builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1461331771.65 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.646772) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.647217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.647505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.664585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.664857) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 06:29:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.4M=0s 2016-04-22 06:29:32 (99.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.316303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.994981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:31.995330) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.044664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.044980) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --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=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 06:29:32,320 truncating revision to first 12 chars 2016-04-22 06:29:32,320 Setting DEBUG logging. 2016-04-22 06:29:32,321 attempt 1/10 2016-04-22 06:29:32,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 06:29:32,690 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.702028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.702394) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.702791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.703061) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 06:29:32.710575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 06:29:32.710844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:29:33 INFO - MultiFileLogger online at 20160422 06:29:33 in /builds/slave/test 06:29:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:29:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:29:33 INFO - {'append_to_log': False, 06:29:33 INFO - 'base_work_dir': '/builds/slave/test', 06:29:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:29:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:29:33 INFO - 'branch': 'Fx-Team-Non-PGO', 06:29:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:29:33 INFO - 'config_files': ('talos/linux_config.py',), 06:29:33 INFO - 'default_actions': ('clobber', 06:29:33 INFO - 'read-buildbot-config', 06:29:33 INFO - 'download-and-extract', 06:29:33 INFO - 'populate-webroot', 06:29:33 INFO - 'create-virtualenv', 06:29:33 INFO - 'install', 06:29:33 INFO - 'run-tests'), 06:29:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:29:33 INFO - 'download_minidump_stackwalk': True, 06:29:33 INFO - 'download_symbols': 'ondemand', 06:29:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:29:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:29:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:29:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:29:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:29:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:29:33 INFO - 'installer_path': 'installer.exe', 06:29:33 INFO - 'log_level': 'info', 06:29:33 INFO - 'log_name': 'talos', 06:29:33 INFO - 'log_to_console': True, 06:29:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:29:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:29:33 INFO - 'opt_config_files': (), 06:29:33 INFO - 'pip_index': False, 06:29:33 INFO - 'sps_profile': False, 06:29:33 INFO - 'sps_profile_interval': 0, 06:29:33 INFO - 'suite': 'dromaeojs-e10s', 06:29:33 INFO - 'system_bits': '32', 06:29:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:29:33 INFO - 'title': 'talos-linux64-ix-024', 06:29:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:29:33 INFO - 'use_talos_json': True, 06:29:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:29:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:29:33 INFO - 'work_dir': 'build'} 06:29:33 INFO - ##### 06:29:33 INFO - ##### Running clobber step. 06:29:33 INFO - ##### 06:29:33 INFO - Running pre-action listener: _resource_record_pre_action 06:29:33 INFO - Running main action method: clobber 06:29:33 INFO - rmtree: /builds/slave/test/build 06:29:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:29:33 INFO - Running post-action listener: _resource_record_post_action 06:29:33 INFO - ##### 06:29:33 INFO - ##### Running read-buildbot-config step. 06:29:33 INFO - ##### 06:29:33 INFO - Running pre-action listener: _resource_record_pre_action 06:29:33 INFO - Running main action method: read_buildbot_config 06:29:33 INFO - Using buildbot properties: 06:29:33 INFO - { 06:29:33 INFO - "project": "", 06:29:33 INFO - "product": "firefox", 06:29:33 INFO - "script_repo_revision": "production", 06:29:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:29:33 INFO - "repository": "", 06:29:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:29:33 INFO - "buildid": "20160419211331", 06:29:33 INFO - "pgo_build": "False", 06:29:33 INFO - "basedir": "/builds/slave/test", 06:29:33 INFO - "buildnumber": 1194, 06:29:33 INFO - "slavename": "talos-linux64-ix-024", 06:29:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:29:33 INFO - "platform": "ubuntu64_hw", 06:29:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:29:33 INFO - "branch": "fx-team", 06:29:33 INFO - "repo_path": "integration/fx-team", 06:29:33 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 06:29:33 INFO - "stage_platform": "linux64", 06:29:33 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 06:29:33 INFO - "slavebuilddir": "test" 06:29:33 INFO - } 06:29:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:29:33 INFO - Running post-action listener: _resource_record_post_action 06:29:33 INFO - ##### 06:29:33 INFO - ##### Running download-and-extract step. 06:29:33 INFO - ##### 06:29:33 INFO - Running pre-action listener: _resource_record_pre_action 06:29:33 INFO - Running main action method: download_and_extract 06:29:33 INFO - mkdir: /builds/slave/test/build/tests 06:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:33 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:34 INFO - Downloaded 1361 bytes. 06:29:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:29:34 INFO - Using the following test package requirements: 06:29:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:29:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:29:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:29:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'jsshell-linux-x86_64.zip'], 06:29:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:29:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:29:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:29:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:29:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:29:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:29:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:29:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:29:34 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:29:34 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:35 INFO - Downloaded 22267191 bytes. 06:29:35 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:29:35 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:29:36 INFO - Return code: 0 06:29:36 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:29: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:29:36 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:37 INFO - Downloaded 22267191 bytes. 06:29:37 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:29:37 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:29:39 INFO - Return code: 0 06:29: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:29:39 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:40 INFO - Downloaded 10845952 bytes. 06:29:40 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:29:40 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:29:40 INFO - Return code: 0 06:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:40 INFO - https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:29:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:29:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:29:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/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:29:41 INFO - Downloaded 54508588 bytes. 06:29:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:29:41 INFO - mkdir: /builds/slave/test/properties 06:29:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:29:41 INFO - Writing to file /builds/slave/test/properties/build_url 06:29:41 INFO - Contents: 06:29:41 INFO - build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:29:42 INFO - Running post-action listener: _resource_record_post_action 06:29:42 INFO - Running post-action listener: set_extra_try_arguments 06:29:42 INFO - ##### 06:29:42 INFO - ##### Running populate-webroot step. 06:29:42 INFO - ##### 06:29:42 INFO - Running pre-action listener: _resource_record_pre_action 06:29:42 INFO - Running main action method: populate_webroot 06:29:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:29:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:29:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:29:42 INFO - '--tppagecycles', 06:29:42 INFO - '7'], 06:29:42 INFO - 'tests': ['tsvgm']}}, 06:29:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:29:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:29:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:29:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:29:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['damp', 'tps']}, 06:29:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'tests': ['damp', 'tps']}, 06:29:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['dromaeo_dom']}, 06:29:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:29:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'other-e10s': {'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['a11yr', 06:29:42 INFO - 'ts_paint', 06:29:42 INFO - 'tpaint', 06:29:42 INFO - 'sessionrestore', 06:29:42 INFO - 'sessionrestore_no_auto_restore', 06:29:42 INFO - 'tabpaint']}, 06:29:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['tsvgx', 06:29:42 INFO - 'tsvgr_opacity', 06:29:42 INFO - 'tart', 06:29:42 INFO - 'tscrollx', 06:29:42 INFO - 'cart']}, 06:29:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:29:42 INFO - 'tsvgr_opacity', 06:29:42 INFO - 'tart', 06:29:42 INFO - 'tscrollx', 06:29:42 INFO - 'cart']}, 06:29:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'talos_options': ['--disable-e10s'], 06:29:42 INFO - 'tests': ['tp5o']}, 06:29:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'tests': ['tp5o']}, 06:29:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'talos_options': ['--disable-e10s', 06:29:42 INFO - '--xperf_path', 06:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:42 INFO - 'tests': ['tp5n']}, 06:29:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:42 INFO - 'talos_options': ['--xperf_path', 06:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:42 INFO - 'tests': ['tp5n']}}, 06:29:42 INFO - 'talos.zip': {'path': '', 06:29:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:29:42 INFO - Running post-action listener: _resource_record_post_action 06:29:42 INFO - ##### 06:29:42 INFO - ##### Running create-virtualenv step. 06:29:42 INFO - ##### 06:29:42 INFO - Running pre-action listener: _resource_record_pre_action 06:29:42 INFO - Running main action method: create_virtualenv 06:29:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:29:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:29:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:29:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:29:42 INFO - Using real prefix '/usr' 06:29:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:29:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:45 INFO - Installing pip.................done. 06:29:45 INFO - Return code: 0 06:29:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:45 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:45 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:29:45 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:29:45 INFO - Using env: {'DISPLAY': ':0', 06:29:45 INFO - 'HOME': '/home/cltbld', 06:29:45 INFO - 'LANG': 'en_US.UTF-8', 06:29:45 INFO - 'LANGUAGE': 'en_US:en', 06:29:45 INFO - 'LOGNAME': 'cltbld', 06:29:45 INFO - 'MAIL': '/var/mail/cltbld', 06:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:45 INFO - 'MOZ_NO_REMOTE': '1', 06:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:45 INFO - 'NO_EM_RESTART': '1', 06:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:45 INFO - 'PWD': '/builds/slave/test', 06:29:45 INFO - 'SHELL': '/bin/bash', 06:29:45 INFO - 'SHLVL': '1', 06:29:45 INFO - 'TERM': 'linux', 06:29:45 INFO - 'TMOUT': '86400', 06:29:45 INFO - 'USER': 'cltbld', 06:29:45 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:45 INFO - '_': '/tools/buildbot/bin/python'} 06:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:45 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:29:45 INFO - Cleaning up... 06:29:45 INFO - Return code: 0 06:29:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:45 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:45 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:29:45 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:29:45 INFO - Using env: {'DISPLAY': ':0', 06:29:45 INFO - 'HOME': '/home/cltbld', 06:29:45 INFO - 'LANG': 'en_US.UTF-8', 06:29:45 INFO - 'LANGUAGE': 'en_US:en', 06:29:45 INFO - 'LOGNAME': 'cltbld', 06:29:45 INFO - 'MAIL': '/var/mail/cltbld', 06:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:45 INFO - 'MOZ_NO_REMOTE': '1', 06:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:45 INFO - 'NO_EM_RESTART': '1', 06:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:45 INFO - 'PWD': '/builds/slave/test', 06:29:45 INFO - 'SHELL': '/bin/bash', 06:29:45 INFO - 'SHLVL': '1', 06:29:45 INFO - 'TERM': 'linux', 06:29:45 INFO - 'TMOUT': '86400', 06:29:45 INFO - 'USER': 'cltbld', 06:29:45 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:45 INFO - '_': '/tools/buildbot/bin/python'} 06:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:45 INFO - Downloading/unpacking psutil>=0.7.1 06:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:47 INFO - Installing collected packages: psutil 06:29:47 INFO - Running setup.py install for psutil 06:29:47 INFO - building 'psutil._psutil_linux' extension 06:29:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:29:48 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:29:48 INFO - building 'psutil._psutil_posix' extension 06:29:48 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:29:48 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:29:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:48 INFO - Successfully installed psutil 06:29:48 INFO - Cleaning up... 06:29:48 INFO - Return code: 0 06:29:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:29: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:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:48 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:29:48 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:29:48 INFO - Using env: {'DISPLAY': ':0', 06:29:48 INFO - 'HOME': '/home/cltbld', 06:29:48 INFO - 'LANG': 'en_US.UTF-8', 06:29:48 INFO - 'LANGUAGE': 'en_US:en', 06:29:48 INFO - 'LOGNAME': 'cltbld', 06:29:48 INFO - 'MAIL': '/var/mail/cltbld', 06:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:48 INFO - 'MOZ_NO_REMOTE': '1', 06:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:48 INFO - 'NO_EM_RESTART': '1', 06:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:48 INFO - 'PWD': '/builds/slave/test', 06:29:48 INFO - 'SHELL': '/bin/bash', 06:29:48 INFO - 'SHLVL': '1', 06:29:48 INFO - 'TERM': 'linux', 06:29:48 INFO - 'TMOUT': '86400', 06:29:48 INFO - 'USER': 'cltbld', 06:29:48 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:48 INFO - '_': '/tools/buildbot/bin/python'} 06:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:50 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:29:50 INFO - Installing collected packages: mozsystemmonitor 06:29:50 INFO - Running setup.py install for mozsystemmonitor 06:29:50 INFO - Successfully installed mozsystemmonitor 06:29:50 INFO - Cleaning up... 06:29:50 INFO - Return code: 0 06:29:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29:50 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:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:50 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:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:50 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:50 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:29:50 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:29:50 INFO - Using env: {'DISPLAY': ':0', 06:29:50 INFO - 'HOME': '/home/cltbld', 06:29:50 INFO - 'LANG': 'en_US.UTF-8', 06:29:50 INFO - 'LANGUAGE': 'en_US:en', 06:29:50 INFO - 'LOGNAME': 'cltbld', 06:29:50 INFO - 'MAIL': '/var/mail/cltbld', 06:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:50 INFO - 'MOZ_NO_REMOTE': '1', 06:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:50 INFO - 'NO_EM_RESTART': '1', 06:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:50 INFO - 'PWD': '/builds/slave/test', 06:29:50 INFO - 'SHELL': '/bin/bash', 06:29:50 INFO - 'SHLVL': '1', 06:29:50 INFO - 'TERM': 'linux', 06:29:50 INFO - 'TMOUT': '86400', 06:29:50 INFO - 'USER': 'cltbld', 06:29:50 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:50 INFO - '_': '/tools/buildbot/bin/python'} 06:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29: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:29: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:29: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:29: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:29: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:29: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:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 INFO - Downloading docopt-0.6.1.tar.gz 06:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:53 INFO - Running setup.py install for blobuploader 06:29:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:53 INFO - Running setup.py install for requests 06:29:53 INFO - Running setup.py install for docopt 06:29:54 INFO - Successfully installed blobuploader requests docopt 06:29:54 INFO - Cleaning up... 06:29:54 INFO - Return code: 0 06:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29: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:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:54 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:54 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:29:54 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:29:54 INFO - Using env: {'DISPLAY': ':0', 06:29:54 INFO - 'HOME': '/home/cltbld', 06:29:54 INFO - 'LANG': 'en_US.UTF-8', 06:29:54 INFO - 'LANGUAGE': 'en_US:en', 06:29:54 INFO - 'LOGNAME': 'cltbld', 06:29:54 INFO - 'MAIL': '/var/mail/cltbld', 06:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:54 INFO - 'MOZ_NO_REMOTE': '1', 06:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:54 INFO - 'NO_EM_RESTART': '1', 06:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:54 INFO - 'PWD': '/builds/slave/test', 06:29:54 INFO - 'SHELL': '/bin/bash', 06:29:54 INFO - 'SHLVL': '1', 06:29:54 INFO - 'TERM': 'linux', 06:29:54 INFO - 'TMOUT': '86400', 06:29:54 INFO - 'USER': 'cltbld', 06:29:54 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:54 INFO - '_': '/tools/buildbot/bin/python'} 06:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:54 INFO - Running setup.py (path:/tmp/pip-LujSBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:54 INFO - Running setup.py (path:/tmp/pip-6rv3fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:54 INFO - Running setup.py (path:/tmp/pip-ai5ZL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:54 INFO - Running setup.py (path:/tmp/pip-uMvgVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:54 INFO - Running setup.py (path:/tmp/pip-yHQWXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:54 INFO - Running setup.py (path:/tmp/pip-FkFnro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:54 INFO - Running setup.py (path:/tmp/pip-Rp7y0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:54 INFO - Running setup.py (path:/tmp/pip-9G3ZHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:54 INFO - Running setup.py (path:/tmp/pip-1_cjqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:54 INFO - Running setup.py (path:/tmp/pip-zxVp0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:55 INFO - Running setup.py (path:/tmp/pip-oKq5fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:55 INFO - Running setup.py (path:/tmp/pip-IO5CGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:55 INFO - Running setup.py (path:/tmp/pip-1InMqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:55 INFO - Running setup.py (path:/tmp/pip-DJNB2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:55 INFO - Running setup.py (path:/tmp/pip-psMHAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:55 INFO - Running setup.py (path:/tmp/pip-6VQqCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:55 INFO - Running setup.py (path:/tmp/pip-GNiJ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:55 INFO - Running setup.py install for manifestparser 06:29:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:55 INFO - Running setup.py install for mozcrash 06:29:55 INFO - Running setup.py install for mozdebug 06:29:55 INFO - Running setup.py install for mozdevice 06:29:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:55 INFO - Running setup.py install for mozfile 06:29:56 INFO - Running setup.py install for mozhttpd 06:29:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for mozinfo 06:29:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for mozInstall 06:29:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for mozleak 06:29:56 INFO - Running setup.py install for mozlog 06:29:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for moznetwork 06:29:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for mozprocess 06:29:56 INFO - Running setup.py install for mozprofile 06:29:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:56 INFO - Running setup.py install for mozrunner 06:29:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:57 INFO - Running setup.py install for mozscreenshot 06:29:57 INFO - Running setup.py install for moztest 06:29:57 INFO - Running setup.py install for mozversion 06:29:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:57 INFO - Cleaning up... 06:29:57 INFO - Return code: 0 06:29:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:57 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:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:57 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:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:57 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:29:57 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:29:57 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:29:57 INFO - Using env: {'DISPLAY': ':0', 06:29:57 INFO - 'HOME': '/home/cltbld', 06:29:57 INFO - 'LANG': 'en_US.UTF-8', 06:29:57 INFO - 'LANGUAGE': 'en_US:en', 06:29:57 INFO - 'LOGNAME': 'cltbld', 06:29:57 INFO - 'MAIL': '/var/mail/cltbld', 06:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:57 INFO - 'MOZ_NO_REMOTE': '1', 06:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:57 INFO - 'NO_EM_RESTART': '1', 06:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:57 INFO - 'PWD': '/builds/slave/test', 06:29:57 INFO - 'SHELL': '/bin/bash', 06:29:57 INFO - 'SHLVL': '1', 06:29:57 INFO - 'TERM': 'linux', 06:29:57 INFO - 'TMOUT': '86400', 06:29:57 INFO - 'USER': 'cltbld', 06:29:57 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:57 INFO - '_': '/tools/buildbot/bin/python'} 06:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:57 INFO - Running setup.py (path:/tmp/pip-dbvpjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:57 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:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:57 INFO - Running setup.py (path:/tmp/pip-WMcy0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:57 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:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:57 INFO - Running setup.py (path:/tmp/pip-87vUEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:57 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:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:57 INFO - Running setup.py (path:/tmp/pip-IGjoaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:57 INFO - Running setup.py (path:/tmp/pip-qLvV86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:58 INFO - Running setup.py (path:/tmp/pip-VxPy48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:58 INFO - Running setup.py (path:/tmp/pip-lGGd9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:58 INFO - Running setup.py (path:/tmp/pip-EMjHp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:58 INFO - Running setup.py (path:/tmp/pip-5Zljen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:58 INFO - Running setup.py (path:/tmp/pip-Ht4i9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:58 INFO - Running setup.py (path:/tmp/pip-rCdjOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:58 INFO - Running setup.py (path:/tmp/pip-mr_Sho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:58 INFO - Running setup.py (path:/tmp/pip-oIHlQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:58 INFO - Running setup.py (path:/tmp/pip-23yTAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:58 INFO - Running setup.py (path:/tmp/pip-lTy9Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:58 INFO - Running setup.py (path:/tmp/pip-wnzOfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:58 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:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:58 INFO - Running setup.py (path:/tmp/pip-QJSwzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:00 INFO - Downloading blessings-1.6.tar.gz 06:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:30:00 INFO - Installing collected packages: blessings 06:30:00 INFO - Running setup.py install for blessings 06:30:00 INFO - Successfully installed blessings 06:30:00 INFO - Cleaning up... 06:30:01 INFO - Return code: 0 06:30:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:30:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:01 INFO - Reading from file tmpfile_stdout 06:30:01 INFO - Current package versions: 06:30:01 INFO - argparse == 1.2.1 06:30:01 INFO - blessings == 1.6 06:30:01 INFO - blobuploader == 1.2.4 06:30:01 INFO - docopt == 0.6.1 06:30:01 INFO - manifestparser == 1.1 06:30:01 INFO - mozInstall == 1.12 06:30:01 INFO - mozcrash == 0.17 06:30:01 INFO - mozdebug == 0.1 06:30:01 INFO - mozdevice == 0.48 06:30:01 INFO - mozfile == 1.2 06:30:01 INFO - mozhttpd == 0.7 06:30:01 INFO - mozinfo == 0.9 06:30:01 INFO - mozleak == 0.1 06:30:01 INFO - mozlog == 3.1 06:30:01 INFO - moznetwork == 0.27 06:30:01 INFO - mozprocess == 0.22 06:30:01 INFO - mozprofile == 0.28 06:30:01 INFO - mozrunner == 6.11 06:30:01 INFO - mozscreenshot == 0.1 06:30:01 INFO - mozsystemmonitor == 0.0 06:30:01 INFO - moztest == 0.7 06:30:01 INFO - mozversion == 1.4 06:30:01 INFO - psutil == 3.1.1 06:30:01 INFO - requests == 1.2.3 06:30:01 INFO - wsgiref == 0.1.2 06:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:01 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:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:01 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:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:01 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:30:01 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:30:01 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:30:01 INFO - Using env: {'DISPLAY': ':0', 06:30:01 INFO - 'HOME': '/home/cltbld', 06:30:01 INFO - 'LANG': 'en_US.UTF-8', 06:30:01 INFO - 'LANGUAGE': 'en_US:en', 06:30:01 INFO - 'LOGNAME': 'cltbld', 06:30:01 INFO - 'MAIL': '/var/mail/cltbld', 06:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:01 INFO - 'MOZ_NO_REMOTE': '1', 06:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:01 INFO - 'NO_EM_RESTART': '1', 06:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:01 INFO - 'PWD': '/builds/slave/test', 06:30:01 INFO - 'SHELL': '/bin/bash', 06:30:01 INFO - 'SHLVL': '1', 06:30:01 INFO - 'TERM': 'linux', 06:30:01 INFO - 'TMOUT': '86400', 06:30:01 INFO - 'USER': 'cltbld', 06:30:01 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:01 INFO - '_': '/tools/buildbot/bin/python'} 06:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 INFO - Cleaning up... 06:30:01 INFO - Return code: 0 06:30:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:30:01 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:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:01 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:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:01 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:30:01 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:30:01 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:30:01 INFO - Using env: {'DISPLAY': ':0', 06:30:01 INFO - 'HOME': '/home/cltbld', 06:30:01 INFO - 'LANG': 'en_US.UTF-8', 06:30:01 INFO - 'LANGUAGE': 'en_US:en', 06:30:01 INFO - 'LOGNAME': 'cltbld', 06:30:01 INFO - 'MAIL': '/var/mail/cltbld', 06:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:01 INFO - 'MOZ_NO_REMOTE': '1', 06:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:01 INFO - 'NO_EM_RESTART': '1', 06:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:01 INFO - 'PWD': '/builds/slave/test', 06:30:01 INFO - 'SHELL': '/bin/bash', 06:30:01 INFO - 'SHLVL': '1', 06:30:01 INFO - 'TERM': 'linux', 06:30:01 INFO - 'TMOUT': '86400', 06:30:01 INFO - 'USER': 'cltbld', 06:30:01 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:01 INFO - '_': '/tools/buildbot/bin/python'} 06:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:01 INFO - Downloading/unpacking jsonschema 06:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:30:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:30:03 INFO - warning: no files found matching '*.txt' 06:30:03 INFO - no previously-included directories found matching 'build' 06:30:03 INFO - no previously-included directories found matching 'dist' 06:30:03 INFO - no previously-included directories found matching '.git*' 06:30:03 INFO - Installing collected packages: jsonschema, functools32 06:30:04 INFO - Running setup.py install for functools32 06:30:04 INFO - warning: no files found matching '*.txt' 06:30:04 INFO - no previously-included directories found matching 'build' 06:30:04 INFO - no previously-included directories found matching 'dist' 06:30:04 INFO - no previously-included directories found matching '.git*' 06:30:04 INFO - Successfully installed jsonschema functools32 06:30:04 INFO - Cleaning up... 06:30:04 INFO - Return code: 0 06:30:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:30:04 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:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:04 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:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:04 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 0x7f352def1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', '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:30:04 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:30:04 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:30:04 INFO - Using env: {'DISPLAY': ':0', 06:30:04 INFO - 'HOME': '/home/cltbld', 06:30:04 INFO - 'LANG': 'en_US.UTF-8', 06:30:04 INFO - 'LANGUAGE': 'en_US:en', 06:30:04 INFO - 'LOGNAME': 'cltbld', 06:30:04 INFO - 'MAIL': '/var/mail/cltbld', 06:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:04 INFO - 'MOZ_NO_REMOTE': '1', 06:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:04 INFO - 'NO_EM_RESTART': '1', 06:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:04 INFO - 'PWD': '/builds/slave/test', 06:30:04 INFO - 'SHELL': '/bin/bash', 06:30:04 INFO - 'SHLVL': '1', 06:30:04 INFO - 'TERM': 'linux', 06:30:04 INFO - 'TMOUT': '86400', 06:30:04 INFO - 'USER': 'cltbld', 06:30:04 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:04 INFO - '_': '/tools/buildbot/bin/python'} 06:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:04 INFO - Downloading/unpacking flake8 06:30:04 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:30:04 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:30:04 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:30:04 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:30:04 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:30:04 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:30:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:30:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:30:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:30:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:30:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:30:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:30:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:30:07 INFO - no previously-included directories found matching 'docs/_build' 06:30:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:30:07 INFO - Running setup.py install for pep8 06:30:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:30:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:30:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:30:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:30:07 INFO - no previously-included directories found matching 'docs/_build' 06:30:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:30:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:30:07 INFO - Cleaning up... 06:30:07 INFO - Return code: 0 06:30:07 INFO - Running post-action listener: _resource_record_post_action 06:30:07 INFO - Running post-action listener: _start_resource_monitoring 06:30:07 INFO - Starting resource monitoring. 06:30:07 INFO - ##### 06:30:07 INFO - ##### Running install step. 06:30:07 INFO - ##### 06:30:07 INFO - Running pre-action listener: _resource_record_pre_action 06:30:07 INFO - Running main action method: install 06:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:07 INFO - Reading from file tmpfile_stdout 06:30:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:30:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:30:07 INFO - Reading from file tmpfile_stdout 06:30:07 INFO - Output received: 06:30:07 INFO - Usage: mozinstall [options] installer 06:30:07 INFO - Options: 06:30:07 INFO - -h, --help show this help message and exit 06:30:07 INFO - -d DEST, --destination=DEST 06:30:07 INFO - Directory to install application into. [default: 06:30:07 INFO - "/builds/slave/test"] 06:30:07 INFO - --app=APP Application being installed. [default: firefox] 06:30:07 INFO - mkdir: /builds/slave/test/build/application 06:30:07 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:30:07 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:30:23 INFO - Reading from file tmpfile_stdout 06:30:23 INFO - Output received: 06:30:23 INFO - /builds/slave/test/build/application/firefox/firefox 06:30:23 INFO - Running post-action listener: _resource_record_post_action 06:30:23 INFO - ##### 06:30:23 INFO - ##### Running run-tests step. 06:30:23 INFO - ##### 06:30:23 INFO - Running pre-action listener: _resource_record_pre_action 06:30:23 INFO - Running main action method: run_tests 06:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:23 INFO - Python 2.7.3 06:30:23 INFO - Return code: 0 06:30:23 INFO - grabbing minidump binary from tooltool 06:30: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:30:23 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 0x2896410>, '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 0x2897310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28977a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:23 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:30:23 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:30:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:23 INFO - Return code: 0 06:30:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:30:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:30:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:30:24 INFO - Return code: 0 06:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:30:24 INFO - Using env: {'DISPLAY': ':0', 06:30:24 INFO - 'HOME': '/home/cltbld', 06:30:24 INFO - 'LANG': 'en_US.UTF-8', 06:30:24 INFO - 'LANGUAGE': 'en_US:en', 06:30:24 INFO - 'LOGNAME': 'cltbld', 06:30:24 INFO - 'MAIL': '/var/mail/cltbld', 06:30:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:24 INFO - 'MOZ_NO_REMOTE': '1', 06:30:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:24 INFO - 'NO_EM_RESTART': '1', 06:30:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:24 INFO - 'PWD': '/builds/slave/test', 06:30:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:24 INFO - 'SHELL': '/bin/bash', 06:30:24 INFO - 'SHLVL': '1', 06:30:24 INFO - 'TERM': 'linux', 06:30:24 INFO - 'TMOUT': '86400', 06:30:24 INFO - 'USER': 'cltbld', 06:30:24 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022', 06:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:24 INFO - '_': '/tools/buildbot/bin/python'} 06:30:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:30:24 INFO - mozversion application_buildid: 20160419211331 06:30:24 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:30:24 INFO - mozversion application_display_name: Nightly 06:30:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:24 INFO - mozversion application_name: Firefox 06:30:24 INFO - mozversion application_remotingname: firefox 06:30:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:30:24 INFO - mozversion application_vendor: Mozilla 06:30:24 INFO - mozversion application_version: 48.0a1 06:30:24 INFO - mozversion platform_buildid: 20160419211331 06:30:24 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 06:30:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:30:24 INFO - mozversion platform_version: 48.0a1 06:30:24 INFO - using testdate: 1461331824 06:30:24 INFO - actual date: 1461331824 06:30:24 INFO - starting webserver on 'localhost:55032' 06:30:24 INFO - SUITE-START | Running 2 tests 06:30:24 INFO - TEST-START | dromaeo_css 06:30:24 INFO - operating with platform_type : linux_ 06:30:24 INFO - Initialising browser for dromaeo_css test... 06:30:24 INFO - TEST-INFO | started process 23723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pqe6j/profile http://localhost:55032/getInfo.html) 06:30:28 INFO - PROCESS | 23723 | 06:30:28 INFO - PROCESS | 23723 | (process:23792): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:30:29 INFO - PROCESS | 23723 | __metrics Screen width/height:1600/1200 06:30:29 INFO - PROCESS | 23723 | colorDepth:24 06:30:29 INFO - PROCESS | 23723 | Browser inner width/height: 1024/697 06:30:29 INFO - PROCESS | 23723 | __metrics 06:30:30 ERROR - PROCESS | 23723 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:30:31 INFO - TEST-INFO | 23723: exit 0 06:30:31 INFO - Browser initialized. 06:30:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:31 INFO - TEST-INFO | started process 23843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5pqe6j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:33 INFO - PROCESS | 23843 | 06:30:33 INFO - PROCESS | 23843 | (process:23902): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:30:43 INFO - PROCESS | 23843 | RSS: Main: 164794368 06:30:43 INFO - PROCESS | 23843 | 06:31:32 INFO - PROCESS | 23843 | 1461331892843 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:33:44 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55032/tests/dromaeo/cssquery-ext.html) 06:33:45 INFO - PROCESS | 23843 | RSS: Main: 166686720 06:33:45 INFO - PROCESS | 23843 | 06:36:47 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-ext.html (next: http://localhost:55032/tests/dromaeo/cssquery-jquery.html) 06:36:48 INFO - PROCESS | 23843 | RSS: Main: 165441536 06:36:48 INFO - PROCESS | 23843 | 06:39:50 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55032/tests/dromaeo/cssquery-mootools.html) 06:39:51 INFO - PROCESS | 23843 | RSS: Main: 166498304 06:39:51 INFO - PROCESS | 23843 | 06:42:52 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55032/tests/dromaeo/cssquery-prototype.html) 06:42:53 INFO - PROCESS | 23843 | RSS: Main: 164139008 06:42:53 INFO - PROCESS | 23843 | 06:45:56 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55032/tests/dromaeo/cssquery-yui.html) 06:45:56 INFO - PROCESS | 23843 | RSS: Main: 165388288 06:45:56 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | Cycle 1(1): loaded http://localhost:55032/tests/dromaeo/cssquery-yui.html (next: http://localhost:55032/tests/dromaeo/cssquery-dojo.html) 06:48:59 INFO - PROCESS | 23843 | RSS: Main: 167383040 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | __start_tp_report 06:48:59 INFO - PROCESS | 23843 | _x_x_mozilla_page_load 06:48:59 INFO - PROCESS | 23843 | _x_x_mozilla_page_load_details 06:48:59 INFO - PROCESS | 23843 | |i|pagename|runs| 06:48:59 INFO - PROCESS | 23843 | |0;dojo.html;2585.0822957849964;2652.522545941731;2679.464107178565;2684.530207213737;2688.0994866719648;4676.228422310319;4689.85930422087;4704;4710.17571924913;4737.478877323491;4534.251848445011;4693.413323334583;4724;4773.737444440563;4783.043391321741;4346.022145017369;4389.539098394671;4397;4438.178936896668;4443.066955939256;4348.608625223729;4354.542773008836;4373.497047839492;4382.255016647162;4398.780060996954;4303.354496825501;4309.008927946574;4344.934825977582;4371.693981421302;4418.889527761799;4326.221280169569;4331.610155086058;4339.717918335298;4349.521552629209;4378.299472084483;4326.048269380732;4330.415393921811;4342.739435633872;4366.3013917773005;4374.234508960919;4439.800208990603;4601.930971035437;4641.234196357597;4656.8602941911795;4687.1328804171335;4951.950480495185;4974.204127339644;4983.875403114915;5015.974920125413;5028.220625803006;4915.5084491550915;5027.79888804451;5033.370828646419;5034.421041580228;5076.517730815566;4717.858464246078;4747.026859493795;4762.166620841408;4799.952000480021;4806.735629540409;5052.545270925634;5115.87210319745;5118.283440318359;5138;5178.508041736029;4718.4809670936165;4871.244957031666;4902.2156454967035;4928.088303663833;4953.6037117030555;4958.975205123951;4975.825846095369;4992.151334273182;5003;5029.446760856303;4772.260299653559;4829.372181616438;4842.806287748451;4848.951510484921;4851.781669824866;4820.662553621213;4848.17581011229;4849.078675051729;4858.028394321079;4862.17343051682;4155.8337666493;4191.601797829201;4234.978825105916;4237.978810105929;4279.037216626297;3664.029032306441;3701.685356744653;3730.720195985312;3761.4357846322723;3769.8869033929027;4320.827166913351;4352.455943007124;4356.564343565618;4357.411749413788;4403.207422663952;5043.87390315245;5050.949490505048;5053.646244762905;5068.923966140511;5079.5428411443145;4221.261279276115;4232.661387089025;4354;4355.324924636687;4391.209582275157;4582.243929751554;4587.799358384548;4594.471635761864;4600.930986035212;4640.141573808856;4791.401074865642;4807.879803004883;4818.229083346648;4832.178529649968;4849.248366503198;4876.24418215163;4982.377202849644;5041.798328066983;5091.083604950996;5105.744712764273;4704.1062198182235;4729.787159577896;4743.335932969318;4762.142814293322;4780.593649539828;4918.926216106833;4922.901541969069;4925.113479573711;4931.580815630711;4972.65191436596;4883.6093112551625;4935.062338155739;5006.724630145377;5012.448630650552;5068.543831055223;4892.046051020017;4897.975510122426;4909.4354149273295;4920.926186107283;4960.057589058068;4882.7314497701545;4886.242632391985;4909.828156014522;4910.165271903714;4962.429320628174;4625.190591646381;4655.743934083658;4678.8596342109795;4741.596964257938;4795.520447955177;4944.986277813112;4952;4953.009398120318;4963.726995015309;4992.6255530834605;4855.393075865517;4856.902861942812;4857.659963802641;4857.758448709304;4902.828401005948 06:48:59 INFO - PROCESS | 23843 | |1;ext.html;589.9439553242444;616.4267231474729;630.9085182648514;639.3414782773742;643.0097649619586;34226;35252;35258.471122933144;35354.8232258839;35444.468332975;38333.23333533328;38924.610753892455;38930.61069389305;38938.22123557527;38988.41517377242;7824.804379890491;7948.602569871512;8019.558924259163;8022.19778022199;8043.075046369655;7789.10425301092;7893.763187104396;7906.169852165497;7924.603769811515;7926.762197134095;7913.564753938531;7926.048874135112;7930.524168549877;7982;7985.520868747864;7845.68617255312;7943.046834379854;7947.523148611073;7947.761567152937;7949.046114466301;7879.724209652634;7982.800429989239;7989.081255655616;7991.041075071029;7992.560409177493;37275.44086838672;37969;37992;38006.42990355147;38067.619323806684;2501.5997440409446;2943.5290353543332;2946.79372443929;3127.9530807037913;3181.729552987999;24324.87837560801;24361.26916192517;24697.506049878903;25368.492630147477;25399.492010159876;3181.602299712536;3242.0922141800334;3249.23642943908;3339.9833000835083;3391.8982430527126;154612;155091;155764.22117889338;157026;157110.21444892703;32383.35233295368;32556.837215813768;32563.348733025206;32616.836915815267;33449.163770905434;33083;33253.50119748206;33799;33806.32387352239;33907.321853563284;12411.813822792485;12767.042471814651;12800.871991280153;12807.359632018362;12839.614811555668;9268.860967085498;9326.06739326062;9331.300152488591;9343.813123737487;9358.485283309483;8174;8200.58997050157;8209.343252539782;8271.2142346477;8306.667733290722;3190.441672707267;3202.343519578481;3218.3885061838646;3245.789023713451;3273.3616944695555;903.3992395057345;930.1024511346583;942.4580866002076;983.7491439682979;1008.3546530220665;27206;28744.413002829846;28828.279293017844;28942.276443089093;29193;994.7413672445216;1005.3515482513737;1005.8340373838381;1039.6257347354947;1147.942602869853;14529.200893950934;15274.312655930287;15422.151781651892;15589.220538973006;15640.2179891005;335155;341949;342293;342789;344209;49203.753981230584;49893.25160122601;50073.49926500761;50100.49899501031;50197;1170.5434880396651;1221.7922953097816;1261.7918043522716;1265.9683507912375;1277.5464710027993;25534.872325638255;27614.5857812137;27908.86045569759;27910.581341280304;28096;42465;42849;43373;43427.78286108549;43550.782246088565;304463;306677;306981;307053;307527;25626.23121306364;25757.871210643825;25846.483070338865;25891.482170356863;25991.870040649676;42431.7878410606;42447.57552424436;42611;43208.35187472253;43230.56769432266;35892.64107358893;36179;36396;36813.81593092017;36828;35769.28461430809;36272.45591316185;36313.27373452569;36477.45283820692;37080;35314.293714126085;35863.64136358603;36035.459468107474;39352.655024323256;39605.2078958425;29979;31463.37073258476;31521.369572608877;31559;31672.366552668358;24651.260462186165;24688.753112468647;24840;25046.74953250444;25198.11806586834 06:48:59 INFO - PROCESS | 23843 | |2;jquery.html;377.22103855538313;385.39877790646574;392.07470369926966;393.49632470437837;398.8703671306826;15212.695746085086;16379.628061717445;16453;16476.917615411905;16540.503784886456;15529;15534.53396398107;16230.918845405757;16308.83691163088;16323.183840807942;5131.794728210867;5286.841394758163;5328.254044433763;5331.2003199519995;5332.600054995872;3656.3966945453967;5714.71426428679;6039.758409663608;6044.66754328514;6050.092486127094;4997.950020499803;5878.588498805086;5921.082232254007;5926.851828704295;5941.584089113764;5262.500062494057;5267.604929630274;5285.762140703678;5310.8406747797435;5324.813631522898;4971.975140124312;5399.244105825148;5412.350517937873;5447.319085114361;5449.264349312832;19256.326028589072;19333.130009149623;19686.70469942952;19970.600587988305;20187.79812201874;1827.3878250786004;1945.108463850346;1951.3853136262173;2002.2591641092888;2105.631514484974;8842.5136617486;9242.260619150451;9574.808503829885;9630.422174669542;9690.51547422626;1706;1748.9650206995789;1794.667986422503;1813.7732783402075;1850.8519318454491;65951.67024164897;67004.3299567003;67044;69167.65416172937;69315.65342173308;9804.509774511245;9942.652007179713;9949.751256218653;9962.203023758228;10073.194144468425;13869.514566990107;13881.305934703225;13940.37268322928;13969.092009019381;14013.719725605431;6927.861442771217;6928.618925959121;6962.1297337832775;7052.153741550944;7053.470989675795;6445.291017988017;6464.676766161673;6565.212174539086;6565.704543295563;6572.342765723485;4074.8573799916862;4194.475690538683;4307.535437951049;4343.82624695015;4369.43197384338;1662.883598148118;1730.204106111203;1810.8913465191868;1820.1172431370774;1834.9445486524046;859.3941271403645;899.9550022498848;925.5418567808978;929.9814003719888;1041.2242879055152;16106.919465402598;16145.919270403572;16323.102229377499;16413.42553010639;16503.422380216874;859.9742007739778;877.8858748362672;890.4034297021011;895.8253140637513;918.2516249256835;8882.86675699865;8904.59929303183;9050.140236677506;9214.815703685888;9244.075592440837;387805;395745;400382;402739;403798;74172;76317;76691;77067.22932770713;77504.61247693725;928.2991341537096;936.8266870628955;956.7368973532195;960.1694534227983;967.1344146988406;14836.480723174636;14869.47956821506;14936.551903442914;15001.324940377928;15094.773578396553;33498.33003339968;34009.31981360408;34246.14384640404;34382.484262735576;35318.82340588281;47096.29355559601;48872.75563622159;49354;49707.502924970286;49722.75138624284;5506.504414602705;7753.573553454614;7806.88289675644;7858.44990850635;8093.919060809317;6290.2766181889665;8083.312918401766;9942.900570994487;11859.762804743685;11902.226355286879;9284.58219380143;9290.210332121846;9302.720918372459;9415.529223538659;9714.611415543299;8904.688335908211;9811.607535698493;10062.345947513388;10174.236932229964;10433.113185379329;10013.998600139928;10062.295639305179;10100.747481313027;10255.897441025792;10326.638567650096;7388.4828062037295;7543.585102819397;7635.656395462106;7678.577678227751;7813.726519572015;9952.35309704896;9997.200223982209;10005.199584033115;10087.848682269918;10155.136813370946 06:48:59 INFO - PROCESS | 23843 | |3;mootools.html;1396.9161850288983;1453.5784622459487;1550.232634845751;1689.704301747194;1741.1555395633115;7022.789316320505;7619.961900190498;7678.462507624468;7890;7916.287534121935;7662.1571627120975;7677.078750549942;7723.189065148163;7725.575093369863;7740.612969351538;2221.2780846225;2237.3511681612313;2240.0815665577115;2243.4391402149463;2246.921357752479;2156.3099808061424;2167.566486702658;2191.2878314547834;2192.2217612747486;2197.549502352022;2223;2223.8109760670363;2237.776222377757;2252.538229662915;2254.4701995031155;2188.2888061380113;2189.562087582474;2196.516766311409;2196.7803219677985;2215.1471683401846;2136.8504204705678;2151.7202763640785;2152.1068756466047;2158.902849371782;2161.729783777028;7788.805279868048;7802.29779319864;7858.607069646495;7881.605919703992;7957.283844453969;4518.028623845889;4709.058188362307;4712.434507859045;4727.385439892826;4738.881527961794;2870.942581148386;2872.5691146328218;2955.1725516855313;2978.5681076243823;2994.191568276575;852.6205838401913;882.2544949517711;888.6623083228332;895.5566994337779;899.2850683706469;10471.947640261826;10518.947405262925;10531.420771857622;10560.577576896914;10603.575856965712;4173.728707633994;4293.441852559147;4295.398644189816;4361.171377438277;4428.933565996513;9011.234045106108;9034.774130646787;9049.683261085831;9050.366474346733;9068.274538036942;4748.3114948332295;4756.357891684647;4762.499937506581;4791.161546729309;4801.735904525215;3861.4400911867624;4321.373400856858;4345.500267469281;4421.911561768747;4422.800973956179;3626.1659818241424;3728.12389088564;3740.401535754266;3843.423486476995;3857.614238576176;1252.292454763056;1274.1781550899618;1284.210210720419;1293.502001729341;1294.4886769725906;718.1669263654136;802.253903869407;897.5960817631961;910.8724778531011;914.8490499067713;5455.918161227585;5502.174673798962;5599.048161812501;5601.29983752031;5683.857903552444;358.867219128924;370.8942951258932;372.5231703419573;378.17369048628836;383.87332180380406;3711.1464363196615;3810.48558444612;3959.920801583952;4014.458048163519;4167.541570427251;9206.217471514996;9451.196648284835;9518.476483793458;9535.666251681158;9540.856887146698;9290.16388525036;9420.43477391345;9451.29115316354;9467.952660236655;9468.19520340765;6950.860982780316;7204.207537170907;7204.747833825791;7225.710971561079;7326.7069317226715;5369.5167434931045;5616.494515493625;5675.517581005495;5699.572532060195;5848.883022339444;8738.475691458532;8925.330600205141;8984.640614375352;9116.179543841086;9168.083191680778;8856.64573417056;9105.681301154427;9118.99691033999;9119.726408207764;9223.815523689624;6475.870482590416;7167.462440317101;7337.3763230123905;7425.777226683208;7534.095908491016;7566.092068951761;7694.769156925301;7706.845863082594;7724.845503089794;7763.4953728007495;6852.486063545353;6996.860062798817;7058.329458701415;7122;7132.679029443584;6838.38454539074;6903.723851045902;6961.060256865258;6968.442524597918;7016.36852683261;6266.060090986389;6296.150019747275;6410.775622853178;6443.871122577429;6499.935000650122;4866.124097662313;4941.555260026615;4974.626902982219;4992.675476094042;5125.974370128126;4974.154393753143;5032.3206367139965;5155.948440515697;5157.922631160461;5195.142801437721 06:48:59 INFO - PROCESS | 23843 | |4;prototype.html;310.1440025529538;317.5015226095031;318.7768562006596;321.927566297583;327.6821483161333;4939.209726443761;5092.312537807395;5291.735413229338;5300.89398212036;5355;5242.397124330693;5262.158054711237;5266.605004624649;5268.209768534722;5302.3106996090555;4167.562405947378;4185.665146788249;4189.790510474464;4190.057237121654;4204.600562946515;4177.101923086536;4187.099773548686;4187.706860519765;4191.057012172252;4192.454980852485;3835.961640383602;4035.3341698619693;4046.3728122141115;4051.0480037191237;4053.5541090480024;4046.2312160689376;4056.3307054336146;4067.837286508536;4069.5726948670554;4071.5114186297537;3557.484164796116;3567.3935430976794;3573.4818451324413;3575.803330816804;3592.7305452091196;4940.689737875632;5037.19404895215;5048.924266136011;5061.949380506185;5078.085944529983;4595.724256544618;4630.467496237942;4636.4899861015265;4640.211164102111;4656.206276234267;5478.150886612581;5483.75323110461;5490.396056433789;5495.148252020943;5507.807226747084;3771.5662698789715;3844.615538446161;3871.2838124946693;3874.2638898609175;3877.476540667002;5435.402105768362;5636.464535869127;5739.885202295973;5800.506956908668;5818.679972601505;3939.3893946438347;3950.6839452843706;3953.367461206193;3963.960360396417;3969.503812023497;4013.538443079083;4017.216642754693;4019.6132334344607;4020.0753826619457;4034.031832360271;4503.874031492127;4602.194615942197;4605.286180642006;4608.976955115203;4611.077784443058;5448.809291674852;5504.559635229172;5510.586705996986;5520.392756796749;5534.169874518854;1370.8286464191976;1390.5828251524501;1392.6978275312413;1396.6368744126396;1398.8461269260374;904.8099899021148;936.0826390137703;942.6229508196776;943.8206740719241;950.7623094226443;4804.95195048045;4811.27830825379;4812.446568644651;4826.396700412449;4829;5544.1960915667805;5641.943580564224;5643.492085712305;5659.5755318351285;5665.405132461032;4638.6752927294765;4781.378420805273;4781.856544303607;4785.210440277316;4793.616510679138;3010.6086208793154;3027.4399236140944;3035;3036.193464888388;3043.6651968283472;5286.444923283077;5313.415524292324;5319.494648008433;5343.385510666323;5347.3048503695045;5569;5764.5676574257095;5791.594588378773;5817.7091145442555;5820.883582328414;5327.094393953037;5335.253064571041;5340.465953404629;5352.5450336721815;5373.731313434313;5561.63849349791;5655.066913959316;5660.971695141498;5677.120046392815;5695.351661477433;5518.475744804237;5527.143292789624;5532.391436942014;5550.666959982414;5585.469380408855;5118.364042518032;5245.423003469539;5345.438728933406;5426.8371948841595;5431.293931788842;3939.2121575684405;3954.149857780591;3961.1879564688593;3968.722189446711;3971.960280397159;5703.515201207943;5710;5714;5716.199732037601;5725.341585717696;5384.21928820311;5538.750756215899;5553.029129415743;5557.305336832896;5565.276514053147;5477.123660214346;5511.641743286674;5519.681733671948;5544.75048622821;5545.334559852843;5337.57299416038;5405.783768649368;5428.511433970962;5462.235287059735;5463.453654634504;5570.749316280696;5578.748956297058;5593.07714227148;5596.440355964371;5606.523445507178;5446.210299506629;5462.3445186577865;5463.399026107046;5483.862903427446;5486.6982315973 06:48:59 INFO - PROCESS | 23843 | |5;yui.html;590.7371219807185;615.6152404747033;631.6778442994072;644.1239913717346;650.102858055883;11647.592334268302;11814.704632384195;11838.526458941642;11851.822222666668;13226.603201903934;13919.512817051405;14028.999999999975;14046.157230566174;14063.648408789786;14070.929645351758;642.9742810287582;780.3679019993823;782.964766585505;784.356827401531;784.8665726826454;794.5074054086474;809.6761295481825;812.0215140755375;812.7642983534768;816.0126247240846;842.1914961636836;845.5265051571109;846.9915300846974;847.8134810341714;850.0139837788167;828.9461185022955;832.2509741232878;837.0792128658488;838.4633834346023;846.2426128614886;595.0152497616451;595.9523238140938;618.4526693875907;623.1151764494429;625.0686477149061;12639.1784534005;12669.493220271179;12705.682357941034;12706.936465317614;12725.045621578327;10806.081483073947;10818.513166907429;11184.273022253528;11491.94254028733;12110.39448027604;9170.358074934757;9173.082691730773;9261.72214833556;9342.346035777498;9433.198178154866;3069.1406406206297;3157.100226435478;3189.5694081299193;3190.6875053036665;3304.7521435892163;46516.302255466195;46929.765351173024;47071.764641176575;47503.287450688265;47728.522714773106;9651.662191823392;9734.610615575439;9764;9809.607615695435;9872.802543949225;17026.659466810594;17064.829351706325;17091.230894609773;17104;17219.052952087757;5703.08750599902;5729.684867332254;5851.707414629337;5906.793262235801;5973.074173503114;3277.852496637657;3379.5775528058994;3453.430184019659;3473.3574288756663;3477.3045390921916;2639.1686618715044;2741.342077901329;2743.82165159268;2745.2862255813634;2927.2828157101644;524.2058281703223;528.9047971365192;529.0714795533813;534.7834127178498;537.2961420539107;501.3532543019464;569.9971500142556;584.8040906296438;588.0180099234288;592.9741547123415;7258.709651613982;7452.292032256927;7543.0948286206;7748.651310691032;7796.649150788228;475.25385145321513;500.7521276967924;544.9809256675998;579.4147910610229;590.4921767280135;3394.4568868980846;3431.9313613727586;3507.94738078929;3616.349057169735;3659.121810765397;54896.725516372164;55460.72269638626;55875;56285.718571406884;56495;46589.30116048262;47089.764551177024;47242.52757472381;48007.75996119997;48336.274955874986;43174;43230.35154472685;43574.56425435705;43863.56136438595;43943;6859;6992.930070699432;7013.473989450914;7074.257202993612;7144.142702875688;27603.585946211224;27699.446011079264;28203;28262.57606135951;28390.019047999664;36000;38878.41682374823;38990.4151437723;39201.215975679756;40033.599664004156;9036.774080648036;9108.681196158102;9216.723498295061;9252.352335336462;9287.210587099902;10273.280870339304;10362.585496580052;10378.221633377376;10530.157587393143;10756.83864742045;9254.4910029949;9427.3400861939;9521;9655.951720241354;9801.411915285105;8393.496390216607;8668.0898505656;8755.080716524928;8793.824123517621;8841.469511829311;8936.776580585538;9007.234385077341;9087.409318394282;9185.219256363016;9195.862062069207;8145.18419597093;8522.78693032679;8611.655533778829;8763.956180219058;8794.692185773467;7959.442839001214;7994.40041996841;8056.476329038594;8108.2297181767635;8239.670413183405 06:48:59 INFO - PROCESS | 23843 | __end_tp_report 06:48:59 INFO - PROCESS | 23843 | __start_cc_report 06:48:59 INFO - PROCESS | 23843 | _x_x_mozilla_cycle_collect,377 06:48:59 INFO - PROCESS | 23843 | __end_cc_report 06:48:59 INFO - PROCESS | 23843 | __startTimestamp1461332939274__endTimestamp 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | ------- Summary: start ------- 06:48:59 INFO - PROCESS | 23843 | Number of tests: 6 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#0] dojo.html Cycles:165 Average:4637.92 Median:4780.59 stddev:469.58 (9.8%) stddev-sans-first:442.55 06:48:59 INFO - PROCESS | 23843 | Values: 2585.1 2652.5 2679.5 2684.5 2688.1 4676.2 4689.9 4704.0 4710.2 4737.5 4534.3 4693.4 4724.0 4773.7 4783.0 4346.0 4389.5 4397.0 4438.2 4443.1 4348.6 4354.5 4373.5 4382.3 4398.8 4303.4 4309.0 4344.9 4371.7 4418.9 4326.2 4331.6 4339.7 4349.5 4378.3 4326.0 4330.4 4342.7 4366.3 4374.2 4439.8 4601.9 4641.2 4656.9 4687.1 4952.0 4974.2 4983.9 5016.0 5028.2 4915.5 5027.8 5033.4 5034.4 5076.5 4717.9 4747.0 4762.2 4800.0 4806.7 5052.5 5115.9 5118.3 5138.0 5178.5 4718.5 4871.2 4902.2 4928.1 4953.6 4959.0 4975.8 4992.2 5003.0 5029.4 4772.3 4829.4 4842.8 4849.0 4851.8 4820.7 4848.2 4849.1 4858.0 4862.2 4155.8 4191.6 4235.0 4238.0 4279.0 3664.0 3701.7 3730.7 3761.4 3769.9 4320.8 4352.5 4356.6 4357.4 4403.2 5043.9 5050.9 5053.6 5068.9 5079.5 4221.3 4232.7 4354.0 4355.3 4391.2 4582.2 4587.8 4594.5 4600.9 4640.1 4791.4 4807.9 4818.2 4832.2 4849.2 4876.2 4982.4 5041.8 5091.1 5105.7 4704.1 4729.8 4743.3 4762.1 4780.6 4918.9 4922.9 4925.1 4931.6 4972.7 4883.6 4935.1 5006.7 5012.4 5068.5 4892.0 4898.0 4909.4 4920.9 4960.1 4882.7 4886.2 4909.8 4910.2 4962.4 4625.2 4655.7 4678.9 4741.6 4795.5 4945.0 4952.0 4953.0 4963.7 4992.6 4855.4 4856.9 4857.7 4857.8 4902.8 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#1] ext.html Cycles:180 Average:41361.62 Median:189730.50 stddev:73824.96 (38.9%) stddev-sans-first:73968.59 06:48:59 INFO - PROCESS | 23843 | Values: 589.9 616.4 630.9 639.3 643.0 34226.0 35252.0 35258.5 35354.8 35444.5 38333.2 38924.6 38930.6 38938.2 38988.4 7824.8 7948.6 8019.6 8022.2 8043.1 7789.1 7893.8 7906.2 7924.6 7926.8 7913.6 7926.0 7930.5 7982.0 7985.5 7845.7 7943.0 7947.5 7947.8 7949.0 7879.7 7982.8 7989.1 7991.0 7992.6 37275.4 37969.0 37992.0 38006.4 38067.6 2501.6 2943.5 2946.8 3128.0 3181.7 24324.9 24361.3 24697.5 25368.5 25399.5 3181.6 3242.1 3249.2 3340.0 3391.9 154612.0 155091.0 155764.2 157026.0 157110.2 32383.4 32556.8 32563.3 32616.8 33449.2 33083.0 33253.5 33799.0 33806.3 33907.3 12411.8 12767.0 12800.9 12807.4 12839.6 9268.9 9326.1 9331.3 9343.8 9358.5 8174.0 8200.6 8209.3 8271.2 8306.7 3190.4 3202.3 3218.4 3245.8 3273.4 903.4 930.1 942.5 983.7 1008.4 27206.0 28744.4 28828.3 28942.3 29193.0 994.7 1005.4 1005.8 1039.6 1147.9 14529.2 15274.3 15422.2 15589.2 15640.2 335155.0 341949.0 342293.0 342789.0 344209.0 49203.8 49893.3 50073.5 50100.5 50197.0 1170.5 1221.8 1261.8 1266.0 1277.5 25534.9 27614.6 27908.9 27910.6 28096.0 42465.0 42849.0 43373.0 43427.8 43550.8 304463.0 306677.0 306981.0 307053.0 307527.0 25626.2 25757.9 25846.5 25891.5 25991.9 42431.8 42447.6 42611.0 43208.4 43230.6 35892.6 36179.0 36396.0 36813.8 36828.0 35769.3 36272.5 36313.3 36477.5 37080.0 35314.3 35863.6 36035.5 39352.7 39605.2 29979.0 31463.4 31521.4 31559.0 31672.4 24651.3 24688.8 24840.0 25046.7 25198.1 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#2] jquery.html Cycles:180 Average:24126.12 Median:5276.68 stddev:65646.36 (1244.1%) stddev-sans-first:65806.30 06:48:59 INFO - PROCESS | 23843 | Values: 377.2 385.4 392.1 393.5 398.9 15212.7 16379.6 16453.0 16476.9 16540.5 15529.0 15534.5 16230.9 16308.8 16323.2 5131.8 5286.8 5328.3 5331.2 5332.6 3656.4 5714.7 6039.8 6044.7 6050.1 4998.0 5878.6 5921.1 5926.9 5941.6 5262.5 5267.6 5285.8 5310.8 5324.8 4972.0 5399.2 5412.4 5447.3 5449.3 19256.3 19333.1 19686.7 19970.6 20187.8 1827.4 1945.1 1951.4 2002.3 2105.6 8842.5 9242.3 9574.8 9630.4 9690.5 1706.0 1749.0 1794.7 1813.8 1850.9 65951.7 67004.3 67044.0 69167.7 69315.7 9804.5 9942.7 9949.8 9962.2 10073.2 13869.5 13881.3 13940.4 13969.1 14013.7 6927.9 6928.6 6962.1 7052.2 7053.5 6445.3 6464.7 6565.2 6565.7 6572.3 4074.9 4194.5 4307.5 4343.8 4369.4 1662.9 1730.2 1810.9 1820.1 1834.9 859.4 900.0 925.5 930.0 1041.2 16106.9 16145.9 16323.1 16413.4 16503.4 860.0 877.9 890.4 895.8 918.3 8882.9 8904.6 9050.1 9214.8 9244.1 387805.0 395745.0 400382.0 402739.0 403798.0 74172.0 76317.0 76691.0 77067.2 77504.6 928.3 936.8 956.7 960.2 967.1 14836.5 14869.5 14936.6 15001.3 15094.8 33498.3 34009.3 34246.1 34382.5 35318.8 47096.3 48872.8 49354.0 49707.5 49722.8 5506.5 7753.6 7806.9 7858.4 8093.9 6290.3 8083.3 9942.9 11859.8 11902.2 9284.6 9290.2 9302.7 9415.5 9714.6 8904.7 9811.6 10062.3 10174.2 10433.1 10014.0 10062.3 10100.7 10255.9 10326.6 7388.5 7543.6 7635.7 7678.6 7813.7 9952.4 9997.2 10005.2 10087.8 10155.1 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#3] mootools.html Cycles:180 Average:5223.39 Median:5412.72 stddev:2874.72 (53.1%) stddev-sans-first:2868.40 06:48:59 INFO - PROCESS | 23843 | Values: 1396.9 1453.6 1550.2 1689.7 1741.2 7022.8 7620.0 7678.5 7890.0 7916.3 7662.2 7677.1 7723.2 7725.6 7740.6 2221.3 2237.4 2240.1 2243.4 2246.9 2156.3 2167.6 2191.3 2192.2 2197.5 2223.0 2223.8 2237.8 2252.5 2254.5 2188.3 2189.6 2196.5 2196.8 2215.1 2136.9 2151.7 2152.1 2158.9 2161.7 7788.8 7802.3 7858.6 7881.6 7957.3 4518.0 4709.1 4712.4 4727.4 4738.9 2870.9 2872.6 2955.2 2978.6 2994.2 852.6 882.3 888.7 895.6 899.3 10471.9 10518.9 10531.4 10560.6 10603.6 4173.7 4293.4 4295.4 4361.2 4428.9 9011.2 9034.8 9049.7 9050.4 9068.3 4748.3 4756.4 4762.5 4791.2 4801.7 3861.4 4321.4 4345.5 4421.9 4422.8 3626.2 3728.1 3740.4 3843.4 3857.6 1252.3 1274.2 1284.2 1293.5 1294.5 718.2 802.3 897.6 910.9 914.8 5455.9 5502.2 5599.0 5601.3 5683.9 358.9 370.9 372.5 378.2 383.9 3711.1 3810.5 3959.9 4014.5 4167.5 9206.2 9451.2 9518.5 9535.7 9540.9 9290.2 9420.4 9451.3 9468.0 9468.2 6950.9 7204.2 7204.7 7225.7 7326.7 5369.5 5616.5 5675.5 5699.6 5848.9 8738.5 8925.3 8984.6 9116.2 9168.1 8856.6 9105.7 9119.0 9119.7 9223.8 6475.9 7167.5 7337.4 7425.8 7534.1 7566.1 7694.8 7706.8 7724.8 7763.5 6852.5 6996.9 7058.3 7122.0 7132.7 6838.4 6903.7 6961.1 6968.4 7016.4 6266.1 6296.2 6410.8 6443.9 6499.9 4866.1 4941.6 4974.6 4992.7 5126.0 4974.2 5032.3 5155.9 5157.9 5195.1 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#4] prototype.html Cycles:180 Average:4561.97 Median:5264.38 stddev:1331.74 (25.3%) stddev-sans-first:1296.68 06:48:59 INFO - PROCESS | 23843 | Values: 310.1 317.5 318.8 321.9 327.7 4939.2 5092.3 5291.7 5300.9 5355.0 5242.4 5262.2 5266.6 5268.2 5302.3 4167.6 4185.7 4189.8 4190.1 4204.6 4177.1 4187.1 4187.7 4191.1 4192.5 3836.0 4035.3 4046.4 4051.0 4053.6 4046.2 4056.3 4067.8 4069.6 4071.5 3557.5 3567.4 3573.5 3575.8 3592.7 4940.7 5037.2 5048.9 5061.9 5078.1 4595.7 4630.5 4636.5 4640.2 4656.2 5478.2 5483.8 5490.4 5495.1 5507.8 3771.6 3844.6 3871.3 3874.3 3877.5 5435.4 5636.5 5739.9 5800.5 5818.7 3939.4 3950.7 3953.4 3964.0 3969.5 4013.5 4017.2 4019.6 4020.1 4034.0 4503.9 4602.2 4605.3 4609.0 4611.1 5448.8 5504.6 5510.6 5520.4 5534.2 1370.8 1390.6 1392.7 1396.6 1398.8 904.8 936.1 942.6 943.8 950.8 4805.0 4811.3 4812.4 4826.4 4829.0 5544.2 5641.9 5643.5 5659.6 5665.4 4638.7 4781.4 4781.9 4785.2 4793.6 3010.6 3027.4 3035.0 3036.2 3043.7 5286.4 5313.4 5319.5 5343.4 5347.3 5569.0 5764.6 5791.6 5817.7 5820.9 5327.1 5335.3 5340.5 5352.5 5373.7 5561.6 5655.1 5661.0 5677.1 5695.4 5518.5 5527.1 5532.4 5550.7 5585.5 5118.4 5245.4 5345.4 5426.8 5431.3 3939.2 3954.1 3961.2 3968.7 3972.0 5703.5 5710.0 5714.0 5716.2 5725.3 5384.2 5538.8 5553.0 5557.3 5565.3 5477.1 5511.6 5519.7 5544.8 5545.3 5337.6 5405.8 5428.5 5462.2 5463.5 5570.7 5578.7 5593.1 5596.4 5606.5 5446.2 5462.3 5463.4 5483.9 5486.7 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - PROCESS | 23843 | [#5] yui.html Cycles:180 Average:12495.11 Median:5716.39 stddev:14966.47 (261.8%) stddev-sans-first:14981.76 06:48:59 INFO - PROCESS | 23843 | Values: 590.7 615.6 631.7 644.1 650.1 11647.6 11814.7 11838.5 11851.8 13226.6 13919.5 14029.0 14046.2 14063.6 14070.9 643.0 780.4 783.0 784.4 784.9 794.5 809.7 812.0 812.8 816.0 842.2 845.5 847.0 847.8 850.0 828.9 832.3 837.1 838.5 846.2 595.0 596.0 618.5 623.1 625.1 12639.2 12669.5 12705.7 12706.9 12725.0 10806.1 10818.5 11184.3 11491.9 12110.4 9170.4 9173.1 9261.7 9342.3 9433.2 3069.1 3157.1 3189.6 3190.7 3304.8 46516.3 46929.8 47071.8 47503.3 47728.5 9651.7 9734.6 9764.0 9809.6 9872.8 17026.7 17064.8 17091.2 17104.0 17219.1 5703.1 5729.7 5851.7 5906.8 5973.1 3277.9 3379.6 3453.4 3473.4 3477.3 2639.2 2741.3 2743.8 2745.3 2927.3 524.2 528.9 529.1 534.8 537.3 501.4 570.0 584.8 588.0 593.0 7258.7 7452.3 7543.1 7748.7 7796.6 475.3 500.8 545.0 579.4 590.5 3394.5 3431.9 3507.9 3616.3 3659.1 54896.7 55460.7 55875.0 56285.7 56495.0 46589.3 47089.8 47242.5 48007.8 48336.3 43174.0 43230.4 43574.6 43863.6 43943.0 6859.0 6992.9 7013.5 7074.3 7144.1 27603.6 27699.4 28203.0 28262.6 28390.0 36000.0 38878.4 38990.4 39201.2 40033.6 9036.8 9108.7 9216.7 9252.4 9287.2 10273.3 10362.6 10378.2 10530.2 10756.8 9254.5 9427.3 9521.0 9656.0 9801.4 8393.5 8668.1 8755.1 8793.8 8841.5 8936.8 9007.2 9087.4 9185.2 9195.9 8145.2 8522.8 8611.7 8764.0 8794.7 7959.4 7994.4 8056.5 8108.2 8239.7 06:48:59 INFO - PROCESS | 23843 | -------- Summary: end -------- 06:48:59 INFO - PROCESS | 23843 | 06:48:59 INFO - TEST-INFO | 23843: exit 0 06:48:59 INFO - TEST-OK | dromaeo_css | took 1115299ms 06:48:59 INFO - TEST-START | kraken 06:48:59 INFO - operating with platform_type : linux_ 06:48:59 INFO - Initialising browser for kraken test... 06:48:59 INFO - TEST-INFO | started process 24078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptVHDmI/profile http://localhost:55032/getInfo.html) 06:49:03 INFO - PROCESS | 24078 | 06:49:03 INFO - PROCESS | 24078 | (process:24146): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:49:04 INFO - PROCESS | 24078 | __metrics Screen width/height:1600/1200 06:49:04 INFO - PROCESS | 24078 | colorDepth:24 06:49:04 INFO - PROCESS | 24078 | Browser inner width/height: 1024/697 06:49:04 INFO - PROCESS | 24078 | __metrics 06:49:04 ERROR - PROCESS | 24078 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:49:05 INFO - TEST-INFO | 24078: exit 0 06:49:05 INFO - Browser initialized. 06:49:05 INFO - Running cycle 1/1 for kraken test... 06:49:05 INFO - TEST-INFO | started process 24197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptVHDmI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:07 INFO - PROCESS | 24197 | 06:49:07 INFO - PROCESS | 24197 | (process:24257): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:49:17 INFO - PROCESS | 24197 | RSS: Main: 164638720 06:49:17 INFO - PROCESS | 24197 | 06:49:20 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55032/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:21 INFO - PROCESS | 24197 | RSS: Main: 168841216 06:49:21 INFO - PROCESS | 24197 | 06:49:24 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55032/tests/kraken/driver.html?testName=audio-dft) 06:49:24 INFO - PROCESS | 24197 | RSS: Main: 172384256 06:49:24 INFO - PROCESS | 24197 | 06:49:27 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55032/tests/kraken/driver.html?testName=audio-fft) 06:49:28 INFO - PROCESS | 24197 | RSS: Main: 164655104 06:49:28 INFO - PROCESS | 24197 | 06:49:30 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55032/tests/kraken/driver.html?testName=audio-oscillator) 06:49:31 INFO - PROCESS | 24197 | RSS: Main: 165253120 06:49:31 INFO - PROCESS | 24197 | 06:49:33 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:34 INFO - PROCESS | 24197 | RSS: Main: 165457920 06:49:34 INFO - PROCESS | 24197 | 06:49:37 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55032/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:37 INFO - PROCESS | 24197 | RSS: Main: 165810176 06:49:37 INFO - PROCESS | 24197 | 06:49:41 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55032/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:41 INFO - PROCESS | 24197 | RSS: Main: 163614720 06:49:41 INFO - PROCESS | 24197 | 06:49:44 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55032/tests/kraken/driver.html?testName=json-parse-financial) 06:49:45 INFO - PROCESS | 24197 | RSS: Main: 163876864 06:49:45 INFO - PROCESS | 24197 | 06:49:47 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:47 INFO - PROCESS | 24197 | RSS: Main: 164118528 06:49:47 INFO - PROCESS | 24197 | 06:49:49 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:50 INFO - PROCESS | 24197 | RSS: Main: 164360192 06:49:50 INFO - PROCESS | 24197 | 06:49:52 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:53 INFO - PROCESS | 24197 | RSS: Main: 164696064 06:49:53 INFO - PROCESS | 24197 | 06:49:56 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:56 INFO - PROCESS | 24197 | RSS: Main: 164843520 06:49:56 INFO - PROCESS | 24197 | 06:49:59 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:50:00 INFO - PROCESS | 24197 | RSS: Main: 164913152 06:50:00 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | Cycle 1(1): loaded http://localhost:55032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55032/tests/kraken/driver.html?testName=ai-astar) 06:50:02 INFO - PROCESS | 24197 | RSS: Main: 166326272 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | __start_tp_report 06:50:02 INFO - PROCESS | 24197 | _x_x_mozilla_page_load 06:50:02 INFO - PROCESS | 24197 | _x_x_mozilla_page_load_details 06:50:02 INFO - PROCESS | 24197 | |i|pagename|runs| 06:50:02 INFO - PROCESS | 24197 | |0;ai-astar;114;107;112;112;112;128;118;114;114;113 06:50:02 INFO - PROCESS | 24197 | |1;audio-beat-detection;158;133;157;199;133;162;155;137;182;132 06:50:02 INFO - PROCESS | 24197 | |2;audio-dft;161;164;166;167;169;165;162;163;167;163 06:50:02 INFO - PROCESS | 24197 | |3;audio-fft;73;74;74;161;75;73;79;73;164;79 06:50:02 INFO - PROCESS | 24197 | |4;audio-oscillator;95;94;152;95;96;95;147;97;94;143 06:50:02 INFO - PROCESS | 24197 | |5;imaging-gaussian-blur;118;118;118;118;117;118;118;117;119;118 06:50:02 INFO - PROCESS | 24197 | |6;imaging-darkroom;147;148;148;147;147;148;147;148;147;146 06:50:02 INFO - PROCESS | 24197 | |7;imaging-desaturate;96;95;95;96;96;95;96;95;95;95 06:50:02 INFO - PROCESS | 24197 | |8;json-parse-financial;64;66;69;64;65;66;70;78;62;65 06:50:02 INFO - PROCESS | 24197 | |9;json-stringify-tinderbox;64;66;65;66;66;66;65;70;65;65 06:50:02 INFO - PROCESS | 24197 | |10;stanford-crypto-aes;79;79;81;80;90;80;81;81;82;81 06:50:02 INFO - PROCESS | 24197 | |11;stanford-crypto-ccm;136;142;133;139;132;135;133;135;221;137 06:50:02 INFO - PROCESS | 24197 | |12;stanford-crypto-pbkdf2;173;180;187;178;173;172;171;180;181;179 06:50:02 INFO - PROCESS | 24197 | |13;stanford-crypto-sha256-iterative;71;74;75;72;72;69;72;72;71;72 06:50:02 INFO - PROCESS | 24197 | __end_tp_report 06:50:02 INFO - PROCESS | 24197 | __start_cc_report 06:50:02 INFO - PROCESS | 24197 | _x_x_mozilla_cycle_collect,935 06:50:02 INFO - PROCESS | 24197 | __end_cc_report 06:50:02 INFO - PROCESS | 24197 | __startTimestamp1461333002454__endTimestamp 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | ------- Summary: start ------- 06:50:02 INFO - PROCESS | 24197 | Number of tests: 14 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:5.50 (4.8%) stddev-sans-first:5.83 06:50:02 INFO - PROCESS | 24197 | Values: 114.0 107.0 112.0 112.0 112.0 128.0 118.0 114.0 114.0 113.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:157.50 stddev:22.48 (14.3%) stddev-sans-first:23.81 06:50:02 INFO - PROCESS | 24197 | Values: 158.0 133.0 157.0 199.0 133.0 162.0 155.0 137.0 182.0 132.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.50 stddev:2.54 (1.5%) stddev-sans-first:2.32 06:50:02 INFO - PROCESS | 24197 | Values: 161.0 164.0 166.0 167.0 169.0 165.0 162.0 163.0 167.0 163.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.00 stddev:36.97 (50.0%) stddev-sans-first:38.53 06:50:02 INFO - PROCESS | 24197 | Values: 73.0 74.0 74.0 161.0 75.0 73.0 79.0 73.0 164.0 79.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:95.00 stddev:25.31 (26.6%) stddev-sans-first:26.20 06:50:02 INFO - PROCESS | 24197 | Values: 95.0 94.0 152.0 95.0 96.0 95.0 147.0 97.0 94.0 143.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:50:02 INFO - PROCESS | 24197 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 118.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:50:02 INFO - PROCESS | 24197 | Values: 147.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 146.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:50:02 INFO - PROCESS | 24197 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:4.56 (6.9%) stddev-sans-first:4.71 06:50:02 INFO - PROCESS | 24197 | Values: 64.0 66.0 69.0 64.0 65.0 66.0 70.0 78.0 62.0 65.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.58 06:50:02 INFO - PROCESS | 24197 | Values: 64.0 66.0 65.0 66.0 66.0 66.0 65.0 70.0 65.0 65.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:3.17 (3.9%) stddev-sans-first:3.24 06:50:02 INFO - PROCESS | 24197 | Values: 79.0 79.0 81.0 80.0 90.0 80.0 81.0 81.0 82.0 81.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:136.50 stddev:27.12 (19.9%) stddev-sans-first:28.60 06:50:02 INFO - PROCESS | 24197 | Values: 136.0 142.0 133.0 139.0 132.0 135.0 133.0 135.0 221.0 137.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:179.50 stddev:5.06 (2.8%) stddev-sans-first:5.11 06:50:02 INFO - PROCESS | 24197 | Values: 173.0 180.0 187.0 178.0 173.0 172.0 171.0 180.0 181.0 179.0 06:50:02 INFO - PROCESS | 24197 | 06:50:02 INFO - PROCESS | 24197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.63 (2.3%) stddev-sans-first:1.69 06:50:02 INFO - PROCESS | 24197 | Values: 71.0 74.0 75.0 72.0 72.0 69.0 72.0 72.0 71.0 72.0 06:50:02 INFO - PROCESS | 24197 | -------- Summary: end -------- 06:50:02 INFO - PROCESS | 24197 | 06:50:03 INFO - TEST-INFO | 24197: exit 0 06:50:03 INFO - TEST-OK | kraken | took 63538ms 06:50:03 INFO - SUITE-END | took 1178s 06:50:03 INFO - Completed test suite (00:19:38) 06:50:03 INFO - javascript benchmark 06:50:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.0822957849964, 2652.522545941731, 2679.464107178565, 2684.530207213737, 2688.0994866719648, 4676.228422310319, 4689.85930422087, 4704.0, 4710.17571924913, 4737.478877323491, 4534.251848445011, 4693.413323334583, 4724.0, 4773.737444440563, 4783.043391321741, 4346.022145017369, 4389.539098394671, 4397.0, 4438.178936896668, 4443.066955939256, 4348.608625223729, 4354.542773008836, 4373.497047839492, 4382.255016647162, 4398.780060996954, 4303.354496825501, 4309.008927946574, 4344.934825977582, 4371.693981421302, 4418.889527761799, 4326.221280169569, 4331.610155086058, 4339.717918335298, 4349.521552629209, 4378.299472084483, 4326.048269380732, 4330.415393921811, 4342.739435633872, 4366.3013917773005, 4374.234508960919, 4439.800208990603, 4601.930971035437, 4641.234196357597, 4656.8602941911795, 4687.1328804171335, 4951.950480495185, 4974.204127339644, 4983.875403114915, 5015.974920125413, 5028.220625803006, 4915.5084491550915, 5027.79888804451, 5033.370828646419, 5034.421041580228, 5076.517730815566, 4717.858464246078, 4747.026859493795, 4762.166620841408, 4799.952000480021, 4806.735629540409, 5052.545270925634, 5115.87210319745, 5118.283440318359, 5138.0, 5178.508041736029, 4718.4809670936165, 4871.244957031666, 4902.2156454967035, 4928.088303663833, 4953.6037117030555, 4958.975205123951, 4975.825846095369, 4992.151334273182, 5003.0, 5029.446760856303, 4772.260299653559, 4829.372181616438, 4842.806287748451, 4848.951510484921, 4851.781669824866, 4820.662553621213, 4848.17581011229, 4849.078675051729, 4858.028394321079, 4862.17343051682, 4155.8337666493, 4191.601797829201, 4234.978825105916, 4237.978810105929, 4279.037216626297, 3664.029032306441, 3701.685356744653, 3730.720195985312, 3761.4357846322723, 3769.8869033929027, 4320.827166913351, 4352.455943007124, 4356.564343565618, 4357.411749413788, 4403.207422663952, 5043.87390315245, 5050.949490505048, 5053.646244762905, 5068.923966140511, 5079.5428411443145, 4221.261279276115, 4232.661387089025, 4354.0, 4355.324924636687, 4391.209582275157, 4582.243929751554, 4587.799358384548, 4594.471635761864, 4600.930986035212, 4640.141573808856, 4791.401074865642, 4807.879803004883, 4818.229083346648, 4832.178529649968, 4849.248366503198, 4876.24418215163, 4982.377202849644, 5041.798328066983, 5091.083604950996, 5105.744712764273, 4704.1062198182235, 4729.787159577896, 4743.335932969318, 4762.142814293322, 4780.593649539828, 4918.926216106833, 4922.901541969069, 4925.113479573711, 4931.580815630711, 4972.65191436596, 4883.6093112551625, 4935.062338155739, 5006.724630145377, 5012.448630650552, 5068.543831055223, 4892.046051020017, 4897.975510122426, 4909.4354149273295, 4920.926186107283, 4960.057589058068, 4882.7314497701545, 4886.242632391985, 4909.828156014522, 4910.165271903714, 4962.429320628174, 4625.190591646381, 4655.743934083658, 4678.8596342109795, 4741.596964257938, 4795.520447955177, 4944.986277813112, 4952.0, 4953.009398120318, 4963.726995015309, 4992.6255530834605, 4855.393075865517, 4856.902861942812, 4857.659963802641, 4857.758448709304, 4902.828401005948], "value": 4608.884993639535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9439553242444, 616.4267231474729, 630.9085182648514, 639.3414782773742, 643.0097649619586, 34226.0, 35252.0, 35258.471122933144, 35354.8232258839, 35444.468332975, 38333.23333533328, 38924.610753892455, 38930.61069389305, 38938.22123557527, 38988.41517377242, 7824.804379890491, 7948.602569871512, 8019.558924259163, 8022.19778022199, 8043.075046369655, 7789.10425301092, 7893.763187104396, 7906.169852165497, 7924.603769811515, 7926.762197134095, 7913.564753938531, 7926.048874135112, 7930.524168549877, 7982.0, 7985.520868747864, 7845.68617255312, 7943.046834379854, 7947.523148611073, 7947.761567152937, 7949.046114466301, 7879.724209652634, 7982.800429989239, 7989.081255655616, 7991.041075071029, 7992.560409177493, 37275.44086838672, 37969.0, 37992.0, 38006.42990355147, 38067.619323806684, 2501.5997440409446, 2943.5290353543332, 2946.79372443929, 3127.9530807037913, 3181.729552987999, 24324.87837560801, 24361.26916192517, 24697.506049878903, 25368.492630147477, 25399.492010159876, 3181.602299712536, 3242.0922141800334, 3249.23642943908, 3339.9833000835083, 3391.8982430527126, 154612.0, 155091.0, 155764.22117889338, 157026.0, 157110.21444892703, 32383.35233295368, 32556.837215813768, 32563.348733025206, 32616.836915815267, 33449.163770905434, 33083.0, 33253.50119748206, 33799.0, 33806.32387352239, 33907.321853563284, 12411.813822792485, 12767.042471814651, 12800.871991280153, 12807.359632018362, 12839.614811555668, 9268.860967085498, 9326.06739326062, 9331.300152488591, 9343.813123737487, 9358.485283309483, 8174.0, 8200.58997050157, 8209.343252539782, 8271.2142346477, 8306.667733290722, 3190.441672707267, 3202.343519578481, 3218.3885061838646, 3245.789023713451, 3273.3616944695555, 903.3992395057345, 930.1024511346583, 942.4580866002076, 983.7491439682979, 1008.3546530220665, 27206.0, 28744.413002829846, 28828.279293017844, 28942.276443089093, 29193.0, 994.7413672445216, 1005.3515482513737, 1005.8340373838381, 1039.6257347354947, 1147.942602869853, 14529.200893950934, 15274.312655930287, 15422.151781651892, 15589.220538973006, 15640.2179891005, 335155.0, 341949.0, 342293.0, 342789.0, 344209.0, 49203.753981230584, 49893.25160122601, 50073.49926500761, 50100.49899501031, 50197.0, 1170.5434880396651, 1221.7922953097816, 1261.7918043522716, 1265.9683507912375, 1277.5464710027993, 25534.872325638255, 27614.5857812137, 27908.86045569759, 27910.581341280304, 28096.0, 42465.0, 42849.0, 43373.0, 43427.78286108549, 43550.782246088565, 304463.0, 306677.0, 306981.0, 307053.0, 307527.0, 25626.23121306364, 25757.871210643825, 25846.483070338865, 25891.482170356863, 25991.870040649676, 42431.7878410606, 42447.57552424436, 42611.0, 43208.35187472253, 43230.56769432266, 35892.64107358893, 36179.0, 36396.0, 36813.81593092017, 36828.0, 35769.28461430809, 36272.45591316185, 36313.27373452569, 36477.45283820692, 37080.0, 35314.293714126085, 35863.64136358603, 36035.459468107474, 39352.655024323256, 39605.2078958425, 29979.0, 31463.37073258476, 31521.369572608877, 31559.0, 31672.366552668358, 24651.260462186165, 24688.753112468647, 24840.0, 25046.74953250444, 25198.11806586834], "value": 15917.698631688694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.22103855538313, 385.39877790646574, 392.07470369926966, 393.49632470437837, 398.8703671306826, 15212.695746085086, 16379.628061717445, 16453.0, 16476.917615411905, 16540.503784886456, 15529.0, 15534.53396398107, 16230.918845405757, 16308.83691163088, 16323.183840807942, 5131.794728210867, 5286.841394758163, 5328.254044433763, 5331.2003199519995, 5332.600054995872, 3656.3966945453967, 5714.71426428679, 6039.758409663608, 6044.66754328514, 6050.092486127094, 4997.950020499803, 5878.588498805086, 5921.082232254007, 5926.851828704295, 5941.584089113764, 5262.500062494057, 5267.604929630274, 5285.762140703678, 5310.8406747797435, 5324.813631522898, 4971.975140124312, 5399.244105825148, 5412.350517937873, 5447.319085114361, 5449.264349312832, 19256.326028589072, 19333.130009149623, 19686.70469942952, 19970.600587988305, 20187.79812201874, 1827.3878250786004, 1945.108463850346, 1951.3853136262173, 2002.2591641092888, 2105.631514484974, 8842.5136617486, 9242.260619150451, 9574.808503829885, 9630.422174669542, 9690.51547422626, 1706.0, 1748.9650206995789, 1794.667986422503, 1813.7732783402075, 1850.8519318454491, 65951.67024164897, 67004.3299567003, 67044.0, 69167.65416172937, 69315.65342173308, 9804.509774511245, 9942.652007179713, 9949.751256218653, 9962.203023758228, 10073.194144468425, 13869.514566990107, 13881.305934703225, 13940.37268322928, 13969.092009019381, 14013.719725605431, 6927.861442771217, 6928.618925959121, 6962.1297337832775, 7052.153741550944, 7053.470989675795, 6445.291017988017, 6464.676766161673, 6565.212174539086, 6565.704543295563, 6572.342765723485, 4074.8573799916862, 4194.475690538683, 4307.535437951049, 4343.82624695015, 4369.43197384338, 1662.883598148118, 1730.204106111203, 1810.8913465191868, 1820.1172431370774, 1834.9445486524046, 859.3941271403645, 899.9550022498848, 925.5418567808978, 929.9814003719888, 1041.2242879055152, 16106.919465402598, 16145.919270403572, 16323.102229377499, 16413.42553010639, 16503.422380216874, 859.9742007739778, 877.8858748362672, 890.4034297021011, 895.8253140637513, 918.2516249256835, 8882.86675699865, 8904.59929303183, 9050.140236677506, 9214.815703685888, 9244.075592440837, 387805.0, 395745.0, 400382.0, 402739.0, 403798.0, 74172.0, 76317.0, 76691.0, 77067.22932770713, 77504.61247693725, 928.2991341537096, 936.8266870628955, 956.7368973532195, 960.1694534227983, 967.1344146988406, 14836.480723174636, 14869.47956821506, 14936.551903442914, 15001.324940377928, 15094.773578396553, 33498.33003339968, 34009.31981360408, 34246.14384640404, 34382.484262735576, 35318.82340588281, 47096.29355559601, 48872.75563622159, 49354.0, 49707.502924970286, 49722.75138624284, 5506.504414602705, 7753.573553454614, 7806.88289675644, 7858.44990850635, 8093.919060809317, 6290.2766181889665, 8083.312918401766, 9942.900570994487, 11859.762804743685, 11902.226355286879, 9284.58219380143, 9290.210332121846, 9302.720918372459, 9415.529223538659, 9714.611415543299, 8904.688335908211, 9811.607535698493, 10062.345947513388, 10174.236932229964, 10433.113185379329, 10013.998600139928, 10062.295639305179, 10100.747481313027, 10255.897441025792, 10326.638567650096, 7388.4828062037295, 7543.585102819397, 7635.656395462106, 7678.577678227751, 7813.726519572015, 9952.35309704896, 9997.200223982209, 10005.199584033115, 10087.848682269918, 10155.136813370946], "value": 8074.578595444774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.9161850288983, 1453.5784622459487, 1550.232634845751, 1689.704301747194, 1741.1555395633115, 7022.789316320505, 7619.961900190498, 7678.462507624468, 7890.0, 7916.287534121935, 7662.1571627120975, 7677.078750549942, 7723.189065148163, 7725.575093369863, 7740.612969351538, 2221.2780846225, 2237.3511681612313, 2240.0815665577115, 2243.4391402149463, 2246.921357752479, 2156.3099808061424, 2167.566486702658, 2191.2878314547834, 2192.2217612747486, 2197.549502352022, 2223.0, 2223.8109760670363, 2237.776222377757, 2252.538229662915, 2254.4701995031155, 2188.2888061380113, 2189.562087582474, 2196.516766311409, 2196.7803219677985, 2215.1471683401846, 2136.8504204705678, 2151.7202763640785, 2152.1068756466047, 2158.902849371782, 2161.729783777028, 7788.805279868048, 7802.29779319864, 7858.607069646495, 7881.605919703992, 7957.283844453969, 4518.028623845889, 4709.058188362307, 4712.434507859045, 4727.385439892826, 4738.881527961794, 2870.942581148386, 2872.5691146328218, 2955.1725516855313, 2978.5681076243823, 2994.191568276575, 852.6205838401913, 882.2544949517711, 888.6623083228332, 895.5566994337779, 899.2850683706469, 10471.947640261826, 10518.947405262925, 10531.420771857622, 10560.577576896914, 10603.575856965712, 4173.728707633994, 4293.441852559147, 4295.398644189816, 4361.171377438277, 4428.933565996513, 9011.234045106108, 9034.774130646787, 9049.683261085831, 9050.366474346733, 9068.274538036942, 4748.3114948332295, 4756.357891684647, 4762.499937506581, 4791.161546729309, 4801.735904525215, 3861.4400911867624, 4321.373400856858, 4345.500267469281, 4421.911561768747, 4422.800973956179, 3626.1659818241424, 3728.12389088564, 3740.401535754266, 3843.423486476995, 3857.614238576176, 1252.292454763056, 1274.1781550899618, 1284.210210720419, 1293.502001729341, 1294.4886769725906, 718.1669263654136, 802.253903869407, 897.5960817631961, 910.8724778531011, 914.8490499067713, 5455.918161227585, 5502.174673798962, 5599.048161812501, 5601.29983752031, 5683.857903552444, 358.867219128924, 370.8942951258932, 372.5231703419573, 378.17369048628836, 383.87332180380406, 3711.1464363196615, 3810.48558444612, 3959.920801583952, 4014.458048163519, 4167.541570427251, 9206.217471514996, 9451.196648284835, 9518.476483793458, 9535.666251681158, 9540.856887146698, 9290.16388525036, 9420.43477391345, 9451.29115316354, 9467.952660236655, 9468.19520340765, 6950.860982780316, 7204.207537170907, 7204.747833825791, 7225.710971561079, 7326.7069317226715, 5369.5167434931045, 5616.494515493625, 5675.517581005495, 5699.572532060195, 5848.883022339444, 8738.475691458532, 8925.330600205141, 8984.640614375352, 9116.179543841086, 9168.083191680778, 8856.64573417056, 9105.681301154427, 9118.99691033999, 9119.726408207764, 9223.815523689624, 6475.870482590416, 7167.462440317101, 7337.3763230123905, 7425.777226683208, 7534.095908491016, 7566.092068951761, 7694.769156925301, 7706.845863082594, 7724.845503089794, 7763.4953728007495, 6852.486063545353, 6996.860062798817, 7058.329458701415, 7122.0, 7132.679029443584, 6838.38454539074, 6903.723851045902, 6961.060256865258, 6968.442524597918, 7016.36852683261, 6266.060090986389, 6296.150019747275, 6410.775622853178, 6443.871122577429, 6499.935000650122, 4866.124097662313, 4941.555260026615, 4974.626902982219, 4992.675476094042, 5125.974370128126, 4974.154393753143, 5032.3206367139965, 5155.948440515697, 5157.922631160461, 5195.142801437721], "value": 4140.731603130809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.1440025529538, 317.5015226095031, 318.7768562006596, 321.927566297583, 327.6821483161333, 4939.209726443761, 5092.312537807395, 5291.735413229338, 5300.89398212036, 5355.0, 5242.397124330693, 5262.158054711237, 5266.605004624649, 5268.209768534722, 5302.3106996090555, 4167.562405947378, 4185.665146788249, 4189.790510474464, 4190.057237121654, 4204.600562946515, 4177.101923086536, 4187.099773548686, 4187.706860519765, 4191.057012172252, 4192.454980852485, 3835.961640383602, 4035.3341698619693, 4046.3728122141115, 4051.0480037191237, 4053.5541090480024, 4046.2312160689376, 4056.3307054336146, 4067.837286508536, 4069.5726948670554, 4071.5114186297537, 3557.484164796116, 3567.3935430976794, 3573.4818451324413, 3575.803330816804, 3592.7305452091196, 4940.689737875632, 5037.19404895215, 5048.924266136011, 5061.949380506185, 5078.085944529983, 4595.724256544618, 4630.467496237942, 4636.4899861015265, 4640.211164102111, 4656.206276234267, 5478.150886612581, 5483.75323110461, 5490.396056433789, 5495.148252020943, 5507.807226747084, 3771.5662698789715, 3844.615538446161, 3871.2838124946693, 3874.2638898609175, 3877.476540667002, 5435.402105768362, 5636.464535869127, 5739.885202295973, 5800.506956908668, 5818.679972601505, 3939.3893946438347, 3950.6839452843706, 3953.367461206193, 3963.960360396417, 3969.503812023497, 4013.538443079083, 4017.216642754693, 4019.6132334344607, 4020.0753826619457, 4034.031832360271, 4503.874031492127, 4602.194615942197, 4605.286180642006, 4608.976955115203, 4611.077784443058, 5448.809291674852, 5504.559635229172, 5510.586705996986, 5520.392756796749, 5534.169874518854, 1370.8286464191976, 1390.5828251524501, 1392.6978275312413, 1396.6368744126396, 1398.8461269260374, 904.8099899021148, 936.0826390137703, 942.6229508196776, 943.8206740719241, 950.7623094226443, 4804.95195048045, 4811.27830825379, 4812.446568644651, 4826.396700412449, 4829.0, 5544.1960915667805, 5641.943580564224, 5643.492085712305, 5659.5755318351285, 5665.405132461032, 4638.6752927294765, 4781.378420805273, 4781.856544303607, 4785.210440277316, 4793.616510679138, 3010.6086208793154, 3027.4399236140944, 3035.0, 3036.193464888388, 3043.6651968283472, 5286.444923283077, 5313.415524292324, 5319.494648008433, 5343.385510666323, 5347.3048503695045, 5569.0, 5764.5676574257095, 5791.594588378773, 5817.7091145442555, 5820.883582328414, 5327.094393953037, 5335.253064571041, 5340.465953404629, 5352.5450336721815, 5373.731313434313, 5561.63849349791, 5655.066913959316, 5660.971695141498, 5677.120046392815, 5695.351661477433, 5518.475744804237, 5527.143292789624, 5532.391436942014, 5550.666959982414, 5585.469380408855, 5118.364042518032, 5245.423003469539, 5345.438728933406, 5426.8371948841595, 5431.293931788842, 3939.2121575684405, 3954.149857780591, 3961.1879564688593, 3968.722189446711, 3971.960280397159, 5703.515201207943, 5710.0, 5714.0, 5716.199732037601, 5725.341585717696, 5384.21928820311, 5538.750756215899, 5553.029129415743, 5557.305336832896, 5565.276514053147, 5477.123660214346, 5511.641743286674, 5519.681733671948, 5544.75048622821, 5545.334559852843, 5337.57299416038, 5405.783768649368, 5428.511433970962, 5462.235287059735, 5463.453654634504, 5570.749316280696, 5578.748956297058, 5593.07714227148, 5596.440355964371, 5606.523445507178, 5446.210299506629, 5462.3445186577865, 5463.399026107046, 5483.862903427446, 5486.6982315973], "value": 4137.035864727704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7371219807185, 615.6152404747033, 631.6778442994072, 644.1239913717346, 650.102858055883, 11647.592334268302, 11814.704632384195, 11838.526458941642, 11851.822222666668, 13226.603201903934, 13919.512817051405, 14028.999999999975, 14046.157230566174, 14063.648408789786, 14070.929645351758, 642.9742810287582, 780.3679019993823, 782.964766585505, 784.356827401531, 784.8665726826454, 794.5074054086474, 809.6761295481825, 812.0215140755375, 812.7642983534768, 816.0126247240846, 842.1914961636836, 845.5265051571109, 846.9915300846974, 847.8134810341714, 850.0139837788167, 828.9461185022955, 832.2509741232878, 837.0792128658488, 838.4633834346023, 846.2426128614886, 595.0152497616451, 595.9523238140938, 618.4526693875907, 623.1151764494429, 625.0686477149061, 12639.1784534005, 12669.493220271179, 12705.682357941034, 12706.936465317614, 12725.045621578327, 10806.081483073947, 10818.513166907429, 11184.273022253528, 11491.94254028733, 12110.39448027604, 9170.358074934757, 9173.082691730773, 9261.72214833556, 9342.346035777498, 9433.198178154866, 3069.1406406206297, 3157.100226435478, 3189.5694081299193, 3190.6875053036665, 3304.7521435892163, 46516.302255466195, 46929.765351173024, 47071.764641176575, 47503.287450688265, 47728.522714773106, 9651.662191823392, 9734.610615575439, 9764.0, 9809.607615695435, 9872.802543949225, 17026.659466810594, 17064.829351706325, 17091.230894609773, 17104.0, 17219.052952087757, 5703.08750599902, 5729.684867332254, 5851.707414629337, 5906.793262235801, 5973.074173503114, 3277.852496637657, 3379.5775528058994, 3453.430184019659, 3473.3574288756663, 3477.3045390921916, 2639.1686618715044, 2741.342077901329, 2743.82165159268, 2745.2862255813634, 2927.2828157101644, 524.2058281703223, 528.9047971365192, 529.0714795533813, 534.7834127178498, 537.2961420539107, 501.3532543019464, 569.9971500142556, 584.8040906296438, 588.0180099234288, 592.9741547123415, 7258.709651613982, 7452.292032256927, 7543.0948286206, 7748.651310691032, 7796.649150788228, 475.25385145321513, 500.7521276967924, 544.9809256675998, 579.4147910610229, 590.4921767280135, 3394.4568868980846, 3431.9313613727586, 3507.94738078929, 3616.349057169735, 3659.121810765397, 54896.725516372164, 55460.72269638626, 55875.0, 56285.718571406884, 56495.0, 46589.30116048262, 47089.764551177024, 47242.52757472381, 48007.75996119997, 48336.274955874986, 43174.0, 43230.35154472685, 43574.56425435705, 43863.56136438595, 43943.0, 6859.0, 6992.930070699432, 7013.473989450914, 7074.257202993612, 7144.142702875688, 27603.585946211224, 27699.446011079264, 28203.0, 28262.57606135951, 28390.019047999664, 36000.0, 38878.41682374823, 38990.4151437723, 39201.215975679756, 40033.599664004156, 9036.774080648036, 9108.681196158102, 9216.723498295061, 9252.352335336462, 9287.210587099902, 10273.280870339304, 10362.585496580052, 10378.221633377376, 10530.157587393143, 10756.83864742045, 9254.4910029949, 9427.3400861939, 9521.0, 9655.951720241354, 9801.411915285105, 8393.496390216607, 8668.0898505656, 8755.080716524928, 8793.824123517621, 8841.469511829311, 8936.776580585538, 9007.234385077341, 9087.409318394282, 9185.219256363016, 9195.862062069207, 8145.18419597093, 8522.78693032679, 8611.655533778829, 8763.956180219058, 8794.692185773467, 7959.442839001214, 7994.40041996841, 8056.476329038594, 8108.2297181767635, 8239.670413183405], "value": 5620.200860879869, "unit": "score"}], "name": "dromaeo_css", "value": 6204.299786853029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 112.0, 112.0, 112.0, 128.0, 118.0, 114.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 157.0, 199.0, 133.0, 162.0, 155.0, 137.0, 182.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 166.0, 167.0, 169.0, 165.0, 162.0, 163.0, 167.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 161.0, 75.0, 73.0, 79.0, 73.0, 164.0, 79.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 152.0, 95.0, 96.0, 95.0, 147.0, 97.0, 94.0, 143.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 69.0, 64.0, 65.0, 66.0, 70.0, 78.0, 62.0, 65.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 70.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 81.0, 80.0, 90.0, 80.0, 81.0, 81.0, 82.0, 81.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 133.0, 139.0, 132.0, 135.0, 133.0, 135.0, 221.0, 137.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 180.0, 187.0, 178.0, 173.0, 172.0, 171.0, 180.0, 181.0, 179.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 75.0, 72.0, 72.0, 69.0, 72.0, 72.0, 71.0, 72.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1605.6000000000001, "alertThreshold": 2.0}]} 06:50:03 INFO - Return code: 0 06:50:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:50:03 ERROR - # TBPL SUCCESS # 06:50:03 INFO - Running post-action listener: _resource_record_post_action 06:50:03 INFO - Running post-run listener: _resource_record_post_run 06:50:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 518279168; Read time: 0; Write time: 392860 06:50:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234418176; Read time: 0; Write time: 247712 06:50:04 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283758592; Read time: 0; Write time: 145148 06:50:04 INFO - Running post-run listener: _upload_blobber_files 06:50:04 INFO - Blob upload gear active. 06:50:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:50:04 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:50:04 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:50:04 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:50:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:50:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:50:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:06 INFO - (blobuploader) - INFO - Done attempting. 06:50:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:50:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:50:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:07 INFO - (blobuploader) - INFO - Done attempting. 06:50:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:50:07 INFO - Return code: 0 06:50:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:50:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:50:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/129482464e91592fc6d02ba5d7271f16ef94df9104e24dcd8d46ba873438b8e843f1d5f658d78fbc5f34368c788ae8357cf4e695aee2fb33d7ed94427123e36a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d97d072fd702fcc3dfc4f0f8c4e512ece41acd2766536dfd58ff2271f4514c98cd4b1faaf7f5ee3ff4ced6a9b8f2cad56f02eea4a36fef9036043fcce3aa99db"} 06:50:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:50:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:50:07 INFO - Contents: 06:50:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/129482464e91592fc6d02ba5d7271f16ef94df9104e24dcd8d46ba873438b8e843f1d5f658d78fbc5f34368c788ae8357cf4e695aee2fb33d7ed94427123e36a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d97d072fd702fcc3dfc4f0f8c4e512ece41acd2766536dfd58ff2271f4514c98cd4b1faaf7f5ee3ff4ced6a9b8f2cad56f02eea4a36fef9036043fcce3aa99db"} 06:50:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:50:07 INFO - Copying logs to upload dir... 06:50:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:50:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.101501 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-22 06:50:06.859965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:06.865147) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/129482464e91592fc6d02ba5d7271f16ef94df9104e24dcd8d46ba873438b8e843f1d5f658d78fbc5f34368c788ae8357cf4e695aee2fb33d7ed94427123e36a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d97d072fd702fcc3dfc4f0f8c4e512ece41acd2766536dfd58ff2271f4514c98cd4b1faaf7f5ee3ff4ced6a9b8f2cad56f02eea4a36fef9036043fcce3aa99db"} build_url:https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/eJ4XRFUDTu2vCSFgbhIBOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/129482464e91592fc6d02ba5d7271f16ef94df9104e24dcd8d46ba873438b8e843f1d5f658d78fbc5f34368c788ae8357cf4e695aee2fb33d7ed94427123e36a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d97d072fd702fcc3dfc4f0f8c4e512ece41acd2766536dfd58ff2271f4514c98cd4b1faaf7f5ee3ff4ced6a9b8f2cad56f02eea4a36fef9036043fcce3aa99db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:06.898825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:06.899277) ========= 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=7cf709767345e0a0c5a90e72000001d4-1461331771.180184-1831138022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:50:06.983103) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:50:06.983535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:50:06.984017) ========= ========= Total master_lag: 0.20 =========