builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1460994554.28 results: success (0) buildid: 20160418075623 builduid: fbc4a8173b0a405ab257119c12df27fc revision: 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.277218) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.277761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.278257) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.342857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.343137) ========= 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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 08:49:14-- 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% 79.4M=0s 2016-04-18 08:49:14 (79.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.446987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.447296) ========= 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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019363 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.504100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:14.504466) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 --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 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 --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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 08:49:14,580 truncating revision to first 12 chars 2016-04-18 08:49:14,580 Setting DEBUG logging. 2016-04-18 08:49:14,580 attempt 1/10 2016-04-18 08:49:14,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7dd5ac3bed0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 08:49:14,820 unpacking tar archive at: fx-team-7dd5ac3bed0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514105 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:15.032346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:15.032698) ========= script_repo_revision: 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:15.033201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:15.033525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 08:49:15.042804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 08:49:15.043149) ========= /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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:15 INFO - MultiFileLogger online at 20160418 08:49:15 in /builds/slave/test 08:49:15 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 08:49:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:15 INFO - {'append_to_log': False, 08:49:15 INFO - 'base_work_dir': '/builds/slave/test', 08:49:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:49:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:15 INFO - 'branch': 'Fx-Team-Non-PGO', 08:49:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:15 INFO - 'config_files': ('talos/linux_config.py',), 08:49:15 INFO - 'default_actions': ('clobber', 08:49:15 INFO - 'read-buildbot-config', 08:49:15 INFO - 'download-and-extract', 08:49:15 INFO - 'populate-webroot', 08:49:15 INFO - 'create-virtualenv', 08:49:15 INFO - 'install', 08:49:15 INFO - 'run-tests'), 08:49:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:15 INFO - 'download_minidump_stackwalk': True, 08:49:15 INFO - 'download_symbols': 'ondemand', 08:49:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:15 INFO - 'installer_path': 'installer.exe', 08:49:15 INFO - 'log_level': 'info', 08:49:15 INFO - 'log_name': 'talos', 08:49:15 INFO - 'log_to_console': True, 08:49:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:15 INFO - 'opt_config_files': (), 08:49:15 INFO - 'pip_index': False, 08:49:15 INFO - 'sps_profile': False, 08:49:15 INFO - 'sps_profile_interval': 0, 08:49:15 INFO - 'suite': 'dromaeojs-e10s', 08:49:15 INFO - 'system_bits': '32', 08:49:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:15 INFO - 'title': 'talos-linux64-ix-003', 08:49:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:15 INFO - 'use_talos_json': True, 08:49:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:15 INFO - 'work_dir': 'build'} 08:49:15 INFO - ##### 08:49:15 INFO - ##### Running clobber step. 08:49:15 INFO - ##### 08:49:15 INFO - Running pre-action listener: _resource_record_pre_action 08:49:15 INFO - Running main action method: clobber 08:49:15 INFO - rmtree: /builds/slave/test/build 08:49:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:16 INFO - Running post-action listener: _resource_record_post_action 08:49:16 INFO - ##### 08:49:16 INFO - ##### Running read-buildbot-config step. 08:49:16 INFO - ##### 08:49:16 INFO - Running pre-action listener: _resource_record_pre_action 08:49:16 INFO - Running main action method: read_buildbot_config 08:49:16 INFO - Using buildbot properties: 08:49:16 INFO - { 08:49:16 INFO - "project": "", 08:49:16 INFO - "product": "firefox", 08:49:16 INFO - "script_repo_revision": "production", 08:49:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:49:16 INFO - "repository": "", 08:49:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:49:16 INFO - "buildid": "20160418075623", 08:49:16 INFO - "pgo_build": "False", 08:49:16 INFO - "basedir": "/builds/slave/test", 08:49:16 INFO - "buildnumber": 1412, 08:49:16 INFO - "slavename": "talos-linux64-ix-003", 08:49:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:49:16 INFO - "platform": "ubuntu64_hw", 08:49:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:49:16 INFO - "branch": "fx-team", 08:49:16 INFO - "repo_path": "integration/fx-team", 08:49:16 INFO - "revision": "7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4", 08:49:16 INFO - "stage_platform": "linux64", 08:49:16 INFO - "builduid": "fbc4a8173b0a405ab257119c12df27fc", 08:49:16 INFO - "slavebuilddir": "test" 08:49:16 INFO - } 08:49:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:49:16 INFO - Running post-action listener: _resource_record_post_action 08:49:16 INFO - ##### 08:49:16 INFO - ##### Running download-and-extract step. 08:49:16 INFO - ##### 08:49:16 INFO - Running pre-action listener: _resource_record_pre_action 08:49:16 INFO - Running main action method: download_and_extract 08:49:16 INFO - mkdir: /builds/slave/test/build/tests 08:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:16 INFO - https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:18 INFO - Downloaded 1361 bytes. 08:49:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:49:18 INFO - Using the following test package requirements: 08:49:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:49:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:49:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'jsshell-linux-x86_64.zip'], 08:49:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:49:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:49:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:49:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:49:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:49:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:49:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:49:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:18 INFO - https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:19 INFO - Downloaded 22203755 bytes. 08:49:19 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'] 08:49:19 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 08:49:20 INFO - Return code: 0 08:49:20 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 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:20 INFO - https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:23 INFO - Downloaded 22203755 bytes. 08:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:49:25 INFO - Return code: 0 08:49:25 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')]} 08:49:25 INFO - https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:26 INFO - Downloaded 10845952 bytes. 08:49:26 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'] 08:49:26 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 08:49:26 INFO - Return code: 0 08:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:26 INFO - https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T5991uagSiiY712zWbfoxw/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 08:49:30 INFO - Downloaded 54450948 bytes. 08:49:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:49:30 INFO - mkdir: /builds/slave/test/properties 08:49:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:30 INFO - Contents: 08:49:30 INFO - build_url:https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - Running post-action listener: set_extra_try_arguments 08:49:31 INFO - ##### 08:49:31 INFO - ##### Running populate-webroot step. 08:49:31 INFO - ##### 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: populate_webroot 08:49:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:31 INFO - '--tppagecycles', 08:49:31 INFO - '7'], 08:49:31 INFO - 'tests': ['tsvgm']}}, 08:49:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['damp', 'tps']}, 08:49:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['damp', 'tps']}, 08:49:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['dromaeo_dom']}, 08:49:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['a11yr', 08:49:31 INFO - 'ts_paint', 08:49:31 INFO - 'tpaint', 08:49:31 INFO - 'sessionrestore', 08:49:31 INFO - 'sessionrestore_no_auto_restore', 08:49:31 INFO - 'tabpaint']}, 08:49:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tsvgx', 08:49:31 INFO - 'tsvgr_opacity', 08:49:31 INFO - 'tart', 08:49:31 INFO - 'tscrollx', 08:49:31 INFO - 'cart']}, 08:49:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:31 INFO - 'tsvgr_opacity', 08:49:31 INFO - 'tart', 08:49:31 INFO - 'tscrollx', 08:49:31 INFO - 'cart']}, 08:49:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s'], 08:49:31 INFO - 'tests': ['tp5o']}, 08:49:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'tests': ['tp5o']}, 08:49:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--disable-e10s', 08:49:31 INFO - '--xperf_path', 08:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:31 INFO - 'tests': ['tp5n']}, 08:49:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:31 INFO - 'talos_options': ['--xperf_path', 08:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:31 INFO - 'tests': ['tp5n']}}, 08:49:31 INFO - 'talos.zip': {'path': '', 08:49:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:31 INFO - Running post-action listener: _resource_record_post_action 08:49:31 INFO - ##### 08:49:31 INFO - ##### Running create-virtualenv step. 08:49:31 INFO - ##### 08:49:31 INFO - Running pre-action listener: _resource_record_pre_action 08:49:31 INFO - Running main action method: create_virtualenv 08:49:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:31 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 08:49:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:31 INFO - Using real prefix '/usr' 08:49:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:34 INFO - Installing pip.................done. 08:49:34 INFO - Return code: 0 08:49:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:34 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 08:49:34 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 08:49:34 INFO - Using env: {'DISPLAY': ':0', 08:49:34 INFO - 'HOME': '/home/cltbld', 08:49:34 INFO - 'LANG': 'en_US.UTF-8', 08:49:34 INFO - 'LANGUAGE': 'en_US:en', 08:49:34 INFO - 'LOGNAME': 'cltbld', 08:49:34 INFO - 'MAIL': '/var/mail/cltbld', 08:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:34 INFO - 'MOZ_NO_REMOTE': '1', 08:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:34 INFO - 'NO_EM_RESTART': '1', 08:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:34 INFO - 'PWD': '/builds/slave/test', 08:49:34 INFO - 'SHELL': '/bin/bash', 08:49:34 INFO - 'SHLVL': '1', 08:49:34 INFO - 'TERM': 'linux', 08:49:34 INFO - 'TMOUT': '86400', 08:49:34 INFO - 'USER': 'cltbld', 08:49:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:34 INFO - '_': '/tools/buildbot/bin/python'} 08:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:34 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 08:49:34 INFO - Cleaning up... 08:49:34 INFO - Return code: 0 08:49:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:34 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:34 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 08:49:34 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 08:49:34 INFO - Using env: {'DISPLAY': ':0', 08:49:34 INFO - 'HOME': '/home/cltbld', 08:49:34 INFO - 'LANG': 'en_US.UTF-8', 08:49:34 INFO - 'LANGUAGE': 'en_US:en', 08:49:34 INFO - 'LOGNAME': 'cltbld', 08:49:34 INFO - 'MAIL': '/var/mail/cltbld', 08:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:34 INFO - 'MOZ_NO_REMOTE': '1', 08:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:34 INFO - 'NO_EM_RESTART': '1', 08:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:34 INFO - 'PWD': '/builds/slave/test', 08:49:34 INFO - 'SHELL': '/bin/bash', 08:49:34 INFO - 'SHLVL': '1', 08:49:34 INFO - 'TERM': 'linux', 08:49:34 INFO - 'TMOUT': '86400', 08:49:34 INFO - 'USER': 'cltbld', 08:49:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:34 INFO - '_': '/tools/buildbot/bin/python'} 08:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:34 INFO - Downloading/unpacking psutil>=0.7.1 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:36 INFO - Installing collected packages: psutil 08:49:36 INFO - Running setup.py install for psutil 08:49:36 INFO - building 'psutil._psutil_linux' extension 08:49:36 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 08:49:36 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 08:49:37 INFO - building 'psutil._psutil_posix' extension 08:49:37 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 08:49:37 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 08:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:37 INFO - Successfully installed psutil 08:49:37 INFO - Cleaning up... 08:49:37 INFO - Return code: 0 08:49:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:37 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:37 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 08:49:37 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 08:49:37 INFO - Using env: {'DISPLAY': ':0', 08:49:37 INFO - 'HOME': '/home/cltbld', 08:49:37 INFO - 'LANG': 'en_US.UTF-8', 08:49:37 INFO - 'LANGUAGE': 'en_US:en', 08:49:37 INFO - 'LOGNAME': 'cltbld', 08:49:37 INFO - 'MAIL': '/var/mail/cltbld', 08:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:37 INFO - 'MOZ_NO_REMOTE': '1', 08:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:37 INFO - 'NO_EM_RESTART': '1', 08:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:37 INFO - 'PWD': '/builds/slave/test', 08:49:37 INFO - 'SHELL': '/bin/bash', 08:49:37 INFO - 'SHLVL': '1', 08:49:37 INFO - 'TERM': 'linux', 08:49:37 INFO - 'TMOUT': '86400', 08:49:37 INFO - 'USER': 'cltbld', 08:49:37 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:37 INFO - '_': '/tools/buildbot/bin/python'} 08:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:49:37 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 08:49:37 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 08:49:37 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 08:49:37 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 08:49:37 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 08:49:37 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 08:49:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:49:39 INFO - Installing collected packages: mozsystemmonitor 08:49:39 INFO - Running setup.py install for mozsystemmonitor 08:49:39 INFO - Successfully installed mozsystemmonitor 08:49:39 INFO - Cleaning up... 08:49:39 INFO - Return code: 0 08:49:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:39 INFO - Using env: {'DISPLAY': ':0', 08:49:39 INFO - 'HOME': '/home/cltbld', 08:49:39 INFO - 'LANG': 'en_US.UTF-8', 08:49:39 INFO - 'LANGUAGE': 'en_US:en', 08:49:39 INFO - 'LOGNAME': 'cltbld', 08:49:39 INFO - 'MAIL': '/var/mail/cltbld', 08:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:39 INFO - 'MOZ_NO_REMOTE': '1', 08:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:39 INFO - 'NO_EM_RESTART': '1', 08:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:39 INFO - 'PWD': '/builds/slave/test', 08:49:39 INFO - 'SHELL': '/bin/bash', 08:49:39 INFO - 'SHLVL': '1', 08:49:39 INFO - 'TERM': 'linux', 08:49:39 INFO - 'TMOUT': '86400', 08:49:39 INFO - 'USER': 'cltbld', 08:49:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:39 INFO - '_': '/tools/buildbot/bin/python'} 08:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 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 08:49:42 INFO - Downloading docopt-0.6.1.tar.gz 08:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:42 INFO - Running setup.py install for blobuploader 08:49:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:42 INFO - Running setup.py install for requests 08:49:43 INFO - Running setup.py install for docopt 08:49:43 INFO - Successfully installed blobuploader requests docopt 08:49:43 INFO - Cleaning up... 08:49:43 INFO - Return code: 0 08:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:43 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:43 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 08:49:43 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 08:49:43 INFO - Using env: {'DISPLAY': ':0', 08:49:43 INFO - 'HOME': '/home/cltbld', 08:49:43 INFO - 'LANG': 'en_US.UTF-8', 08:49:43 INFO - 'LANGUAGE': 'en_US:en', 08:49:43 INFO - 'LOGNAME': 'cltbld', 08:49:43 INFO - 'MAIL': '/var/mail/cltbld', 08:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:43 INFO - 'MOZ_NO_REMOTE': '1', 08:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:43 INFO - 'NO_EM_RESTART': '1', 08:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:43 INFO - 'PWD': '/builds/slave/test', 08:49:43 INFO - 'SHELL': '/bin/bash', 08:49:43 INFO - 'SHLVL': '1', 08:49:43 INFO - 'TERM': 'linux', 08:49:43 INFO - 'TMOUT': '86400', 08:49:43 INFO - 'USER': 'cltbld', 08:49:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:43 INFO - '_': '/tools/buildbot/bin/python'} 08:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:43 INFO - Running setup.py (path:/tmp/pip-TPBOGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:43 INFO - Running setup.py (path:/tmp/pip-efu_Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:43 INFO - Running setup.py (path:/tmp/pip-ds44k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:43 INFO - Running setup.py (path:/tmp/pip-onKaNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:43 INFO - Running setup.py (path:/tmp/pip-08weoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:43 INFO - Running setup.py (path:/tmp/pip-oM8Mmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:43 INFO - Running setup.py (path:/tmp/pip-TVQM9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:44 INFO - Running setup.py (path:/tmp/pip-bMtI7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:44 INFO - Running setup.py (path:/tmp/pip-fYbV0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:44 INFO - Running setup.py (path:/tmp/pip-XausDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:44 INFO - Running setup.py (path:/tmp/pip-WPel26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:44 INFO - Running setup.py (path:/tmp/pip-kX5c9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:44 INFO - Running setup.py (path:/tmp/pip-q0MxiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:44 INFO - Running setup.py (path:/tmp/pip-K6N7U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:44 INFO - Running setup.py (path:/tmp/pip-wn6FM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:44 INFO - Running setup.py (path:/tmp/pip-2A9Qhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:44 INFO - Running setup.py (path:/tmp/pip-Eqkmsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:44 INFO - Running setup.py install for manifestparser 08:49:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:44 INFO - Running setup.py install for mozcrash 08:49:44 INFO - Running setup.py install for mozdebug 08:49:45 INFO - Running setup.py install for mozdevice 08:49:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for mozfile 08:49:45 INFO - Running setup.py install for mozhttpd 08:49:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for mozinfo 08:49:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for mozInstall 08:49:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for mozleak 08:49:45 INFO - Running setup.py install for mozlog 08:49:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for moznetwork 08:49:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:45 INFO - Running setup.py install for mozprocess 08:49:46 INFO - Running setup.py install for mozprofile 08:49:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Running setup.py install for mozrunner 08:49:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Running setup.py install for mozscreenshot 08:49:46 INFO - Running setup.py install for moztest 08:49:46 INFO - Running setup.py install for mozversion 08:49:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:46 INFO - Cleaning up... 08:49:46 INFO - Return code: 0 08:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:46 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:46 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 08:49:46 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 08:49:46 INFO - Using env: {'DISPLAY': ':0', 08:49:46 INFO - 'HOME': '/home/cltbld', 08:49:46 INFO - 'LANG': 'en_US.UTF-8', 08:49:46 INFO - 'LANGUAGE': 'en_US:en', 08:49:46 INFO - 'LOGNAME': 'cltbld', 08:49:46 INFO - 'MAIL': '/var/mail/cltbld', 08:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:46 INFO - 'MOZ_NO_REMOTE': '1', 08:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:46 INFO - 'NO_EM_RESTART': '1', 08:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:46 INFO - 'PWD': '/builds/slave/test', 08:49:46 INFO - 'SHELL': '/bin/bash', 08:49:46 INFO - 'SHLVL': '1', 08:49:46 INFO - 'TERM': 'linux', 08:49:46 INFO - 'TMOUT': '86400', 08:49:46 INFO - 'USER': 'cltbld', 08:49:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:46 INFO - '_': '/tools/buildbot/bin/python'} 08:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:46 INFO - Running setup.py (path:/tmp/pip-N6aV4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:46 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)) 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:46 INFO - Running setup.py (path:/tmp/pip-X5vlHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:46 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)) 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:46 INFO - Running setup.py (path:/tmp/pip-Sn6Hvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:46 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)) 08:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:47 INFO - Running setup.py (path:/tmp/pip-q_p025-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:47 INFO - Running setup.py (path:/tmp/pip-NSstGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:47 INFO - Running setup.py (path:/tmp/pip-Nsjlix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:47 INFO - Running setup.py (path:/tmp/pip-zykhgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:47 INFO - Running setup.py (path:/tmp/pip-HTvAdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:47 INFO - Running setup.py (path:/tmp/pip-Izw3wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:47 INFO - Running setup.py (path:/tmp/pip-fakU0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:47 INFO - Running setup.py (path:/tmp/pip-2LeyTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:47 INFO - Running setup.py (path:/tmp/pip-RtBC9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:47 INFO - Running setup.py (path:/tmp/pip-v3EB5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:47 INFO - Running setup.py (path:/tmp/pip-zMrzNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:47 INFO - Running setup.py (path:/tmp/pip-4Gc_5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:47 INFO - Running setup.py (path:/tmp/pip-FUZuyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:47 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)) 08:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:47 INFO - Running setup.py (path:/tmp/pip-DhfU2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:48 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)) 08:49:48 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)) 08:49:48 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)) 08:49:48 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)) 08:49:48 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)) 08:49:48 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)) 08:49:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:49 INFO - Downloading blessings-1.6.tar.gz 08:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:49 INFO - Installing collected packages: blessings 08:49:49 INFO - Running setup.py install for blessings 08:49:50 INFO - Successfully installed blessings 08:49:50 INFO - Cleaning up... 08:49:50 INFO - Return code: 0 08:49:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:50 INFO - Reading from file tmpfile_stdout 08:49:50 INFO - Current package versions: 08:49:50 INFO - argparse == 1.2.1 08:49:50 INFO - blessings == 1.6 08:49:50 INFO - blobuploader == 1.2.4 08:49:50 INFO - docopt == 0.6.1 08:49:50 INFO - manifestparser == 1.1 08:49:50 INFO - mozInstall == 1.12 08:49:50 INFO - mozcrash == 0.17 08:49:50 INFO - mozdebug == 0.1 08:49:50 INFO - mozdevice == 0.48 08:49:50 INFO - mozfile == 1.2 08:49:50 INFO - mozhttpd == 0.7 08:49:50 INFO - mozinfo == 0.9 08:49:50 INFO - mozleak == 0.1 08:49:50 INFO - mozlog == 3.1 08:49:50 INFO - moznetwork == 0.27 08:49:50 INFO - mozprocess == 0.22 08:49:50 INFO - mozprofile == 0.28 08:49:50 INFO - mozrunner == 6.11 08:49:50 INFO - mozscreenshot == 0.1 08:49:50 INFO - mozsystemmonitor == 0.0 08:49:50 INFO - moztest == 0.7 08:49:50 INFO - mozversion == 1.4 08:49:50 INFO - psutil == 3.1.1 08:49:50 INFO - requests == 1.2.3 08:49:50 INFO - wsgiref == 0.1.2 08:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:50 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:50 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 08:49:50 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 08:49:50 INFO - Using env: {'DISPLAY': ':0', 08:49:50 INFO - 'HOME': '/home/cltbld', 08:49:50 INFO - 'LANG': 'en_US.UTF-8', 08:49:50 INFO - 'LANGUAGE': 'en_US:en', 08:49:50 INFO - 'LOGNAME': 'cltbld', 08:49:50 INFO - 'MAIL': '/var/mail/cltbld', 08:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:50 INFO - 'MOZ_NO_REMOTE': '1', 08:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:50 INFO - 'NO_EM_RESTART': '1', 08:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:50 INFO - 'PWD': '/builds/slave/test', 08:49:50 INFO - 'SHELL': '/bin/bash', 08:49:50 INFO - 'SHLVL': '1', 08:49:50 INFO - 'TERM': 'linux', 08:49:50 INFO - 'TMOUT': '86400', 08:49:50 INFO - 'USER': 'cltbld', 08:49:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:50 INFO - '_': '/tools/buildbot/bin/python'} 08:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 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)) 08:49:50 INFO - Cleaning up... 08:49:50 INFO - Return code: 0 08:49:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49: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', 'jsonschema'] in /builds/slave/test/build 08:49: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 jsonschema 08:49:50 INFO - Using env: {'DISPLAY': ':0', 08:49:50 INFO - 'HOME': '/home/cltbld', 08:49:50 INFO - 'LANG': 'en_US.UTF-8', 08:49:50 INFO - 'LANGUAGE': 'en_US:en', 08:49:50 INFO - 'LOGNAME': 'cltbld', 08:49:50 INFO - 'MAIL': '/var/mail/cltbld', 08:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:50 INFO - 'MOZ_NO_REMOTE': '1', 08:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:50 INFO - 'NO_EM_RESTART': '1', 08:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:50 INFO - 'PWD': '/builds/slave/test', 08:49:50 INFO - 'SHELL': '/bin/bash', 08:49:50 INFO - 'SHLVL': '1', 08:49:50 INFO - 'TERM': 'linux', 08:49:50 INFO - 'TMOUT': '86400', 08:49:50 INFO - 'USER': 'cltbld', 08:49:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:50 INFO - '_': '/tools/buildbot/bin/python'} 08:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:50 INFO - Downloading/unpacking jsonschema 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:52 INFO - Downloading/unpacking functools32 (from jsonschema) 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:52 INFO - warning: no files found matching '*.txt' 08:49:52 INFO - no previously-included directories found matching 'build' 08:49:52 INFO - no previously-included directories found matching 'dist' 08:49:52 INFO - no previously-included directories found matching '.git*' 08:49:52 INFO - Installing collected packages: jsonschema, functools32 08:49:52 INFO - Running setup.py install for functools32 08:49:53 INFO - warning: no files found matching '*.txt' 08:49:53 INFO - no previously-included directories found matching 'build' 08:49:53 INFO - no previously-included directories found matching 'dist' 08:49:53 INFO - no previously-included directories found matching '.git*' 08:49:53 INFO - Successfully installed jsonschema functools32 08:49:53 INFO - Cleaning up... 08:49:53 INFO - Return code: 0 08:49:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:49:53 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')]} 08:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 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')]} 08:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:53 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 0x7f3dfbdbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29645a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, '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': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', '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 08:49:53 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 08:49:53 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 08:49:53 INFO - Using env: {'DISPLAY': ':0', 08:49:53 INFO - 'HOME': '/home/cltbld', 08:49:53 INFO - 'LANG': 'en_US.UTF-8', 08:49:53 INFO - 'LANGUAGE': 'en_US:en', 08:49:53 INFO - 'LOGNAME': 'cltbld', 08:49:53 INFO - 'MAIL': '/var/mail/cltbld', 08:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:53 INFO - 'MOZ_NO_REMOTE': '1', 08:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:53 INFO - 'NO_EM_RESTART': '1', 08:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:53 INFO - 'PWD': '/builds/slave/test', 08:49:53 INFO - 'SHELL': '/bin/bash', 08:49:53 INFO - 'SHLVL': '1', 08:49:53 INFO - 'TERM': 'linux', 08:49:53 INFO - 'TMOUT': '86400', 08:49:53 INFO - 'USER': 'cltbld', 08:49:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:53 INFO - '_': '/tools/buildbot/bin/python'} 08:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:53 INFO - Downloading/unpacking flake8 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49: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 08:49:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:49:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:49:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 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 08:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:55 INFO - no previously-included directories found matching 'docs/_build' 08:49:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:49:56 INFO - Running setup.py install for pep8 08:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:56 INFO - no previously-included directories found matching 'docs/_build' 08:49:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:49:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:49:56 INFO - Cleaning up... 08:49:56 INFO - Return code: 0 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - Running post-action listener: _start_resource_monitoring 08:49:56 INFO - Starting resource monitoring. 08:49:56 INFO - ##### 08:49:56 INFO - ##### Running install step. 08:49:56 INFO - ##### 08:49:56 INFO - Running pre-action listener: _resource_record_pre_action 08:49:56 INFO - Running main action method: install 08:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:56 INFO - Reading from file tmpfile_stdout 08:49:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:56 INFO - Reading from file tmpfile_stdout 08:49:56 INFO - Output received: 08:49:56 INFO - Usage: mozinstall [options] installer 08:49:56 INFO - Options: 08:49:56 INFO - -h, --help show this help message and exit 08:49:56 INFO - -d DEST, --destination=DEST 08:49:56 INFO - Directory to install application into. [default: 08:49:56 INFO - "/builds/slave/test"] 08:49:56 INFO - --app=APP Application being installed. [default: firefox] 08:49:56 INFO - mkdir: /builds/slave/test/build/application 08:49:56 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'] 08:49:56 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 08:50:12 INFO - Reading from file tmpfile_stdout 08:50:12 INFO - Output received: 08:50:12 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:12 INFO - Running post-action listener: _resource_record_post_action 08:50:12 INFO - ##### 08:50:12 INFO - ##### Running run-tests step. 08:50:12 INFO - ##### 08:50:12 INFO - Running pre-action listener: _resource_record_pre_action 08:50:12 INFO - Running main action method: run_tests 08:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:12 INFO - Python 2.7.3 08:50:12 INFO - Return code: 0 08:50:12 INFO - grabbing minidump binary from tooltool 08:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:12 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 0x29f3410>, '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 0x29f4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:12 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 08:50:12 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 08:50:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:12 INFO - Return code: 0 08:50:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:50:13 INFO - Return code: 0 08:50:13 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/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:50:13 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/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 08:50:13 INFO - Using env: {'DISPLAY': ':0', 08:50:13 INFO - 'HOME': '/home/cltbld', 08:50:13 INFO - 'LANG': 'en_US.UTF-8', 08:50:13 INFO - 'LANGUAGE': 'en_US:en', 08:50:13 INFO - 'LOGNAME': 'cltbld', 08:50:13 INFO - 'MAIL': '/var/mail/cltbld', 08:50:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:13 INFO - 'MOZ_NO_REMOTE': '1', 08:50:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:13 INFO - 'NO_EM_RESTART': '1', 08:50:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:13 INFO - 'PWD': '/builds/slave/test', 08:50:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:13 INFO - 'SHELL': '/bin/bash', 08:50:13 INFO - 'SHLVL': '1', 08:50:13 INFO - 'TERM': 'linux', 08:50:13 INFO - 'TMOUT': '86400', 08:50:13 INFO - 'USER': 'cltbld', 08:50:13 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1460994210.358839-572105167', 08:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:13 INFO - '_': '/tools/buildbot/bin/python'} 08:50:13 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/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 08:50:13 INFO - mozversion application_buildid: 20160418075623 08:50:13 INFO - mozversion application_changeset: 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 08:50:13 INFO - mozversion application_display_name: Nightly 08:50:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:13 INFO - mozversion application_name: Firefox 08:50:13 INFO - mozversion application_remotingname: firefox 08:50:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:50:13 INFO - mozversion application_vendor: Mozilla 08:50:13 INFO - mozversion application_version: 48.0a1 08:50:13 INFO - mozversion platform_buildid: 20160418075623 08:50:13 INFO - mozversion platform_changeset: 7dd5ac3bed0c5193dc2b76bbc3816bc320dcb1d4 08:50:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:50:13 INFO - mozversion platform_version: 48.0a1 08:50:13 INFO - using testdate: 1460994613 08:50:13 INFO - actual date: 1460994613 08:50:13 INFO - starting webserver on 'localhost:33209' 08:50:13 INFO - SUITE-START | Running 2 tests 08:50:13 INFO - TEST-START | dromaeo_css 08:50:13 INFO - operating with platform_type : linux_ 08:50:13 INFO - Initialising browser for dromaeo_css test... 08:50:13 INFO - TEST-INFO | started process 28904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVMnSK/profile http://localhost:33209/getInfo.html) 08:50:17 INFO - PROCESS | 28904 | 08:50:17 INFO - PROCESS | 28904 | (process:28971): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:50:18 INFO - PROCESS | 28904 | __metrics Screen width/height:1600/1200 08:50:18 INFO - PROCESS | 28904 | colorDepth:24 08:50:18 INFO - PROCESS | 28904 | Browser inner width/height: 1024/697 08:50:18 INFO - PROCESS | 28904 | __metrics 08:50:19 ERROR - PROCESS | 28904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:50:20 INFO - TEST-INFO | 28904: exit 0 08:50:20 INFO - Browser initialized. 08:50:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:20 INFO - TEST-INFO | started process 29022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVMnSK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:22 INFO - PROCESS | 29022 | 08:50:22 INFO - PROCESS | 29022 | (process:29080): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:50:32 INFO - PROCESS | 29022 | RSS: Main: 164749312 08:50:32 INFO - PROCESS | 29022 | 08:51:21 INFO - PROCESS | 29022 | 1460994681788 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] 08:53:33 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33209/tests/dromaeo/cssquery-ext.html) 08:53:34 INFO - PROCESS | 29022 | RSS: Main: 169676800 08:53:34 INFO - PROCESS | 29022 | 08:56:36 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-ext.html (next: http://localhost:33209/tests/dromaeo/cssquery-jquery.html) 08:56:37 INFO - PROCESS | 29022 | RSS: Main: 165306368 08:56:37 INFO - PROCESS | 29022 | 08:59:38 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33209/tests/dromaeo/cssquery-mootools.html) 08:59:39 INFO - PROCESS | 29022 | RSS: Main: 166617088 08:59:39 INFO - PROCESS | 29022 | 09:02:41 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33209/tests/dromaeo/cssquery-prototype.html) 09:02:42 INFO - PROCESS | 29022 | RSS: Main: 164237312 09:02:42 INFO - PROCESS | 29022 | 09:05:44 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33209/tests/dromaeo/cssquery-yui.html) 09:05:45 INFO - PROCESS | 29022 | RSS: Main: 165330944 09:05:45 INFO - PROCESS | 29022 | 09:08:47 INFO - PROCESS | 29022 | Cycle 1(1): loaded http://localhost:33209/tests/dromaeo/cssquery-yui.html (next: http://localhost:33209/tests/dromaeo/cssquery-dojo.html) 09:08:48 INFO - PROCESS | 29022 | RSS: Main: 167567360 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | __start_tp_report 09:08:48 INFO - PROCESS | 29022 | _x_x_mozilla_page_load 09:08:48 INFO - PROCESS | 29022 | _x_x_mozilla_page_load_details 09:08:48 INFO - PROCESS | 29022 | |i|pagename|runs| 09:08:48 INFO - PROCESS | 29022 | |0;dojo.html;2616.2020583721965;2685.6777186737595;2723.605077263797;2728.6043523689077;2733.412316351984;4617.122746678133;4721.622270218383;4728.3380326754195;4741.051789642068;4750.406199225097;4636.86089417318;4695.976520117395;4767.11808315461;4812.927806082903;4825.855224343267;4273.188094262088;4397.758123303217;4408.140412619525;4425.513193548707;4443.622292105175;611.7590214972901;4062.9191562004635;4226.175895700339;4317.589828966243;4331.5884990925815;4298.161858437606;4311.956880431187;4319.76241306728;4324.6972711910175;4342.240107981091;4310.073334233123;4321.200577893069;4327.956720432787;4359.520452750195;4362.716423432498;4298.355246712987;4355.150745604608;4365.2142614329405;4385.912281754347;4409.140217657558;4696.060787842411;4717.410323709536;4723.031778485402;4723.078999595046;4724.952750472486;4958.7024778513405;5031.823886163967;5132.692038477666;5152.433232344439;5158.9484105158845;5012.624053195988;5016.3980322361185;5026.723530205837;5028.120078986163;5063.822766203165;4677.7661116944355;4679.859604211879;4684.882877928045;4691.882702932454;4724.83463078794;5082.923756143661;5134.306868572769;5164.535191832678;5197.194434862602;5238.057149713089;5029.321041659329;5055.721935293521;5061.9493805061475;5067.5185857343495;5069;5138.537531622172;5148.407933087743;5150.201718733602;5157.8452646420665;5167.896642067213;4905.48492408292;5069.188929771219;5080.669756465818;5155.175171972466;5168.819091331786;4976.751162441863;4982.227754698028;4991.425986011655;5002.89994200114;5023.522765337287;4259.829606815692;4275.541548649587;4276.31578947367;4295.355696645528;4309.762963037063;3652.2695460907926;3665.560132784083;3744.43833424983;3792.393217085253;3856.151646637791;4371.715838470489;4379.321205213197;4419.690621656453;4425.645948324126;4469.7988590513505;5124.5131712487255;5125.69245845243;5125.820596279113;5127;5147.485251474823;4236.279832428495;4386.956130438654;4425.845095421645;4451.10977804434;4482.8206871725415;4599.218132917345;4612.76936153191;4614.100250451197;4617.8383756568355;4657.417822772153;4772.570468657837;4814.927776083291;4817.542333478314;4820.566149046603;4866.5376789204265;4957;5120.846374608767;5188.118019936695;5204.713740744295;5220.425753167073;4778.092162489116;4788.162071637519;4788.497207793271;4818.855434336975;4823.541763532458;4921.507849215193;5034.697918124924;5037.546620804145;5042.571381432619;5080.1363768160245;5076.847694569169;5097.0315640028275;5109.489051094861;5113.15632920564;5182.97408512955;4971.304017437489;4992.825251116194;4995.47547507521;5001.374828146481;5042.966191930719;4814.350062741625;4959.156943319572;4977.377827771528;4982.202847544376;5009.0482808266315;4773.451053128934;4824;4862.5380588844;4883.462819089827;4914.803407863646;4967.254911763264;4968.850934471971;4977.328060711758;4982.925256121233;5036.219385995177;4824;4855.611551075976;4893.853184404474;4907.656464047483;4967.279744437109 09:08:48 INFO - PROCESS | 29022 | |1;ext.html;561.8417446458633;581.9388964158763;589.9085641725532;601.5247954116248;638.6774678787211;32976.17559561012;33966.66033339669;34100.48849267263;34160;34266.8286658567;37531.249375012485;37934;38026.61973380272;38102;38112;7570.545767253955;7724.806879827993;7733.072031356245;7735.883961740578;7743.148253692089;7600.505967112148;7725.18885517021;7731.729389471369;7764.961175194145;7765.301122898938;7765.339946104559;7794.298513133816;7807.219278072176;7828.960855195744;7830.765077047669;7712.498687585317;7732.2267773223075;7776.611169441505;7779.8833017504785;7783.910252564646;7634.236576342377;7704.036995375578;7725.8454830903065;7731.149573546905;7736.187700291501;29392.41215175706;34965.82517087424;35233.64766352355;35375.64624353775;35510.64489355099;2782;3052.8168309901475;3467.4706600553263;3749.0252534340993;3753.1930634913624;25458.108966186093;25954;26006.479870402676;26401.47197056048;27132.45735085307;3110.5178697301953;3115.8346837934787;3136.4354416205074;3165.271987442901;3200.199950012497;167863;168922;169214;170060.1496992507;207989;33307.666923330944;34335.484967725504;34448.48327275093;49534.50465495371;50006;31216.21959451032;31524.842375788434;31573;31672.208194794854;31712.524312135338;11904.285742855456;12188.329641869783;12204.816927746091;12235.32705701195;12251.938740306241;9068.727938161734;9150.40522366044;9227;9243.815123697623;9375;8228.711995080144;8263.049749278789;8283.62723677436;8327;8334.16658334174;3167.0973772474736;3265.3142840003866;3305.4215512285737;3314.3537010283244;3340.8329583520726;933.7712260496222;950.1401231885155;952.1050212799946;991.5141580625586;1023.948802559869;27207.863960680465;28363.57454638182;28444.71555284462;28792.42415151685;28886.422271554453;990.1039559198937;991.6925753016588;1020.6835880876804;1025.5487585462372;1039.5841663334575;14514.782278265835;15043.548693538993;15049.54851354461;15174.165420901736;15284.388624454898;334805;338374;341269;342262;343056;47666.76166619144;48013.75993120012;48181;48219;48238;1167.270455965022;1179.3159967218992;1203.8194270859442;1214.2714371377103;1237.4864431260926;26543.86728066347;27938.86030569834;28060;28183.71816281811;28213.71786282193;42378.576214237466;42918.57081429146;43227.78386108049;43281.78359108185;43442.348364775185;302063;302208;303071;305309;305933;25187.87406062958;25225;25520.48959020772;25747.6137857936;25852.482950340513;41072.38391424191;41103.38344924888;41510.377344340464;41546;42014.36978445265;35085.64914350926;36519.81740091283;36566;36678.26643467062;37301.6269837309;35314.64685353216;35606.287874241854;35642.28715425625;36035.63964360428;36242.8187859059;35648.465273021444;36106.27787444289;36222.63777362193;36279.63720362762;36521;28412.57381139326;29406.70593294125;29629;29821.850890746275;30661.4052068594;24636.630450542896;25116.874415627804;25218.369540760894;25238.74761252364;25484.23547293584 09:08:48 INFO - PROCESS | 29022 | |2;jquery.html;375.40498310178384;380.72968192583267;389.0720631294363;395.59649157858985;398.55561049429895;16044.05031471636;17276.308947642112;17648.82351176488;17953.833000854935;18004.279828806866;16603.750943735853;16994.405195818148;17230.56923576911;17318.56703582408;17428.651426971453;5001.224810154423;5174.146265866128;5177.844664660066;5211.895762084756;5231.032259032091;3733.645303696158;5683.744231509592;5937.88124237515;6014.75940962361;6014.789482368118;5000.399952005764;5923.378045305246;5943.851403714899;5960.165576819249;5965.88068238635;5190.948090519122;5212.8957420851375;5222.190560463135;5245.554127899133;5268.631195816294;5017.698938063728;5183.688978661255;5401.810936617199;5443.455654434564;5457.045017122027;12067.336296503689;12289.877101229053;12328.753424931541;12389.752204955941;12587.433565489575;1869.2522990803786;1900.3253844885005;1903.5050886769402;1949.8732582382243;2082.6043051820106;8673.13268673134;8725.127487251224;9022;9084.954575227148;9102.953160386574;1708.1032457959545;1761.9119044047745;1778.084286592406;1790.2838864454193;1811.0401487211798;68896.6555167221;71303.64348178278;71454.64272678655;72384;72535;9800.068993445753;9901.05939935705;10012.849807252896;10060.849087263698;10089.344192627455;13635.727285454434;13649.11280766747;13667.794983075262;13706.725865482835;13752.793708094387;6876.724931002704;6897.55165914214;6929.480288978246;7066.893996590055;7152.105986751656;6559.737610495622;6580.341965803477;6605.471562275006;6663.766768163188;6680;4233.78831058452;4239.27932251518;4329.826806927687;4515.193656241663;4516.525764794715;1676.8658507319385;1775.946721598354;1871.391797665764;1898.7531620889472;1920.0975541495475;864.7881269089113;865.5326123893027;883.2183517586982;929.5212965322864;1019.108280254777;15523.844761552466;15885.682286354207;15931.920340398225;16692.332306707594;16874.493765187064;859.1365677494078;883.6156272021691;891.38494438837;960.1934375124929;962.8940816510178;9044.592993315317;9123.044262922593;9284.860727089099;9296.95351523238;9399.906000939904;426381;436508;437417;440027;442069;77378;80978.19021809706;82910.17089829146;83243.58378208191;84298.57850710707;949.482532020037;956.1776871890169;964.6671898195111;970.335320305593;972.1202311907734;14893.957422980287;14907.403703851724;14912.328945197709;14938.402463901757;14954.775678365051;32818;33823.15442113967;34560.65439345574;34723.9582812516;34922.82538587291;45157.77421112874;46521.302180467996;47881;48280.517194827604;48836.511634883194;6762.256151823394;7123.608201548965;7384.150822655463;7698.345640620386;7900.920990790019;7748.535087894519;9875.358101723365;11245.100391968786;11270.718232044264;11427.942860285646;10267.229957753048;10298.948505257425;10308.587656493955;10465.895341046493;10682.679519614425;4758.286257061469;8754.47473151613;10006.399616023062;10481.536838842714;10513.369197848153;10511.632092876713;10533.736656583647;10550.683479495627;10739.570417183226;10777.461126943464;7856.175101614248;7877.094134174643;7929;7940.761777146695;8000;9543.28425368114;10581.841272381074;10636.468176591294;10746.355218686904;10755.89244107549 09:08:48 INFO - PROCESS | 29022 | |3;mootools.html;1426.7859821026846;1484.4655923867408;1577.3059853664388;1747.2050217151198;1755.245244544846;6621.9006714899315;7660.463767536267;7763.378929685626;7898;7898.526088434698;7723.536587804736;7757.7672669819995;7822.217778222175;7843.372530197585;7875.80310492238;2179.8038176564105;2184.770599087097;2201.042546492273;2206.8344874134423;2207.0730293276783;2154.375231182955;2181.4764456530397;2198.9450263743374;2207.293666026872;2213.6458166693333;2205.128974055247;2217.345882964529;2221.455743342883;2232.6316157834017;2246.8988895499742;2167.7507086684996;2170.934871953844;2176.0316659086634;2185.846990710651;2193.5941850757663;2130.052126803573;2171.815395691368;2173.261091228974;2181.967270490944;2182.9235976740897;7832.921670783333;7981.680732770682;8002.679892804281;8010.759677209693;8026.518408895485;4782.665213435061;4891.070696567676;4891.388576427947;4900.289458028602;4947.431045429749;2793.7345952134515;2811.9718802811913;2863.842488663123;2876.5972763813083;2977.5533669949464;815.6003558256471;848.9320854331638;851.1701091435863;1725.8619310455133;1791.2118667786262;10618.150547956222;10733.087687546567;10745.14038876888;10747.838782418348;10800.081993030602;4103.281925662997;4133.318002529549;4313.50394704613;4319.43847299849;4339.761313127745;8566.057733649293;8651.567421628893;8666.78333041679;8670.349723770742;8673.132686731402;4779.569838714463;4806.975965120152;4808.3989501312335;4808.447028591687;4816.783244753994;3829.1384438501113;4211.4525111735275;4347.043650396908;4433.8226470941445;4440.4671439427475;3460.186856088817;3579.785212887183;3592.7844329340323;3626.655467730561;3686.7972261525874;979.3927764785736;986.7286496213599;986.753311672082;996.6710985374809;1081.7890511350367;831.1314676163423;845.5603086395163;878.9428687135444;885.3094586222757;893.071205945822;5395.676259424447;5451.836444906659;5526.58550608706;5591.133374326986;5803.622764520293;405.84577860412855;410.58530883806975;411.08123344325406;416.58965918570186;428.036916936892;3912.4522566840665;3973.304671682444;3990.102226998902;4010.2781499329817;4065.918681626351;9427.19868811145;9737.610495580238;9741.951290243504;9749.65876194344;9808.36245644045;9326.533673316308;9650.662226822027;9676.322657413913;9707.126358627758;9716.465594392377;7166.068411106627;7213.927860721431;7288.271172882669;7401.666924988388;7409.8147546311775;5555.555555555627;5680.857978550569;5685.431456854281;5731.054376027909;5834.620749651259;9004.279657627505;9030.232430243503;9088.182063614306;9094.909050909406;9162.633494660138;8627.654893804429;8937.821243575223;8965.731028069169;8988.505632190292;9018.053104423941;6066.696665166813;6702.396784289437;6847.657617119224;6914.5159838812815;6993.860122797617;7551.093868735787;7631.1605723371495;7634.312911837961;7647.808804779925;7653.732119375795;6654.833629159116;6945.201301850352;6952.930470695228;6993.720251190099;7056.576605403487;6900.585964842126;6910.412614927787;6926.619035953071;6945.062416573698;6991.965040174767;6276.152719382825;6314.747410103728;6333.619982801047;6432.614043157426;6435.678216089271;4797.136515427117;4802.951970480391;4856.174450343521;4874.366332376769;4888.780004899717;4868.732219727807;4914.262860570943;4942.135126352946;4947.82682606107;5017.272495488207 09:08:48 INFO - PROCESS | 29022 | |4;prototype.html;314.07974634321437;314.71203848478643;317.2228041298817;317.3716042236372;319.88644031368875;5312.804618960737;5348.893022139559;5399.865003374917;5400.594955378343;5405.324334458192;5303.867403314909;5309.548688361494;5331.173668081444;5332.093544097503;5337.919931201025;3941.980290098553;3959.742616729903;4137.1518838638;4141.0744004038115;4150.211459822639;4120.608542188487;4132.214879172948;4139.482564679415;4141.316682747343;4147.854825081107;4103.651189648868;4110.671146308303;4114.691398145136;4118.629323360897;4132.442120313749;4019.7588144711412;4094.979525102385;4122.876313710593;4122.9381559276635;4140.792960351971;3619.6742293193474;3636.799976001319;3640.9635903640888;3641.217138315275;3654.28741395428;5046.974765126188;5062.0888240116765;5081.789421601578;5092.59259259262;5138.229265610151;4584.220682483986;4746.905061898778;4765.475797662254;4773.9761301193275;4776.689515181537;5577.972110139464;5584.944150558483;5604.41153678866;5611.615063597955;5630.324361076656;3987.1228329767405;3989.8005099744896;3997.360422332413;4000.0999775050673;4011.578784227643;5594.992901277768;5824.563157763142;5870.970645146747;5876.382979787147;5921.328776158766;3978.801059947049;3982.681385489154;3996.440498330236;4007.458993035961;4024.1146947671464;4040;4040.4545386372465;4048.109415928491;4070.8778736637946;4075.3275709508193;4561.270196768501;4645.818763113158;4651.325557794101;4656.813727450932;4663.090697314059;5549;5554.305711786027;5574.554035677136;5594.524465420485;5607.130894711327;1392.3386391463973;1412.3009110490373;1420.8846055846318;1421.665908511499;1423.2741301936087;880.5421180985851;928.3826255540125;940.5720397219249;946.2004606107828;974.9805003899883;4794.496577859274;4797.832075877397;4801.18379875422;4811.4707382187935;4841.8547443576745;5668.149777533403;5717.771289148471;5725.341585717612;5779.162021506858;5783.190353350535;4594.563516465931;4824.975875120672;4837.975810120927;4839.975800120977;4901.975490122527;3084.521899105642;3111.7043880831284;3122.656507784142;3127.1400364899378;3132.37352529495;5368.785248590091;5438.864028399322;5484.122540393518;5485.17722341644;5505.091659876076;5803.158542011384;5933.033483258371;5958.404159584094;5989.490893274034;6026.969865150734;5460.453954604508;5461.426550212171;5463.781448742086;5491.423400542965;5496.5983674163635;5725.141228815544;5846.94153058464;5853.824385268449;5855.677937713296;5879.5002424794375;5728.713564321851;5729.799457018984;5730.312362516358;5740.425957404226;5749.798757043483;5439.809606663748;5444.782208711607;5473.917891231555;5477.424870388551;5486.588505861996;3885.417187421909;3945.3292940199663;3949.1241660212318;3984.32266514699;3999.3601023836045;5801.114637742666;5810.273715785527;5810.593258471867;5832.12518122285;5860.443257890493;5661.433856614306;5665.320161580472;5668.659880407024;5675.744591493475;5681.460261275172;5454.084347354677;5595.412481689526;5621;5631.802886898939;5643.689597072036;5225.764840582106;5508.669479831223;5513.61404701667;5534.1975413565615;5538.363088244742;5503.697296648723;5666.829995100154;5677.290338707661;5702.401247868914;5713.857153571194;5510.504054634942;5549.528290095387;5551.557314781483;5552.583556233218;5569.106503788731 09:08:48 INFO - PROCESS | 29022 | |5;yui.html;652.7715299645125;676.7428377216656;705.0235423937847;753.7776355974987;769.8344855855993;11483.712907177325;11538.942305288472;11752.413424187722;12342.444589993449;12891.935540322309;14033.719325613481;14126.081804682688;14147.575572732809;14160.858391416083;14230.715385692305;817.6565842346214;820.0651257566379;820.4011071917504;824.0688022534528;824.9051359093721;651.4365074210821;805.2390490986021;816.8978877640295;820.3232333325001;835.2858306148247;853.9359548033891;856.1353033436243;859.1923591823697;859.9656013759442;861.9396642235046;845.6786421159982;854.5769843927234;856.2251162697769;857.0272740439615;857.7212405968023;620.045130499031;621.6674079367517;621.726440366242;623.0249659283207;626.2359920896499;12016.218945768585;12094.213876098025;12169.695757606041;12189.695257618541;12203.511859525608;12185.39073046353;12310.507579696801;12323.198992065487;12357.443915023845;12536.749265014649;9750.609975600968;9904.059114384121;9995.300328976975;10060.195184385231;10140.239482038876;3201.8719251229923;3255.039763269841;3263.6083669959758;3280.130765347185;3290.424175769255;46462;46532.7673361631;46864.531354686354;46975;48426.75786621044;9741.220702343795;9792.902070979198;10039.849402258971;10124;10255.128314093236;17078;17145.14274286281;17148.228329725192;17152.31390744381;17255.39606113805;6339.080833279241;6423.421892029646;6456.741730330828;6538.574992625464;6635.900461493082;3782.9243415132096;3845.288621605012;3857.40210267409;3867.2265546890735;3887.1448281378052;2844.9573256401172;2892.334763004521;2910.2433367324224;2912.7524160446173;2922.211003029213;513.5839969624616;516.5557620446413;523.0741587390298;527.1933941070168;536.2760273630568;533.5758072332505;539.2531344088466;569.894569504643;593.4391999560374;629.9401556852092;7377.22539133394;7681.654325555363;7696.923030769621;7786.7663970080985;7800.882986755203;588.3910152991633;594.4768603628779;616.0728104203146;620.252595622274;620.3982137326785;3548.929021419557;3666.871659491905;3680.723945704083;3717.423799311111;3812.6568608825337;50733;50807.745961270695;51429;51520.22719659208;51688.48311516837;43971.12057758827;45006;45358.09283814305;45780.084398312516;46081.76959115183;36754;39548.406773898416;40932.79533602372;41406.1718765623;42185.156296874506;8198.180181981754;8242.876356854533;8264.752057438287;8284.627191776264;8469.407141500036;27170.864145679145;27383.452330953667;27425.86287068552;28080.29799255035;28633;30237;30357.54463683002;34246.828765856015;38893.41659875161;39403;10337.9483102584;10617.734556636145;10671.199660025373;10821.51303191374;10908.727281818017;11913.761724765629;11944.820827687417;12102.75794484123;12371.257724536557;12393.876061239273;11366.768321501202;11731.472083756422;11774.411279435823;12040.21738586989;12198.878011219775;10795.352278863293;11094.057005154329;11504.827427588425;11518.596849110241;11555.42222888869;10676.946615266874;11413.885861141282;11501.597444089417;11538.423078845855;11846.585369512026;8971.049739144264;9390.624375024923;9415.57629906642;9852.507374631097;10029.849552256868;8839.911600883908;9686.564104615169;9942.204623630238;9959.502024898582;9960.651377201762 09:08:48 INFO - PROCESS | 29022 | __end_tp_report 09:08:48 INFO - PROCESS | 29022 | __start_cc_report 09:08:48 INFO - PROCESS | 29022 | _x_x_mozilla_cycle_collect,368 09:08:48 INFO - PROCESS | 29022 | __end_cc_report 09:08:48 INFO - PROCESS | 29022 | __startTimestamp1460995728065__endTimestamp 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | ------- Summary: start ------- 09:08:48 INFO - PROCESS | 29022 | Number of tests: 6 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#0] dojo.html Cycles:165 Average:4672.79 Median:4820.57 stddev:588.32 (12.2%) stddev-sans-first:567.57 09:08:48 INFO - PROCESS | 29022 | Values: 2616.2 2685.7 2723.6 2728.6 2733.4 4617.1 4721.6 4728.3 4741.1 4750.4 4636.9 4696.0 4767.1 4812.9 4825.9 4273.2 4397.8 4408.1 4425.5 4443.6 611.8 4062.9 4226.2 4317.6 4331.6 4298.2 4312.0 4319.8 4324.7 4342.2 4310.1 4321.2 4328.0 4359.5 4362.7 4298.4 4355.2 4365.2 4385.9 4409.1 4696.1 4717.4 4723.0 4723.1 4725.0 4958.7 5031.8 5132.7 5152.4 5158.9 5012.6 5016.4 5026.7 5028.1 5063.8 4677.8 4679.9 4684.9 4691.9 4724.8 5082.9 5134.3 5164.5 5197.2 5238.1 5029.3 5055.7 5061.9 5067.5 5069.0 5138.5 5148.4 5150.2 5157.8 5167.9 4905.5 5069.2 5080.7 5155.2 5168.8 4976.8 4982.2 4991.4 5002.9 5023.5 4259.8 4275.5 4276.3 4295.4 4309.8 3652.3 3665.6 3744.4 3792.4 3856.2 4371.7 4379.3 4419.7 4425.6 4469.8 5124.5 5125.7 5125.8 5127.0 5147.5 4236.3 4387.0 4425.8 4451.1 4482.8 4599.2 4612.8 4614.1 4617.8 4657.4 4772.6 4814.9 4817.5 4820.6 4866.5 4957.0 5120.8 5188.1 5204.7 5220.4 4778.1 4788.2 4788.5 4818.9 4823.5 4921.5 5034.7 5037.5 5042.6 5080.1 5076.8 5097.0 5109.5 5113.2 5183.0 4971.3 4992.8 4995.5 5001.4 5043.0 4814.4 4959.2 4977.4 4982.2 5009.0 4773.5 4824.0 4862.5 4883.5 4914.8 4967.3 4968.9 4977.3 4982.9 5036.2 4824.0 4855.6 4893.9 4907.7 4967.3 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#1] ext.html Cycles:180 Average:41629.60 Median:19216.65 stddev:74454.56 (387.4%) stddev-sans-first:74599.57 09:08:48 INFO - PROCESS | 29022 | Values: 561.8 581.9 589.9 601.5 638.7 32976.2 33966.7 34100.5 34160.0 34266.8 37531.2 37934.0 38026.6 38102.0 38112.0 7570.5 7724.8 7733.1 7735.9 7743.1 7600.5 7725.2 7731.7 7765.0 7765.3 7765.3 7794.3 7807.2 7829.0 7830.8 7712.5 7732.2 7776.6 7779.9 7783.9 7634.2 7704.0 7725.8 7731.1 7736.2 29392.4 34965.8 35233.6 35375.6 35510.6 2782.0 3052.8 3467.5 3749.0 3753.2 25458.1 25954.0 26006.5 26401.5 27132.5 3110.5 3115.8 3136.4 3165.3 3200.2 167863.0 168922.0 169214.0 170060.1 207989.0 33307.7 34335.5 34448.5 49534.5 50006.0 31216.2 31524.8 31573.0 31672.2 31712.5 11904.3 12188.3 12204.8 12235.3 12251.9 9068.7 9150.4 9227.0 9243.8 9375.0 8228.7 8263.0 8283.6 8327.0 8334.2 3167.1 3265.3 3305.4 3314.4 3340.8 933.8 950.1 952.1 991.5 1023.9 27207.9 28363.6 28444.7 28792.4 28886.4 990.1 991.7 1020.7 1025.5 1039.6 14514.8 15043.5 15049.5 15174.2 15284.4 334805.0 338374.0 341269.0 342262.0 343056.0 47666.8 48013.8 48181.0 48219.0 48238.0 1167.3 1179.3 1203.8 1214.3 1237.5 26543.9 27938.9 28060.0 28183.7 28213.7 42378.6 42918.6 43227.8 43281.8 43442.3 302063.0 302208.0 303071.0 305309.0 305933.0 25187.9 25225.0 25520.5 25747.6 25852.5 41072.4 41103.4 41510.4 41546.0 42014.4 35085.6 36519.8 36566.0 36678.3 37301.6 35314.6 35606.3 35642.3 36035.6 36242.8 35648.5 36106.3 36222.6 36279.6 36521.0 28412.6 29406.7 29629.0 29821.9 30661.4 24636.6 25116.9 25218.4 25238.7 25484.2 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#2] jquery.html Cycles:180 Average:25288.97 Median:25518.91 stddev:71945.34 (281.9%) stddev-sans-first:72122.85 09:08:48 INFO - PROCESS | 29022 | Values: 375.4 380.7 389.1 395.6 398.6 16044.1 17276.3 17648.8 17953.8 18004.3 16603.8 16994.4 17230.6 17318.6 17428.7 5001.2 5174.1 5177.8 5211.9 5231.0 3733.6 5683.7 5937.9 6014.8 6014.8 5000.4 5923.4 5943.9 5960.2 5965.9 5190.9 5212.9 5222.2 5245.6 5268.6 5017.7 5183.7 5401.8 5443.5 5457.0 12067.3 12289.9 12328.8 12389.8 12587.4 1869.3 1900.3 1903.5 1949.9 2082.6 8673.1 8725.1 9022.0 9085.0 9103.0 1708.1 1761.9 1778.1 1790.3 1811.0 68896.7 71303.6 71454.6 72384.0 72535.0 9800.1 9901.1 10012.8 10060.8 10089.3 13635.7 13649.1 13667.8 13706.7 13752.8 6876.7 6897.6 6929.5 7066.9 7152.1 6559.7 6580.3 6605.5 6663.8 6680.0 4233.8 4239.3 4329.8 4515.2 4516.5 1676.9 1775.9 1871.4 1898.8 1920.1 864.8 865.5 883.2 929.5 1019.1 15523.8 15885.7 15931.9 16692.3 16874.5 859.1 883.6 891.4 960.2 962.9 9044.6 9123.0 9284.9 9297.0 9399.9 426381.0 436508.0 437417.0 440027.0 442069.0 77378.0 80978.2 82910.2 83243.6 84298.6 949.5 956.2 964.7 970.3 972.1 14894.0 14907.4 14912.3 14938.4 14954.8 32818.0 33823.2 34560.7 34724.0 34922.8 45157.8 46521.3 47881.0 48280.5 48836.5 6762.3 7123.6 7384.2 7698.3 7900.9 7748.5 9875.4 11245.1 11270.7 11427.9 10267.2 10298.9 10308.6 10465.9 10682.7 4758.3 8754.5 10006.4 10481.5 10513.4 10511.6 10533.7 10550.7 10739.6 10777.5 7856.2 7877.1 7929.0 7940.8 8000.0 9543.3 10581.8 10636.5 10746.4 10755.9 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#3] mootools.html Cycles:180 Average:5209.95 Median:5541.07 stddev:2881.18 (52.0%) stddev-sans-first:2875.24 09:08:48 INFO - PROCESS | 29022 | Values: 1426.8 1484.5 1577.3 1747.2 1755.2 6621.9 7660.5 7763.4 7898.0 7898.5 7723.5 7757.8 7822.2 7843.4 7875.8 2179.8 2184.8 2201.0 2206.8 2207.1 2154.4 2181.5 2198.9 2207.3 2213.6 2205.1 2217.3 2221.5 2232.6 2246.9 2167.8 2170.9 2176.0 2185.8 2193.6 2130.1 2171.8 2173.3 2182.0 2182.9 7832.9 7981.7 8002.7 8010.8 8026.5 4782.7 4891.1 4891.4 4900.3 4947.4 2793.7 2812.0 2863.8 2876.6 2977.6 815.6 848.9 851.2 1725.9 1791.2 10618.2 10733.1 10745.1 10747.8 10800.1 4103.3 4133.3 4313.5 4319.4 4339.8 8566.1 8651.6 8666.8 8670.3 8673.1 4779.6 4807.0 4808.4 4808.4 4816.8 3829.1 4211.5 4347.0 4433.8 4440.5 3460.2 3579.8 3592.8 3626.7 3686.8 979.4 986.7 986.8 996.7 1081.8 831.1 845.6 878.9 885.3 893.1 5395.7 5451.8 5526.6 5591.1 5803.6 405.8 410.6 411.1 416.6 428.0 3912.5 3973.3 3990.1 4010.3 4065.9 9427.2 9737.6 9742.0 9749.7 9808.4 9326.5 9650.7 9676.3 9707.1 9716.5 7166.1 7213.9 7288.3 7401.7 7409.8 5555.6 5680.9 5685.4 5731.1 5834.6 9004.3 9030.2 9088.2 9094.9 9162.6 8627.7 8937.8 8965.7 8988.5 9018.1 6066.7 6702.4 6847.7 6914.5 6993.9 7551.1 7631.2 7634.3 7647.8 7653.7 6654.8 6945.2 6952.9 6993.7 7056.6 6900.6 6910.4 6926.6 6945.1 6992.0 6276.2 6314.7 6333.6 6432.6 6435.7 4797.1 4803.0 4856.2 4874.4 4888.8 4868.7 4914.3 4942.1 4947.8 5017.3 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#4] prototype.html Cycles:180 Average:4638.27 Median:5335.01 stddev:1367.38 (25.6%) stddev-sans-first:1332.14 09:08:48 INFO - PROCESS | 29022 | Values: 314.1 314.7 317.2 317.4 319.9 5312.8 5348.9 5399.9 5400.6 5405.3 5303.9 5309.5 5331.2 5332.1 5337.9 3942.0 3959.7 4137.2 4141.1 4150.2 4120.6 4132.2 4139.5 4141.3 4147.9 4103.7 4110.7 4114.7 4118.6 4132.4 4019.8 4095.0 4122.9 4122.9 4140.8 3619.7 3636.8 3641.0 3641.2 3654.3 5047.0 5062.1 5081.8 5092.6 5138.2 4584.2 4746.9 4765.5 4774.0 4776.7 5578.0 5584.9 5604.4 5611.6 5630.3 3987.1 3989.8 3997.4 4000.1 4011.6 5595.0 5824.6 5871.0 5876.4 5921.3 3978.8 3982.7 3996.4 4007.5 4024.1 4040.0 4040.5 4048.1 4070.9 4075.3 4561.3 4645.8 4651.3 4656.8 4663.1 5549.0 5554.3 5574.6 5594.5 5607.1 1392.3 1412.3 1420.9 1421.7 1423.3 880.5 928.4 940.6 946.2 975.0 4794.5 4797.8 4801.2 4811.5 4841.9 5668.1 5717.8 5725.3 5779.2 5783.2 4594.6 4825.0 4838.0 4840.0 4902.0 3084.5 3111.7 3122.7 3127.1 3132.4 5368.8 5438.9 5484.1 5485.2 5505.1 5803.2 5933.0 5958.4 5989.5 6027.0 5460.5 5461.4 5463.8 5491.4 5496.6 5725.1 5846.9 5853.8 5855.7 5879.5 5728.7 5729.8 5730.3 5740.4 5749.8 5439.8 5444.8 5473.9 5477.4 5486.6 3885.4 3945.3 3949.1 3984.3 3999.4 5801.1 5810.3 5810.6 5832.1 5860.4 5661.4 5665.3 5668.7 5675.7 5681.5 5454.1 5595.4 5621.0 5631.8 5643.7 5225.8 5508.7 5513.6 5534.2 5538.4 5503.7 5666.8 5677.3 5702.4 5713.9 5510.5 5549.5 5551.6 5552.6 5569.1 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - PROCESS | 29022 | [#5] yui.html Cycles:180 Average:12578.28 Median:43078.14 stddev:13978.70 (32.4%) stddev-sans-first:13989.22 09:08:48 INFO - PROCESS | 29022 | Values: 652.8 676.7 705.0 753.8 769.8 11483.7 11538.9 11752.4 12342.4 12891.9 14033.7 14126.1 14147.6 14160.9 14230.7 817.7 820.1 820.4 824.1 824.9 651.4 805.2 816.9 820.3 835.3 853.9 856.1 859.2 860.0 861.9 845.7 854.6 856.2 857.0 857.7 620.0 621.7 621.7 623.0 626.2 12016.2 12094.2 12169.7 12189.7 12203.5 12185.4 12310.5 12323.2 12357.4 12536.7 9750.6 9904.1 9995.3 10060.2 10140.2 3201.9 3255.0 3263.6 3280.1 3290.4 46462.0 46532.8 46864.5 46975.0 48426.8 9741.2 9792.9 10039.8 10124.0 10255.1 17078.0 17145.1 17148.2 17152.3 17255.4 6339.1 6423.4 6456.7 6538.6 6635.9 3782.9 3845.3 3857.4 3867.2 3887.1 2845.0 2892.3 2910.2 2912.8 2922.2 513.6 516.6 523.1 527.2 536.3 533.6 539.3 569.9 593.4 629.9 7377.2 7681.7 7696.9 7786.8 7800.9 588.4 594.5 616.1 620.3 620.4 3548.9 3666.9 3680.7 3717.4 3812.7 50733.0 50807.7 51429.0 51520.2 51688.5 43971.1 45006.0 45358.1 45780.1 46081.8 36754.0 39548.4 40932.8 41406.2 42185.2 8198.2 8242.9 8264.8 8284.6 8469.4 27170.9 27383.5 27425.9 28080.3 28633.0 30237.0 30357.5 34246.8 38893.4 39403.0 10337.9 10617.7 10671.2 10821.5 10908.7 11913.8 11944.8 12102.8 12371.3 12393.9 11366.8 11731.5 11774.4 12040.2 12198.9 10795.4 11094.1 11504.8 11518.6 11555.4 10676.9 11413.9 11501.6 11538.4 11846.6 8971.0 9390.6 9415.6 9852.5 10029.8 8839.9 9686.6 9942.2 9959.5 9960.7 09:08:48 INFO - PROCESS | 29022 | -------- Summary: end -------- 09:08:48 INFO - PROCESS | 29022 | 09:08:48 INFO - TEST-INFO | 29022: exit 0 09:08:48 INFO - TEST-OK | dromaeo_css | took 1115309ms 09:08:48 INFO - TEST-START | kraken 09:08:48 INFO - operating with platform_type : linux_ 09:08:48 INFO - Initialising browser for kraken test... 09:08:48 INFO - TEST-INFO | started process 29254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDrVyH5/profile http://localhost:33209/getInfo.html) 09:08:53 INFO - PROCESS | 29254 | 09:08:53 INFO - PROCESS | 29254 | (process:29322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:08:53 INFO - PROCESS | 29254 | __metrics Screen width/height:1600/1200 09:08:53 INFO - PROCESS | 29254 | colorDepth:24 09:08:53 INFO - PROCESS | 29254 | Browser inner width/height: 1024/697 09:08:53 INFO - PROCESS | 29254 | __metrics 09:08:54 ERROR - PROCESS | 29254 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:08:55 INFO - TEST-INFO | 29254: exit 0 09:08:55 INFO - Browser initialized. 09:08:55 INFO - Running cycle 1/1 for kraken test... 09:08:55 INFO - TEST-INFO | started process 29373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDrVyH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:57 INFO - PROCESS | 29373 | 09:08:57 INFO - PROCESS | 29373 | (process:29431): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:09:07 INFO - PROCESS | 29373 | RSS: Main: 164499456 09:09:07 INFO - PROCESS | 29373 | 09:09:10 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33209/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:11 INFO - PROCESS | 29373 | RSS: Main: 168587264 09:09:11 INFO - PROCESS | 29373 | 09:09:13 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33209/tests/kraken/driver.html?testName=audio-dft) 09:09:14 INFO - PROCESS | 29373 | RSS: Main: 172425216 09:09:14 INFO - PROCESS | 29373 | 09:09:17 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33209/tests/kraken/driver.html?testName=audio-fft) 09:09:18 INFO - PROCESS | 29373 | RSS: Main: 162648064 09:09:18 INFO - PROCESS | 29373 | 09:09:20 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33209/tests/kraken/driver.html?testName=audio-oscillator) 09:09:20 INFO - PROCESS | 29373 | RSS: Main: 163635200 09:09:20 INFO - PROCESS | 29373 | 09:09:23 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:23 INFO - PROCESS | 29373 | RSS: Main: 164945920 09:09:23 INFO - PROCESS | 29373 | 09:09:26 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33209/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:27 INFO - PROCESS | 29373 | RSS: Main: 165478400 09:09:27 INFO - PROCESS | 29373 | 09:09:31 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33209/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:31 INFO - PROCESS | 29373 | RSS: Main: 164331520 09:09:31 INFO - PROCESS | 29373 | 09:09:34 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33209/tests/kraken/driver.html?testName=json-parse-financial) 09:09:35 INFO - PROCESS | 29373 | RSS: Main: 164474880 09:09:35 INFO - PROCESS | 29373 | 09:09:36 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:37 INFO - PROCESS | 29373 | RSS: Main: 165216256 09:09:37 INFO - PROCESS | 29373 | 09:09:39 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:40 INFO - PROCESS | 29373 | RSS: Main: 164978688 09:09:40 INFO - PROCESS | 29373 | 09:09:42 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:42 INFO - PROCESS | 29373 | RSS: Main: 165961728 09:09:42 INFO - PROCESS | 29373 | 09:09:45 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:46 INFO - PROCESS | 29373 | RSS: Main: 165961728 09:09:46 INFO - PROCESS | 29373 | 09:09:49 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:50 INFO - PROCESS | 29373 | RSS: Main: 165318656 09:09:50 INFO - PROCESS | 29373 | 09:09:51 INFO - PROCESS | 29373 | Cycle 1(1): loaded http://localhost:33209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33209/tests/kraken/driver.html?testName=ai-astar) 09:09:52 INFO - PROCESS | 29373 | RSS: Main: 167022592 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | __start_tp_report 09:09:52 INFO - PROCESS | 29373 | _x_x_mozilla_page_load 09:09:52 INFO - PROCESS | 29373 | _x_x_mozilla_page_load_details 09:09:52 INFO - PROCESS | 29373 | |i|pagename|runs| 09:09:52 INFO - PROCESS | 29373 | |0;ai-astar;112;109;116;114;114;125;114;113;114;114 09:09:52 INFO - PROCESS | 29373 | |1;audio-beat-detection;166;140;166;194;134;169;164;135;210;137 09:09:52 INFO - PROCESS | 29373 | |2;audio-dft;162;160;165;167;178;163;162;163;167;163 09:09:52 INFO - PROCESS | 29373 | |3;audio-fft;78;74;75;167;79;78;74;73;156;79 09:09:52 INFO - PROCESS | 29373 | |4;audio-oscillator;95;95;144;94;95;94;138;93;94;146 09:09:52 INFO - PROCESS | 29373 | |5;imaging-gaussian-blur;118;117;118;118;116;118;118;118;118;117 09:09:52 INFO - PROCESS | 29373 | |6;imaging-darkroom;147;147;148;149;147;147;148;148;146;148 09:09:52 INFO - PROCESS | 29373 | |7;imaging-desaturate;95;95;96;95;95;95;96;98;95;95 09:09:52 INFO - PROCESS | 29373 | |8;json-parse-financial;65;66;65;64;66;66;65;84;63;75 09:09:52 INFO - PROCESS | 29373 | |9;json-stringify-tinderbox;64;65;65;64;65;64;65;64;68;65 09:09:52 INFO - PROCESS | 29373 | |10;stanford-crypto-aes;78;80;78;88;79;80;82;84;81;81 09:09:52 INFO - PROCESS | 29373 | |11;stanford-crypto-ccm;145;134;141;140;144;133;135;142;166;135 09:09:52 INFO - PROCESS | 29373 | |12;stanford-crypto-pbkdf2;175;171;178;176;182;172;173;168;180;178 09:09:52 INFO - PROCESS | 29373 | |13;stanford-crypto-sha256-iterative;76;75;74;75;74;74;85;81;72;71 09:09:52 INFO - PROCESS | 29373 | __end_tp_report 09:09:52 INFO - PROCESS | 29373 | __start_cc_report 09:09:52 INFO - PROCESS | 29373 | _x_x_mozilla_cycle_collect,912 09:09:52 INFO - PROCESS | 29373 | __end_cc_report 09:09:52 INFO - PROCESS | 29373 | __startTimestamp1460995792081__endTimestamp 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | ------- Summary: start ------- 09:09:52 INFO - PROCESS | 29373 | Number of tests: 14 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:4.12 (3.6%) stddev-sans-first:4.27 09:09:52 INFO - PROCESS | 29373 | Values: 112.0 109.0 116.0 114.0 114.0 125.0 114.0 113.0 114.0 114.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#1] audio-beat-detection Cycles:10 Average:161.50 Median:166.00 stddev:25.89 (15.6%) stddev-sans-first:27.41 09:09:52 INFO - PROCESS | 29373 | Values: 166.0 140.0 166.0 194.0 134.0 169.0 164.0 135.0 210.0 137.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:5.08 (3.1%) stddev-sans-first:5.27 09:09:52 INFO - PROCESS | 29373 | Values: 162.0 160.0 165.0 167.0 178.0 163.0 162.0 163.0 167.0 163.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.50 stddev:36.10 (47.2%) stddev-sans-first:37.87 09:09:52 INFO - PROCESS | 29373 | Values: 78.0 74.0 75.0 167.0 79.0 78.0 74.0 73.0 156.0 79.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.00 stddev:23.46 (25.0%) stddev-sans-first:24.35 09:09:52 INFO - PROCESS | 29373 | Values: 95.0 95.0 144.0 94.0 95.0 94.0 138.0 93.0 94.0 146.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:09:52 INFO - PROCESS | 29373 | Values: 118.0 117.0 118.0 118.0 116.0 118.0 118.0 118.0 118.0 117.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 09:09:52 INFO - PROCESS | 29373 | Values: 147.0 147.0 148.0 149.0 147.0 147.0 148.0 148.0 146.0 148.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 09:09:52 INFO - PROCESS | 29373 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 98.0 95.0 95.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:66.00 stddev:6.54 (9.9%) stddev-sans-first:6.85 09:09:52 INFO - PROCESS | 29373 | Values: 65.0 66.0 65.0 64.0 66.0 66.0 65.0 84.0 63.0 75.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 09:09:52 INFO - PROCESS | 29373 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 65.0 64.0 68.0 65.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:3.03 (3.7%) stddev-sans-first:3.00 09:09:52 INFO - PROCESS | 29373 | Values: 78.0 80.0 78.0 88.0 79.0 80.0 82.0 84.0 81.0 81.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:141.50 stddev:9.63 (6.8%) stddev-sans-first:10.13 09:09:52 INFO - PROCESS | 29373 | Values: 145.0 134.0 141.0 140.0 144.0 133.0 135.0 142.0 166.0 135.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:177.00 stddev:4.35 (2.5%) stddev-sans-first:4.61 09:09:52 INFO - PROCESS | 29373 | Values: 175.0 171.0 178.0 176.0 182.0 172.0 173.0 168.0 180.0 178.0 09:09:52 INFO - PROCESS | 29373 | 09:09:52 INFO - PROCESS | 29373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:75.00 stddev:4.22 (5.6%) stddev-sans-first:4.47 09:09:52 INFO - PROCESS | 29373 | Values: 76.0 75.0 74.0 75.0 74.0 74.0 85.0 81.0 72.0 71.0 09:09:52 INFO - PROCESS | 29373 | -------- Summary: end -------- 09:09:52 INFO - PROCESS | 29373 | 09:09:53 INFO - TEST-INFO | 29373: exit 0 09:09:53 INFO - TEST-OK | kraken | took 64207ms 09:09:53 INFO - SUITE-END | took 1179s 09:09:53 INFO - Completed test suite (00:19:39) 09:09:53 INFO - javascript benchmark 09:09:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.2020583721965, 2685.6777186737595, 2723.605077263797, 2728.6043523689077, 2733.412316351984, 4617.122746678133, 4721.622270218383, 4728.3380326754195, 4741.051789642068, 4750.406199225097, 4636.86089417318, 4695.976520117395, 4767.11808315461, 4812.927806082903, 4825.855224343267, 4273.188094262088, 4397.758123303217, 4408.140412619525, 4425.513193548707, 4443.622292105175, 611.7590214972901, 4062.9191562004635, 4226.175895700339, 4317.589828966243, 4331.5884990925815, 4298.161858437606, 4311.956880431187, 4319.76241306728, 4324.6972711910175, 4342.240107981091, 4310.073334233123, 4321.200577893069, 4327.956720432787, 4359.520452750195, 4362.716423432498, 4298.355246712987, 4355.150745604608, 4365.2142614329405, 4385.912281754347, 4409.140217657558, 4696.060787842411, 4717.410323709536, 4723.031778485402, 4723.078999595046, 4724.952750472486, 4958.7024778513405, 5031.823886163967, 5132.692038477666, 5152.433232344439, 5158.9484105158845, 5012.624053195988, 5016.3980322361185, 5026.723530205837, 5028.120078986163, 5063.822766203165, 4677.7661116944355, 4679.859604211879, 4684.882877928045, 4691.882702932454, 4724.83463078794, 5082.923756143661, 5134.306868572769, 5164.535191832678, 5197.194434862602, 5238.057149713089, 5029.321041659329, 5055.721935293521, 5061.9493805061475, 5067.5185857343495, 5069.0, 5138.537531622172, 5148.407933087743, 5150.201718733602, 5157.8452646420665, 5167.896642067213, 4905.48492408292, 5069.188929771219, 5080.669756465818, 5155.175171972466, 5168.819091331786, 4976.751162441863, 4982.227754698028, 4991.425986011655, 5002.89994200114, 5023.522765337287, 4259.829606815692, 4275.541548649587, 4276.31578947367, 4295.355696645528, 4309.762963037063, 3652.2695460907926, 3665.560132784083, 3744.43833424983, 3792.393217085253, 3856.151646637791, 4371.715838470489, 4379.321205213197, 4419.690621656453, 4425.645948324126, 4469.7988590513505, 5124.5131712487255, 5125.69245845243, 5125.820596279113, 5127.0, 5147.485251474823, 4236.279832428495, 4386.956130438654, 4425.845095421645, 4451.10977804434, 4482.8206871725415, 4599.218132917345, 4612.76936153191, 4614.100250451197, 4617.8383756568355, 4657.417822772153, 4772.570468657837, 4814.927776083291, 4817.542333478314, 4820.566149046603, 4866.5376789204265, 4957.0, 5120.846374608767, 5188.118019936695, 5204.713740744295, 5220.425753167073, 4778.092162489116, 4788.162071637519, 4788.497207793271, 4818.855434336975, 4823.541763532458, 4921.507849215193, 5034.697918124924, 5037.546620804145, 5042.571381432619, 5080.1363768160245, 5076.847694569169, 5097.0315640028275, 5109.489051094861, 5113.15632920564, 5182.97408512955, 4971.304017437489, 4992.825251116194, 4995.47547507521, 5001.374828146481, 5042.966191930719, 4814.350062741625, 4959.156943319572, 4977.377827771528, 4982.202847544376, 5009.0482808266315, 4773.451053128934, 4824.0, 4862.5380588844, 4883.462819089827, 4914.803407863646, 4967.254911763264, 4968.850934471971, 4977.328060711758, 4982.925256121233, 5036.219385995177, 4824.0, 4855.611551075976, 4893.853184404474, 4907.656464047483, 4967.279744437109], "value": 4636.878694425702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8417446458633, 581.9388964158763, 589.9085641725532, 601.5247954116248, 638.6774678787211, 32976.17559561012, 33966.66033339669, 34100.48849267263, 34160.0, 34266.8286658567, 37531.249375012485, 37934.0, 38026.61973380272, 38102.0, 38112.0, 7570.545767253955, 7724.806879827993, 7733.072031356245, 7735.883961740578, 7743.148253692089, 7600.505967112148, 7725.18885517021, 7731.729389471369, 7764.961175194145, 7765.301122898938, 7765.339946104559, 7794.298513133816, 7807.219278072176, 7828.960855195744, 7830.765077047669, 7712.498687585317, 7732.2267773223075, 7776.611169441505, 7779.8833017504785, 7783.910252564646, 7634.236576342377, 7704.036995375578, 7725.8454830903065, 7731.149573546905, 7736.187700291501, 29392.41215175706, 34965.82517087424, 35233.64766352355, 35375.64624353775, 35510.64489355099, 2782.0, 3052.8168309901475, 3467.4706600553263, 3749.0252534340993, 3753.1930634913624, 25458.108966186093, 25954.0, 26006.479870402676, 26401.47197056048, 27132.45735085307, 3110.5178697301953, 3115.8346837934787, 3136.4354416205074, 3165.271987442901, 3200.199950012497, 167863.0, 168922.0, 169214.0, 170060.1496992507, 207989.0, 33307.666923330944, 34335.484967725504, 34448.48327275093, 49534.50465495371, 50006.0, 31216.21959451032, 31524.842375788434, 31573.0, 31672.208194794854, 31712.524312135338, 11904.285742855456, 12188.329641869783, 12204.816927746091, 12235.32705701195, 12251.938740306241, 9068.727938161734, 9150.40522366044, 9227.0, 9243.815123697623, 9375.0, 8228.711995080144, 8263.049749278789, 8283.62723677436, 8327.0, 8334.16658334174, 3167.0973772474736, 3265.3142840003866, 3305.4215512285737, 3314.3537010283244, 3340.8329583520726, 933.7712260496222, 950.1401231885155, 952.1050212799946, 991.5141580625586, 1023.948802559869, 27207.863960680465, 28363.57454638182, 28444.71555284462, 28792.42415151685, 28886.422271554453, 990.1039559198937, 991.6925753016588, 1020.6835880876804, 1025.5487585462372, 1039.5841663334575, 14514.782278265835, 15043.548693538993, 15049.54851354461, 15174.165420901736, 15284.388624454898, 334805.0, 338374.0, 341269.0, 342262.0, 343056.0, 47666.76166619144, 48013.75993120012, 48181.0, 48219.0, 48238.0, 1167.270455965022, 1179.3159967218992, 1203.8194270859442, 1214.2714371377103, 1237.4864431260926, 26543.86728066347, 27938.86030569834, 28060.0, 28183.71816281811, 28213.71786282193, 42378.576214237466, 42918.57081429146, 43227.78386108049, 43281.78359108185, 43442.348364775185, 302063.0, 302208.0, 303071.0, 305309.0, 305933.0, 25187.87406062958, 25225.0, 25520.48959020772, 25747.6137857936, 25852.482950340513, 41072.38391424191, 41103.38344924888, 41510.377344340464, 41546.0, 42014.36978445265, 35085.64914350926, 36519.81740091283, 36566.0, 36678.26643467062, 37301.6269837309, 35314.64685353216, 35606.287874241854, 35642.28715425625, 36035.63964360428, 36242.8187859059, 35648.465273021444, 36106.27787444289, 36222.63777362193, 36279.63720362762, 36521.0, 28412.57381139326, 29406.70593294125, 29629.0, 29821.850890746275, 30661.4052068594, 24636.630450542896, 25116.874415627804, 25218.369540760894, 25238.74761252364, 25484.23547293584], "value": 15830.830822462716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.40498310178384, 380.72968192583267, 389.0720631294363, 395.59649157858985, 398.55561049429895, 16044.05031471636, 17276.308947642112, 17648.82351176488, 17953.833000854935, 18004.279828806866, 16603.750943735853, 16994.405195818148, 17230.56923576911, 17318.56703582408, 17428.651426971453, 5001.224810154423, 5174.146265866128, 5177.844664660066, 5211.895762084756, 5231.032259032091, 3733.645303696158, 5683.744231509592, 5937.88124237515, 6014.75940962361, 6014.789482368118, 5000.399952005764, 5923.378045305246, 5943.851403714899, 5960.165576819249, 5965.88068238635, 5190.948090519122, 5212.8957420851375, 5222.190560463135, 5245.554127899133, 5268.631195816294, 5017.698938063728, 5183.688978661255, 5401.810936617199, 5443.455654434564, 5457.045017122027, 12067.336296503689, 12289.877101229053, 12328.753424931541, 12389.752204955941, 12587.433565489575, 1869.2522990803786, 1900.3253844885005, 1903.5050886769402, 1949.8732582382243, 2082.6043051820106, 8673.13268673134, 8725.127487251224, 9022.0, 9084.954575227148, 9102.953160386574, 1708.1032457959545, 1761.9119044047745, 1778.084286592406, 1790.2838864454193, 1811.0401487211798, 68896.6555167221, 71303.64348178278, 71454.64272678655, 72384.0, 72535.0, 9800.068993445753, 9901.05939935705, 10012.849807252896, 10060.849087263698, 10089.344192627455, 13635.727285454434, 13649.11280766747, 13667.794983075262, 13706.725865482835, 13752.793708094387, 6876.724931002704, 6897.55165914214, 6929.480288978246, 7066.893996590055, 7152.105986751656, 6559.737610495622, 6580.341965803477, 6605.471562275006, 6663.766768163188, 6680.0, 4233.78831058452, 4239.27932251518, 4329.826806927687, 4515.193656241663, 4516.525764794715, 1676.8658507319385, 1775.946721598354, 1871.391797665764, 1898.7531620889472, 1920.0975541495475, 864.7881269089113, 865.5326123893027, 883.2183517586982, 929.5212965322864, 1019.108280254777, 15523.844761552466, 15885.682286354207, 15931.920340398225, 16692.332306707594, 16874.493765187064, 859.1365677494078, 883.6156272021691, 891.38494438837, 960.1934375124929, 962.8940816510178, 9044.592993315317, 9123.044262922593, 9284.860727089099, 9296.95351523238, 9399.906000939904, 426381.0, 436508.0, 437417.0, 440027.0, 442069.0, 77378.0, 80978.19021809706, 82910.17089829146, 83243.58378208191, 84298.57850710707, 949.482532020037, 956.1776871890169, 964.6671898195111, 970.335320305593, 972.1202311907734, 14893.957422980287, 14907.403703851724, 14912.328945197709, 14938.402463901757, 14954.775678365051, 32818.0, 33823.15442113967, 34560.65439345574, 34723.9582812516, 34922.82538587291, 45157.77421112874, 46521.302180467996, 47881.0, 48280.517194827604, 48836.511634883194, 6762.256151823394, 7123.608201548965, 7384.150822655463, 7698.345640620386, 7900.920990790019, 7748.535087894519, 9875.358101723365, 11245.100391968786, 11270.718232044264, 11427.942860285646, 10267.229957753048, 10298.948505257425, 10308.587656493955, 10465.895341046493, 10682.679519614425, 4758.286257061469, 8754.47473151613, 10006.399616023062, 10481.536838842714, 10513.369197848153, 10511.632092876713, 10533.736656583647, 10550.683479495627, 10739.570417183226, 10777.461126943464, 7856.175101614248, 7877.094134174643, 7929.0, 7940.761777146695, 8000.0, 9543.28425368114, 10581.841272381074, 10636.468176591294, 10746.355218686904, 10755.89244107549], "value": 8074.724924679798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.7859821026846, 1484.4655923867408, 1577.3059853664388, 1747.2050217151198, 1755.245244544846, 6621.9006714899315, 7660.463767536267, 7763.378929685626, 7898.0, 7898.526088434698, 7723.536587804736, 7757.7672669819995, 7822.217778222175, 7843.372530197585, 7875.80310492238, 2179.8038176564105, 2184.770599087097, 2201.042546492273, 2206.8344874134423, 2207.0730293276783, 2154.375231182955, 2181.4764456530397, 2198.9450263743374, 2207.293666026872, 2213.6458166693333, 2205.128974055247, 2217.345882964529, 2221.455743342883, 2232.6316157834017, 2246.8988895499742, 2167.7507086684996, 2170.934871953844, 2176.0316659086634, 2185.846990710651, 2193.5941850757663, 2130.052126803573, 2171.815395691368, 2173.261091228974, 2181.967270490944, 2182.9235976740897, 7832.921670783333, 7981.680732770682, 8002.679892804281, 8010.759677209693, 8026.518408895485, 4782.665213435061, 4891.070696567676, 4891.388576427947, 4900.289458028602, 4947.431045429749, 2793.7345952134515, 2811.9718802811913, 2863.842488663123, 2876.5972763813083, 2977.5533669949464, 815.6003558256471, 848.9320854331638, 851.1701091435863, 1725.8619310455133, 1791.2118667786262, 10618.150547956222, 10733.087687546567, 10745.14038876888, 10747.838782418348, 10800.081993030602, 4103.281925662997, 4133.318002529549, 4313.50394704613, 4319.43847299849, 4339.761313127745, 8566.057733649293, 8651.567421628893, 8666.78333041679, 8670.349723770742, 8673.132686731402, 4779.569838714463, 4806.975965120152, 4808.3989501312335, 4808.447028591687, 4816.783244753994, 3829.1384438501113, 4211.4525111735275, 4347.043650396908, 4433.8226470941445, 4440.4671439427475, 3460.186856088817, 3579.785212887183, 3592.7844329340323, 3626.655467730561, 3686.7972261525874, 979.3927764785736, 986.7286496213599, 986.753311672082, 996.6710985374809, 1081.7890511350367, 831.1314676163423, 845.5603086395163, 878.9428687135444, 885.3094586222757, 893.071205945822, 5395.676259424447, 5451.836444906659, 5526.58550608706, 5591.133374326986, 5803.622764520293, 405.84577860412855, 410.58530883806975, 411.08123344325406, 416.58965918570186, 428.036916936892, 3912.4522566840665, 3973.304671682444, 3990.102226998902, 4010.2781499329817, 4065.918681626351, 9427.19868811145, 9737.610495580238, 9741.951290243504, 9749.65876194344, 9808.36245644045, 9326.533673316308, 9650.662226822027, 9676.322657413913, 9707.126358627758, 9716.465594392377, 7166.068411106627, 7213.927860721431, 7288.271172882669, 7401.666924988388, 7409.8147546311775, 5555.555555555627, 5680.857978550569, 5685.431456854281, 5731.054376027909, 5834.620749651259, 9004.279657627505, 9030.232430243503, 9088.182063614306, 9094.909050909406, 9162.633494660138, 8627.654893804429, 8937.821243575223, 8965.731028069169, 8988.505632190292, 9018.053104423941, 6066.696665166813, 6702.396784289437, 6847.657617119224, 6914.5159838812815, 6993.860122797617, 7551.093868735787, 7631.1605723371495, 7634.312911837961, 7647.808804779925, 7653.732119375795, 6654.833629159116, 6945.201301850352, 6952.930470695228, 6993.720251190099, 7056.576605403487, 6900.585964842126, 6910.412614927787, 6926.619035953071, 6945.062416573698, 6991.965040174767, 6276.152719382825, 6314.747410103728, 6333.619982801047, 6432.614043157426, 6435.678216089271, 4797.136515427117, 4802.951970480391, 4856.174450343521, 4874.366332376769, 4888.780004899717, 4868.732219727807, 4914.262860570943, 4942.135126352946, 4947.82682606107, 5017.272495488207], "value": 4147.656616635433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.07974634321437, 314.71203848478643, 317.2228041298817, 317.3716042236372, 319.88644031368875, 5312.804618960737, 5348.893022139559, 5399.865003374917, 5400.594955378343, 5405.324334458192, 5303.867403314909, 5309.548688361494, 5331.173668081444, 5332.093544097503, 5337.919931201025, 3941.980290098553, 3959.742616729903, 4137.1518838638, 4141.0744004038115, 4150.211459822639, 4120.608542188487, 4132.214879172948, 4139.482564679415, 4141.316682747343, 4147.854825081107, 4103.651189648868, 4110.671146308303, 4114.691398145136, 4118.629323360897, 4132.442120313749, 4019.7588144711412, 4094.979525102385, 4122.876313710593, 4122.9381559276635, 4140.792960351971, 3619.6742293193474, 3636.799976001319, 3640.9635903640888, 3641.217138315275, 3654.28741395428, 5046.974765126188, 5062.0888240116765, 5081.789421601578, 5092.59259259262, 5138.229265610151, 4584.220682483986, 4746.905061898778, 4765.475797662254, 4773.9761301193275, 4776.689515181537, 5577.972110139464, 5584.944150558483, 5604.41153678866, 5611.615063597955, 5630.324361076656, 3987.1228329767405, 3989.8005099744896, 3997.360422332413, 4000.0999775050673, 4011.578784227643, 5594.992901277768, 5824.563157763142, 5870.970645146747, 5876.382979787147, 5921.328776158766, 3978.801059947049, 3982.681385489154, 3996.440498330236, 4007.458993035961, 4024.1146947671464, 4040.0, 4040.4545386372465, 4048.109415928491, 4070.8778736637946, 4075.3275709508193, 4561.270196768501, 4645.818763113158, 4651.325557794101, 4656.813727450932, 4663.090697314059, 5549.0, 5554.305711786027, 5574.554035677136, 5594.524465420485, 5607.130894711327, 1392.3386391463973, 1412.3009110490373, 1420.8846055846318, 1421.665908511499, 1423.2741301936087, 880.5421180985851, 928.3826255540125, 940.5720397219249, 946.2004606107828, 974.9805003899883, 4794.496577859274, 4797.832075877397, 4801.18379875422, 4811.4707382187935, 4841.8547443576745, 5668.149777533403, 5717.771289148471, 5725.341585717612, 5779.162021506858, 5783.190353350535, 4594.563516465931, 4824.975875120672, 4837.975810120927, 4839.975800120977, 4901.975490122527, 3084.521899105642, 3111.7043880831284, 3122.656507784142, 3127.1400364899378, 3132.37352529495, 5368.785248590091, 5438.864028399322, 5484.122540393518, 5485.17722341644, 5505.091659876076, 5803.158542011384, 5933.033483258371, 5958.404159584094, 5989.490893274034, 6026.969865150734, 5460.453954604508, 5461.426550212171, 5463.781448742086, 5491.423400542965, 5496.5983674163635, 5725.141228815544, 5846.94153058464, 5853.824385268449, 5855.677937713296, 5879.5002424794375, 5728.713564321851, 5729.799457018984, 5730.312362516358, 5740.425957404226, 5749.798757043483, 5439.809606663748, 5444.782208711607, 5473.917891231555, 5477.424870388551, 5486.588505861996, 3885.417187421909, 3945.3292940199663, 3949.1241660212318, 3984.32266514699, 3999.3601023836045, 5801.114637742666, 5810.273715785527, 5810.593258471867, 5832.12518122285, 5860.443257890493, 5661.433856614306, 5665.320161580472, 5668.659880407024, 5675.744591493475, 5681.460261275172, 5454.084347354677, 5595.412481689526, 5621.0, 5631.802886898939, 5643.689597072036, 5225.764840582106, 5508.669479831223, 5513.61404701667, 5534.1975413565615, 5538.363088244742, 5503.697296648723, 5666.829995100154, 5677.290338707661, 5702.401247868914, 5713.857153571194, 5510.504054634942, 5549.528290095387, 5551.557314781483, 5552.583556233218, 5569.106503788731], "value": 4199.414641975777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.7715299645125, 676.7428377216656, 705.0235423937847, 753.7776355974987, 769.8344855855993, 11483.712907177325, 11538.942305288472, 11752.413424187722, 12342.444589993449, 12891.935540322309, 14033.719325613481, 14126.081804682688, 14147.575572732809, 14160.858391416083, 14230.715385692305, 817.6565842346214, 820.0651257566379, 820.4011071917504, 824.0688022534528, 824.9051359093721, 651.4365074210821, 805.2390490986021, 816.8978877640295, 820.3232333325001, 835.2858306148247, 853.9359548033891, 856.1353033436243, 859.1923591823697, 859.9656013759442, 861.9396642235046, 845.6786421159982, 854.5769843927234, 856.2251162697769, 857.0272740439615, 857.7212405968023, 620.045130499031, 621.6674079367517, 621.726440366242, 623.0249659283207, 626.2359920896499, 12016.218945768585, 12094.213876098025, 12169.695757606041, 12189.695257618541, 12203.511859525608, 12185.39073046353, 12310.507579696801, 12323.198992065487, 12357.443915023845, 12536.749265014649, 9750.609975600968, 9904.059114384121, 9995.300328976975, 10060.195184385231, 10140.239482038876, 3201.8719251229923, 3255.039763269841, 3263.6083669959758, 3280.130765347185, 3290.424175769255, 46462.0, 46532.7673361631, 46864.531354686354, 46975.0, 48426.75786621044, 9741.220702343795, 9792.902070979198, 10039.849402258971, 10124.0, 10255.128314093236, 17078.0, 17145.14274286281, 17148.228329725192, 17152.31390744381, 17255.39606113805, 6339.080833279241, 6423.421892029646, 6456.741730330828, 6538.574992625464, 6635.900461493082, 3782.9243415132096, 3845.288621605012, 3857.40210267409, 3867.2265546890735, 3887.1448281378052, 2844.9573256401172, 2892.334763004521, 2910.2433367324224, 2912.7524160446173, 2922.211003029213, 513.5839969624616, 516.5557620446413, 523.0741587390298, 527.1933941070168, 536.2760273630568, 533.5758072332505, 539.2531344088466, 569.894569504643, 593.4391999560374, 629.9401556852092, 7377.22539133394, 7681.654325555363, 7696.923030769621, 7786.7663970080985, 7800.882986755203, 588.3910152991633, 594.4768603628779, 616.0728104203146, 620.252595622274, 620.3982137326785, 3548.929021419557, 3666.871659491905, 3680.723945704083, 3717.423799311111, 3812.6568608825337, 50733.0, 50807.745961270695, 51429.0, 51520.22719659208, 51688.48311516837, 43971.12057758827, 45006.0, 45358.09283814305, 45780.084398312516, 46081.76959115183, 36754.0, 39548.406773898416, 40932.79533602372, 41406.1718765623, 42185.156296874506, 8198.180181981754, 8242.876356854533, 8264.752057438287, 8284.627191776264, 8469.407141500036, 27170.864145679145, 27383.452330953667, 27425.86287068552, 28080.29799255035, 28633.0, 30237.0, 30357.54463683002, 34246.828765856015, 38893.41659875161, 39403.0, 10337.9483102584, 10617.734556636145, 10671.199660025373, 10821.51303191374, 10908.727281818017, 11913.761724765629, 11944.820827687417, 12102.75794484123, 12371.257724536557, 12393.876061239273, 11366.768321501202, 11731.472083756422, 11774.411279435823, 12040.21738586989, 12198.878011219775, 10795.352278863293, 11094.057005154329, 11504.827427588425, 11518.596849110241, 11555.42222888869, 10676.946615266874, 11413.885861141282, 11501.597444089417, 11538.423078845855, 11846.585369512026, 8971.049739144264, 9390.624375024923, 9415.57629906642, 9852.507374631097, 10029.849552256868, 8839.911600883908, 9686.564104615169, 9942.204623630238, 9959.502024898582, 9960.651377201762], "value": 5937.587420703592, "unit": "score"}], "name": "dromaeo_css", "value": 6279.378359632021, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 116.0, 114.0, 114.0, 125.0, 114.0, 113.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 140.0, 166.0, 194.0, 134.0, 169.0, 164.0, 135.0, 210.0, 137.0], "value": 161.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 165.0, 167.0, 178.0, 163.0, 162.0, 163.0, 167.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 167.0, 79.0, 78.0, 74.0, 73.0, 156.0, 79.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 144.0, 94.0, 95.0, 94.0, 138.0, 93.0, 94.0, 146.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 116.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 146.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 98.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 66.0, 66.0, 65.0, 84.0, 63.0, 75.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 68.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 88.0, 79.0, 80.0, 82.0, 84.0, 81.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 141.0, 140.0, 144.0, 133.0, 135.0, 142.0, 166.0, 135.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 178.0, 176.0, 182.0, 172.0, 173.0, 168.0, 180.0, 178.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 75.0, 74.0, 74.0, 85.0, 81.0, 72.0, 71.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1610.1, "alertThreshold": 2.0}]} 09:09:53 INFO - Return code: 0 09:09:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:09:53 ERROR - # TBPL SUCCESS # 09:09:53 INFO - Running post-action listener: _resource_record_post_action 09:09:53 INFO - Running post-run listener: _resource_record_post_run 09:09:54 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 482680832; Read time: 12; Write time: 456776 09:09:54 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 188059648; Read time: 0; Write time: 226484 09:09:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294621184; Read time: 12; Write time: 230292 09:09:54 INFO - Running post-run listener: _upload_blobber_files 09:09:54 INFO - Blob upload gear active. 09:09:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:54 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 09:09:54 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'] 09:09:54 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 09:09:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:55 INFO - (blobuploader) - INFO - Done attempting. 09:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:56 INFO - (blobuploader) - INFO - Done attempting. 09:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:56 INFO - Return code: 0 09:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5846111d299fd590f6a1e4a8c5d61a1b718fd629a29c6a07f6f5553f5a235352bcb2ef5e86b8f324a6bd220c181306e302de96501ca1acb39eaf536c0377ab7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19669744848863b6904d7022bc11daa7a8207fade06691a83acfb3ae7616502d2b8ad2957cca69948cb1a65af8cbdf2e4c9f390a3c2922cbaae84e7e3c0275c1"} 09:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:56 INFO - Contents: 09:09:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5846111d299fd590f6a1e4a8c5d61a1b718fd629a29c6a07f6f5553f5a235352bcb2ef5e86b8f324a6bd220c181306e302de96501ca1acb39eaf536c0377ab7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19669744848863b6904d7022bc11daa7a8207fade06691a83acfb3ae7616502d2b8ad2957cca69948cb1a65af8cbdf2e4c9f390a3c2922cbaae84e7e3c0275c1"} 09:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:56 INFO - Copying logs to upload dir... 09:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.629306 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-18 09:09:56.690699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 09:09:56.694548) ========= 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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 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/d5846111d299fd590f6a1e4a8c5d61a1b718fd629a29c6a07f6f5553f5a235352bcb2ef5e86b8f324a6bd220c181306e302de96501ca1acb39eaf536c0377ab7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19669744848863b6904d7022bc11daa7a8207fade06691a83acfb3ae7616502d2b8ad2957cca69948cb1a65af8cbdf2e4c9f390a3c2922cbaae84e7e3c0275c1"} build_url:https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/T5991uagSiiY712zWbfoxw/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/d5846111d299fd590f6a1e4a8c5d61a1b718fd629a29c6a07f6f5553f5a235352bcb2ef5e86b8f324a6bd220c181306e302de96501ca1acb39eaf536c0377ab7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19669744848863b6904d7022bc11daa7a8207fade06691a83acfb3ae7616502d2b8ad2957cca69948cb1a65af8cbdf2e4c9f390a3c2922cbaae84e7e3c0275c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 09:09:56.719518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:09:56.719851) ========= 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=7de08804244eb36560b44971000001c3-1460994210.358839-572105167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:09:56.803090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 09:09:56.803411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 09:09:56.803700) ========= ========= Total master_lag: 0.18 =========