builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1460649675.81 results: success (0) buildid: 20160414074538 builduid: e44f1848eee34552bfde55587b277c28 revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:15.814191) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:15.814656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:15.814930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:15.857080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:15.857403) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 09:01:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-14 09:01:16 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.209758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.084820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.085143) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018358 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.149790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.150125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 995e7890dd613843c3914a1d9d46676f400152c1 --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 995e7890dd613843c3914a1d9d46676f400152c1 --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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 09:01:16,264 truncating revision to first 12 chars 2016-04-14 09:01:16,264 Setting DEBUG logging. 2016-04-14 09:01:16,264 attempt 1/10 2016-04-14 09:01:16,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/995e7890dd61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 09:01:16,504 unpacking tar archive at: fx-team-995e7890dd61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.679918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.680268) ========= script_repo_revision: 995e7890dd613843c3914a1d9d46676f400152c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.680682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.681000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 09:01:16.698123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-14 09:01:16.698480) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:16 INFO - MultiFileLogger online at 20160414 09:01:16 in /builds/slave/test 09:01:16 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 09:01:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:16 INFO - {'append_to_log': False, 09:01:16 INFO - 'base_work_dir': '/builds/slave/test', 09:01:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:01:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:16 INFO - 'branch': 'Fx-Team-Non-PGO', 09:01:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:16 INFO - 'config_files': ('talos/linux_config.py',), 09:01:16 INFO - 'default_actions': ('clobber', 09:01:16 INFO - 'read-buildbot-config', 09:01:16 INFO - 'download-and-extract', 09:01:16 INFO - 'populate-webroot', 09:01:16 INFO - 'create-virtualenv', 09:01:16 INFO - 'install', 09:01:16 INFO - 'run-tests'), 09:01:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:16 INFO - 'download_minidump_stackwalk': True, 09:01:16 INFO - 'download_symbols': 'ondemand', 09:01:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:16 INFO - 'installer_path': 'installer.exe', 09:01:16 INFO - 'log_level': 'info', 09:01:16 INFO - 'log_name': 'talos', 09:01:16 INFO - 'log_to_console': True, 09:01:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:16 INFO - 'opt_config_files': (), 09:01:16 INFO - 'pip_index': False, 09:01:16 INFO - 'sps_profile': False, 09:01:16 INFO - 'sps_profile_interval': 0, 09:01:16 INFO - 'suite': 'dromaeojs-e10s', 09:01:16 INFO - 'system_bits': '32', 09:01:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:16 INFO - 'title': 'talos-linux64-ix-005', 09:01:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:16 INFO - 'use_talos_json': True, 09:01:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:17 INFO - 'work_dir': 'build'} 09:01:17 INFO - ##### 09:01:17 INFO - ##### Running clobber step. 09:01:17 INFO - ##### 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: clobber 09:01:17 INFO - rmtree: /builds/slave/test/build 09:01:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:17 INFO - Running post-action listener: _resource_record_post_action 09:01:17 INFO - ##### 09:01:17 INFO - ##### Running read-buildbot-config step. 09:01:17 INFO - ##### 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: read_buildbot_config 09:01:17 INFO - Using buildbot properties: 09:01:17 INFO - { 09:01:17 INFO - "project": "", 09:01:17 INFO - "product": "firefox", 09:01:17 INFO - "script_repo_revision": "production", 09:01:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:01:17 INFO - "repository": "", 09:01:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:01:17 INFO - "buildid": "20160414074538", 09:01:17 INFO - "pgo_build": "False", 09:01:17 INFO - "basedir": "/builds/slave/test", 09:01:17 INFO - "buildnumber": 1151, 09:01:17 INFO - "slavename": "talos-linux64-ix-005", 09:01:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:01:17 INFO - "platform": "ubuntu64_hw", 09:01:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:01:17 INFO - "branch": "fx-team", 09:01:17 INFO - "repo_path": "integration/fx-team", 09:01:17 INFO - "revision": "995e7890dd613843c3914a1d9d46676f400152c1", 09:01:17 INFO - "stage_platform": "linux64", 09:01:17 INFO - "builduid": "e44f1848eee34552bfde55587b277c28", 09:01:17 INFO - "slavebuilddir": "test" 09:01:17 INFO - } 09:01:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:01:17 INFO - Running post-action listener: _resource_record_post_action 09:01:17 INFO - ##### 09:01:17 INFO - ##### Running download-and-extract step. 09:01:17 INFO - ##### 09:01:17 INFO - Running pre-action listener: _resource_record_pre_action 09:01:17 INFO - Running main action method: download_and_extract 09:01:17 INFO - mkdir: /builds/slave/test/build/tests 09:01:17 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')]} 09:01:17 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:01:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:26 INFO - Downloaded 1361 bytes. 09:01:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:01:26 INFO - Using the following test package requirements: 09:01:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:01:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'jsshell-linux-x86_64.zip'], 09:01:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01: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')]} 09:01:26 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:29 INFO - Downloaded 22202881 bytes. 09:01:29 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'] 09:01:29 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 09:01:30 INFO - Return code: 0 09:01:30 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 09:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:30 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:33 INFO - Downloaded 22202881 bytes. 09:01:33 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'] 09:01:33 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 09:01:35 INFO - Return code: 0 09:01:35 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')]} 09:01:35 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:36 INFO - Downloaded 10841076 bytes. 09:01:36 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'] 09:01:36 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 09:01:36 INFO - Return code: 0 09:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:36 INFO - https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M231uVHtT223nVzRbPAm_A/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 09:01:40 INFO - Downloaded 54450742 bytes. 09:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:40 INFO - mkdir: /builds/slave/test/properties 09:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:01:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:01:40 INFO - Contents: 09:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - Running post-action listener: set_extra_try_arguments 09:01:41 INFO - ##### 09:01:41 INFO - ##### Running populate-webroot step. 09:01:41 INFO - ##### 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: populate_webroot 09:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:41 INFO - '--tppagecycles', 09:01:41 INFO - '7'], 09:01:41 INFO - 'tests': ['tsvgm']}}, 09:01:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:01:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:01:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:01:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['damp', 'tps']}, 09:01:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['damp', 'tps']}, 09:01:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['dromaeo_dom']}, 09:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['a11yr', 09:01:41 INFO - 'ts_paint', 09:01:41 INFO - 'tpaint', 09:01:41 INFO - 'sessionrestore', 09:01:41 INFO - 'sessionrestore_no_auto_restore', 09:01:41 INFO - 'tabpaint']}, 09:01:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tsvgx', 09:01:41 INFO - 'tsvgr_opacity', 09:01:41 INFO - 'tart', 09:01:41 INFO - 'tscrollx', 09:01:41 INFO - 'cart']}, 09:01:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:01:41 INFO - 'tsvgr_opacity', 09:01:41 INFO - 'tart', 09:01:41 INFO - 'tscrollx', 09:01:41 INFO - 'cart']}, 09:01:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s'], 09:01:41 INFO - 'tests': ['tp5o']}, 09:01:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'tests': ['tp5o']}, 09:01:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--disable-e10s', 09:01:41 INFO - '--xperf_path', 09:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:41 INFO - 'tests': ['tp5n']}, 09:01:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:41 INFO - 'talos_options': ['--xperf_path', 09:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:41 INFO - 'tests': ['tp5n']}}, 09:01:41 INFO - 'talos.zip': {'path': '', 09:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - ##### 09:01:41 INFO - ##### Running create-virtualenv step. 09:01:41 INFO - ##### 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: create_virtualenv 09:01:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:01:41 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 09:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:41 INFO - Using real prefix '/usr' 09:01:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:44 INFO - Installing pip.................done. 09:01:44 INFO - Return code: 0 09:01:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:44 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 09:01:44 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 09:01:44 INFO - Using env: {'DISPLAY': ':0', 09:01:44 INFO - 'HOME': '/home/cltbld', 09:01:44 INFO - 'LANG': 'en_US.UTF-8', 09:01:44 INFO - 'LANGUAGE': 'en_US:en', 09:01:44 INFO - 'LOGNAME': 'cltbld', 09:01:44 INFO - 'MAIL': '/var/mail/cltbld', 09:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:44 INFO - 'MOZ_NO_REMOTE': '1', 09:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:44 INFO - 'NO_EM_RESTART': '1', 09:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:44 INFO - 'PWD': '/builds/slave/test', 09:01:44 INFO - 'SHELL': '/bin/bash', 09:01:44 INFO - 'SHLVL': '1', 09:01:44 INFO - 'TERM': 'linux', 09:01:44 INFO - 'TMOUT': '86400', 09:01:44 INFO - 'USER': 'cltbld', 09:01:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:44 INFO - '_': '/tools/buildbot/bin/python'} 09:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:44 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 09:01:44 INFO - Cleaning up... 09:01:44 INFO - Return code: 0 09:01:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:44 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 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:44 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 09:01:44 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 09:01:44 INFO - Using env: {'DISPLAY': ':0', 09:01:44 INFO - 'HOME': '/home/cltbld', 09:01:44 INFO - 'LANG': 'en_US.UTF-8', 09:01:44 INFO - 'LANGUAGE': 'en_US:en', 09:01:44 INFO - 'LOGNAME': 'cltbld', 09:01:44 INFO - 'MAIL': '/var/mail/cltbld', 09:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:44 INFO - 'MOZ_NO_REMOTE': '1', 09:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:44 INFO - 'NO_EM_RESTART': '1', 09:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:44 INFO - 'PWD': '/builds/slave/test', 09:01:44 INFO - 'SHELL': '/bin/bash', 09:01:44 INFO - 'SHLVL': '1', 09:01:44 INFO - 'TERM': 'linux', 09:01:44 INFO - 'TMOUT': '86400', 09:01:44 INFO - 'USER': 'cltbld', 09:01:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:44 INFO - '_': '/tools/buildbot/bin/python'} 09:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:44 INFO - Downloading/unpacking psutil>=0.7.1 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:46 INFO - Installing collected packages: psutil 09:01:46 INFO - Running setup.py install for psutil 09:01:46 INFO - building 'psutil._psutil_linux' extension 09:01:46 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 09:01:47 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 09:01:47 INFO - building 'psutil._psutil_posix' extension 09:01:47 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 09:01:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:48 INFO - Successfully installed psutil 09:01:48 INFO - Cleaning up... 09:01:48 INFO - Return code: 0 09:01:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:01:48 INFO - Using env: {'DISPLAY': ':0', 09:01:48 INFO - 'HOME': '/home/cltbld', 09:01:48 INFO - 'LANG': 'en_US.UTF-8', 09:01:48 INFO - 'LANGUAGE': 'en_US:en', 09:01:48 INFO - 'LOGNAME': 'cltbld', 09:01:48 INFO - 'MAIL': '/var/mail/cltbld', 09:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:48 INFO - 'MOZ_NO_REMOTE': '1', 09:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:48 INFO - 'NO_EM_RESTART': '1', 09:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:48 INFO - 'PWD': '/builds/slave/test', 09:01:48 INFO - 'SHELL': '/bin/bash', 09:01:48 INFO - 'SHLVL': '1', 09:01:48 INFO - 'TERM': 'linux', 09:01:48 INFO - 'TMOUT': '86400', 09:01:48 INFO - 'USER': 'cltbld', 09:01:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:48 INFO - '_': '/tools/buildbot/bin/python'} 09:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:01:50 INFO - Installing collected packages: mozsystemmonitor 09:01:50 INFO - Running setup.py install for mozsystemmonitor 09:01:50 INFO - Successfully installed mozsystemmonitor 09:01:50 INFO - Cleaning up... 09:01:50 INFO - Return code: 0 09:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:01:50 INFO - Using env: {'DISPLAY': ':0', 09:01:50 INFO - 'HOME': '/home/cltbld', 09:01:50 INFO - 'LANG': 'en_US.UTF-8', 09:01:50 INFO - 'LANGUAGE': 'en_US:en', 09:01:50 INFO - 'LOGNAME': 'cltbld', 09:01:50 INFO - 'MAIL': '/var/mail/cltbld', 09:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:50 INFO - 'MOZ_NO_REMOTE': '1', 09:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:50 INFO - 'NO_EM_RESTART': '1', 09:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:50 INFO - 'PWD': '/builds/slave/test', 09:01:50 INFO - 'SHELL': '/bin/bash', 09:01:50 INFO - 'SHLVL': '1', 09:01:50 INFO - 'TERM': 'linux', 09:01:50 INFO - 'TMOUT': '86400', 09:01:50 INFO - 'USER': 'cltbld', 09:01:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:50 INFO - '_': '/tools/buildbot/bin/python'} 09:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:01:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:53 INFO - Downloading docopt-0.6.1.tar.gz 09:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:01:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:01:53 INFO - Running setup.py install for blobuploader 09:01:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:01:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:01:53 INFO - Running setup.py install for requests 09:01:53 INFO - Running setup.py install for docopt 09:01:53 INFO - Successfully installed blobuploader requests docopt 09:01:53 INFO - Cleaning up... 09:01:54 INFO - Return code: 0 09:01:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:01:54 INFO - Using env: {'DISPLAY': ':0', 09:01:54 INFO - 'HOME': '/home/cltbld', 09:01:54 INFO - 'LANG': 'en_US.UTF-8', 09:01:54 INFO - 'LANGUAGE': 'en_US:en', 09:01:54 INFO - 'LOGNAME': 'cltbld', 09:01:54 INFO - 'MAIL': '/var/mail/cltbld', 09:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:54 INFO - 'MOZ_NO_REMOTE': '1', 09:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:54 INFO - 'NO_EM_RESTART': '1', 09:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:54 INFO - 'PWD': '/builds/slave/test', 09:01:54 INFO - 'SHELL': '/bin/bash', 09:01:54 INFO - 'SHLVL': '1', 09:01:54 INFO - 'TERM': 'linux', 09:01:54 INFO - 'TMOUT': '86400', 09:01:54 INFO - 'USER': 'cltbld', 09:01:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:54 INFO - '_': '/tools/buildbot/bin/python'} 09:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:54 INFO - Running setup.py (path:/tmp/pip-IGB5di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:54 INFO - Running setup.py (path:/tmp/pip-aDMawt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:54 INFO - Running setup.py (path:/tmp/pip-zZRbhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:54 INFO - Running setup.py (path:/tmp/pip-yWN5nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:54 INFO - Running setup.py (path:/tmp/pip-QZLMbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:54 INFO - Running setup.py (path:/tmp/pip-rum5cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:54 INFO - Running setup.py (path:/tmp/pip-qTsKQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:54 INFO - Running setup.py (path:/tmp/pip-PhuExb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:54 INFO - Running setup.py (path:/tmp/pip-AE32ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:54 INFO - Running setup.py (path:/tmp/pip-pXwgPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:54 INFO - Running setup.py (path:/tmp/pip-kH5r57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:55 INFO - Running setup.py (path:/tmp/pip-9SJUJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:55 INFO - Running setup.py (path:/tmp/pip-pLkccO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:55 INFO - Running setup.py (path:/tmp/pip-GiLdRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:55 INFO - Running setup.py (path:/tmp/pip-paJWqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:55 INFO - Running setup.py (path:/tmp/pip-kC1jRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:55 INFO - Running setup.py (path:/tmp/pip-ouoiJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:01:55 INFO - Running setup.py install for manifestparser 09:01:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozcrash 09:01:55 INFO - Running setup.py install for mozdebug 09:01:55 INFO - Running setup.py install for mozdevice 09:01:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:01:55 INFO - Running setup.py install for mozfile 09:01:55 INFO - Running setup.py install for mozhttpd 09:01:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozinfo 09:01:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozInstall 09:01:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozleak 09:01:56 INFO - Running setup.py install for mozlog 09:01:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for moznetwork 09:01:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozprocess 09:01:56 INFO - Running setup.py install for mozprofile 09:01:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozrunner 09:01:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:56 INFO - Running setup.py install for mozscreenshot 09:01:57 INFO - Running setup.py install for moztest 09:01:57 INFO - Running setup.py install for mozversion 09:01:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:57 INFO - Cleaning up... 09:01:57 INFO - Return code: 0 09:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:01:57 INFO - Using env: {'DISPLAY': ':0', 09:01:57 INFO - 'HOME': '/home/cltbld', 09:01:57 INFO - 'LANG': 'en_US.UTF-8', 09:01:57 INFO - 'LANGUAGE': 'en_US:en', 09:01:57 INFO - 'LOGNAME': 'cltbld', 09:01:57 INFO - 'MAIL': '/var/mail/cltbld', 09:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:57 INFO - 'MOZ_NO_REMOTE': '1', 09:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:57 INFO - 'NO_EM_RESTART': '1', 09:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:57 INFO - 'PWD': '/builds/slave/test', 09:01:57 INFO - 'SHELL': '/bin/bash', 09:01:57 INFO - 'SHLVL': '1', 09:01:57 INFO - 'TERM': 'linux', 09:01:57 INFO - 'TMOUT': '86400', 09:01:57 INFO - 'USER': 'cltbld', 09:01:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:57 INFO - '_': '/tools/buildbot/bin/python'} 09:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:57 INFO - Running setup.py (path:/tmp/pip-rkee6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:57 INFO - Running setup.py (path:/tmp/pip-2jpWQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:57 INFO - Running setup.py (path:/tmp/pip-t46unf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:57 INFO - Running setup.py (path:/tmp/pip-h876rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:57 INFO - Running setup.py (path:/tmp/pip-nuJKqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:57 INFO - Running setup.py (path:/tmp/pip-SLqE8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:57 INFO - Running setup.py (path:/tmp/pip-GvChRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:57 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)) 09:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:57 INFO - Running setup.py (path:/tmp/pip-zebikr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:58 INFO - Running setup.py (path:/tmp/pip-fWFQEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:58 INFO - Running setup.py (path:/tmp/pip-LAYuzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:58 INFO - Running setup.py (path:/tmp/pip-skB5za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:58 INFO - Running setup.py (path:/tmp/pip-_o3Ze7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:58 INFO - Running setup.py (path:/tmp/pip-dFhsBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:58 INFO - Running setup.py (path:/tmp/pip-TvU47n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:58 INFO - Running setup.py (path:/tmp/pip-z_SwiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:58 INFO - Running setup.py (path:/tmp/pip-_jG6Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:58 INFO - Running setup.py (path:/tmp/pip-5Y3NAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:00 INFO - Downloading blessings-1.6.tar.gz 09:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:00 INFO - Installing collected packages: blessings 09:02:00 INFO - Running setup.py install for blessings 09:02:00 INFO - Successfully installed blessings 09:02:00 INFO - Cleaning up... 09:02:00 INFO - Return code: 0 09:02:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:01 INFO - Reading from file tmpfile_stdout 09:02:01 INFO - Current package versions: 09:02:01 INFO - argparse == 1.2.1 09:02:01 INFO - blessings == 1.6 09:02:01 INFO - blobuploader == 1.2.4 09:02:01 INFO - docopt == 0.6.1 09:02:01 INFO - manifestparser == 1.1 09:02:01 INFO - mozInstall == 1.12 09:02:01 INFO - mozcrash == 0.17 09:02:01 INFO - mozdebug == 0.1 09:02:01 INFO - mozdevice == 0.48 09:02:01 INFO - mozfile == 1.2 09:02:01 INFO - mozhttpd == 0.7 09:02:01 INFO - mozinfo == 0.9 09:02:01 INFO - mozleak == 0.1 09:02:01 INFO - mozlog == 3.1 09:02:01 INFO - moznetwork == 0.27 09:02:01 INFO - mozprocess == 0.22 09:02:01 INFO - mozprofile == 0.28 09:02:01 INFO - mozrunner == 6.11 09:02:01 INFO - mozscreenshot == 0.1 09:02:01 INFO - mozsystemmonitor == 0.0 09:02:01 INFO - moztest == 0.7 09:02:01 INFO - mozversion == 1.4 09:02:01 INFO - psutil == 3.1.1 09:02:01 INFO - requests == 1.2.3 09:02:01 INFO - wsgiref == 0.1.2 09:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:02:01 INFO - Using env: {'DISPLAY': ':0', 09:02:01 INFO - 'HOME': '/home/cltbld', 09:02:01 INFO - 'LANG': 'en_US.UTF-8', 09:02:01 INFO - 'LANGUAGE': 'en_US:en', 09:02:01 INFO - 'LOGNAME': 'cltbld', 09:02:01 INFO - 'MAIL': '/var/mail/cltbld', 09:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:01 INFO - 'MOZ_NO_REMOTE': '1', 09:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:01 INFO - 'NO_EM_RESTART': '1', 09:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:01 INFO - 'PWD': '/builds/slave/test', 09:02:01 INFO - 'SHELL': '/bin/bash', 09:02:01 INFO - 'SHLVL': '1', 09:02:01 INFO - 'TERM': 'linux', 09:02:01 INFO - 'TMOUT': '86400', 09:02:01 INFO - 'USER': 'cltbld', 09:02:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:01 INFO - '_': '/tools/buildbot/bin/python'} 09:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:02:01 INFO - Cleaning up... 09:02:01 INFO - Return code: 0 09:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:02:01 INFO - Using env: {'DISPLAY': ':0', 09:02:01 INFO - 'HOME': '/home/cltbld', 09:02:01 INFO - 'LANG': 'en_US.UTF-8', 09:02:01 INFO - 'LANGUAGE': 'en_US:en', 09:02:01 INFO - 'LOGNAME': 'cltbld', 09:02:01 INFO - 'MAIL': '/var/mail/cltbld', 09:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:01 INFO - 'MOZ_NO_REMOTE': '1', 09:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:01 INFO - 'NO_EM_RESTART': '1', 09:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:01 INFO - 'PWD': '/builds/slave/test', 09:02:01 INFO - 'SHELL': '/bin/bash', 09:02:01 INFO - 'SHLVL': '1', 09:02:01 INFO - 'TERM': 'linux', 09:02:01 INFO - 'TMOUT': '86400', 09:02:01 INFO - 'USER': 'cltbld', 09:02:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:01 INFO - '_': '/tools/buildbot/bin/python'} 09:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:01 INFO - Downloading/unpacking jsonschema 09:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:02:03 INFO - Downloading/unpacking functools32 (from jsonschema) 09:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:02:03 INFO - warning: no files found matching '*.txt' 09:02:03 INFO - no previously-included directories found matching 'build' 09:02:03 INFO - no previously-included directories found matching 'dist' 09:02:03 INFO - no previously-included directories found matching '.git*' 09:02:03 INFO - Installing collected packages: jsonschema, functools32 09:02:03 INFO - Running setup.py install for functools32 09:02:03 INFO - warning: no files found matching '*.txt' 09:02:03 INFO - no previously-included directories found matching 'build' 09:02:03 INFO - no previously-included directories found matching 'dist' 09:02:03 INFO - no previously-included directories found matching '.git*' 09:02:03 INFO - Successfully installed jsonschema functools32 09:02:03 INFO - Cleaning up... 09:02:03 INFO - Return code: 0 09:02:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:02:03 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')]} 09:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 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')]} 09:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 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 0x7fd974d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', '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 09:02:03 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 09:02:03 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 09:02:03 INFO - Using env: {'DISPLAY': ':0', 09:02:03 INFO - 'HOME': '/home/cltbld', 09:02:03 INFO - 'LANG': 'en_US.UTF-8', 09:02:03 INFO - 'LANGUAGE': 'en_US:en', 09:02:03 INFO - 'LOGNAME': 'cltbld', 09:02:03 INFO - 'MAIL': '/var/mail/cltbld', 09:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:03 INFO - 'MOZ_NO_REMOTE': '1', 09:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:03 INFO - 'NO_EM_RESTART': '1', 09:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:03 INFO - 'PWD': '/builds/slave/test', 09:02:03 INFO - 'SHELL': '/bin/bash', 09:02:03 INFO - 'SHLVL': '1', 09:02:03 INFO - 'TERM': 'linux', 09:02:03 INFO - 'TMOUT': '86400', 09:02:03 INFO - 'USER': 'cltbld', 09:02:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:03 INFO - '_': '/tools/buildbot/bin/python'} 09:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:04 INFO - Downloading/unpacking flake8 09:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:02:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:02:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:06 INFO - no previously-included directories found matching 'docs/_build' 09:02:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:02:06 INFO - Running setup.py install for pep8 09:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:02:06 INFO - no previously-included directories found matching 'docs/_build' 09:02:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:02:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:02:06 INFO - Cleaning up... 09:02:06 INFO - Return code: 0 09:02:06 INFO - Running post-action listener: _resource_record_post_action 09:02:06 INFO - Running post-action listener: _start_resource_monitoring 09:02:06 INFO - Starting resource monitoring. 09:02:06 INFO - ##### 09:02:06 INFO - ##### Running install step. 09:02:06 INFO - ##### 09:02:06 INFO - Running pre-action listener: _resource_record_pre_action 09:02:06 INFO - Running main action method: install 09:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:07 INFO - Reading from file tmpfile_stdout 09:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:02:07 INFO - Reading from file tmpfile_stdout 09:02:07 INFO - Output received: 09:02:07 INFO - Usage: mozinstall [options] installer 09:02:07 INFO - Options: 09:02:07 INFO - -h, --help show this help message and exit 09:02:07 INFO - -d DEST, --destination=DEST 09:02:07 INFO - Directory to install application into. [default: 09:02:07 INFO - "/builds/slave/test"] 09:02:07 INFO - --app=APP Application being installed. [default: firefox] 09:02:07 INFO - mkdir: /builds/slave/test/build/application 09:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:02:22 INFO - Reading from file tmpfile_stdout 09:02:22 INFO - Output received: 09:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:02:22 INFO - Running post-action listener: _resource_record_post_action 09:02:22 INFO - ##### 09:02:22 INFO - ##### Running run-tests step. 09:02:22 INFO - ##### 09:02:22 INFO - Running pre-action listener: _resource_record_pre_action 09:02:22 INFO - Running main action method: run_tests 09:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:02:22 INFO - Python 2.7.3 09:02:22 INFO - Return code: 0 09:02:22 INFO - grabbing minidump binary from tooltool 09:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:22 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 0x1d58410>, '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 0x1d59310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d597a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:02:22 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 09:02:22 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 09:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:22 INFO - Return code: 0 09:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:02:23 INFO - Return code: 0 09:02:23 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/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 09:02:23 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/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 09:02:23 INFO - Using env: {'DISPLAY': ':0', 09:02:23 INFO - 'HOME': '/home/cltbld', 09:02:23 INFO - 'LANG': 'en_US.UTF-8', 09:02:23 INFO - 'LANGUAGE': 'en_US:en', 09:02:23 INFO - 'LOGNAME': 'cltbld', 09:02:23 INFO - 'MAIL': '/var/mail/cltbld', 09:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:23 INFO - 'MOZ_NO_REMOTE': '1', 09:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:23 INFO - 'NO_EM_RESTART': '1', 09:02:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:23 INFO - 'PWD': '/builds/slave/test', 09:02:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:02:23 INFO - 'SHELL': '/bin/bash', 09:02:23 INFO - 'SHLVL': '1', 09:02:23 INFO - 'TERM': 'linux', 09:02:23 INFO - 'TMOUT': '86400', 09:02:23 INFO - 'USER': 'cltbld', 09:02:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590', 09:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:23 INFO - '_': '/tools/buildbot/bin/python'} 09:02:23 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/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 09:02:24 INFO - mozversion application_buildid: 20160414074538 09:02:24 INFO - mozversion application_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 09:02:24 INFO - mozversion application_display_name: Nightly 09:02:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:24 INFO - mozversion application_name: Firefox 09:02:24 INFO - mozversion application_remotingname: firefox 09:02:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:02:24 INFO - mozversion application_vendor: Mozilla 09:02:24 INFO - mozversion application_version: 48.0a1 09:02:24 INFO - mozversion platform_buildid: 20160414074538 09:02:24 INFO - mozversion platform_changeset: 995e7890dd613843c3914a1d9d46676f400152c1 09:02:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:02:24 INFO - mozversion platform_version: 48.0a1 09:02:24 INFO - using testdate: 1460649744 09:02:24 INFO - actual date: 1460649744 09:02:24 INFO - starting webserver on 'localhost:39645' 09:02:24 INFO - SUITE-START | Running 2 tests 09:02:24 INFO - TEST-START | dromaeo_css 09:02:24 INFO - operating with platform_type : linux_ 09:02:24 INFO - Initialising browser for dromaeo_css test... 09:02:24 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Rufgm/profile http://localhost:39645/getInfo.html) 09:02:29 INFO - PROCESS | 3318 | 09:02:29 INFO - PROCESS | 3318 | (process:3388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:29 INFO - PROCESS | 3318 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:02:30 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 09:02:30 INFO - PROCESS | 3318 | colorDepth:24 09:02:30 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 09:02:30 INFO - PROCESS | 3318 | __metrics 09:02:31 ERROR - PROCESS | 3318 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:02:31 INFO - TEST-INFO | 3318: exit 0 09:02:31 INFO - Browser initialized. 09:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:02:31 INFO - TEST-INFO | started process 3438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Rufgm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:33 INFO - PROCESS | 3438 | 09:02:33 INFO - PROCESS | 3438 | (process:3496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:02:43 INFO - PROCESS | 3438 | RSS: Main: 164241408 09:02:43 INFO - PROCESS | 3438 | 09:03:33 INFO - PROCESS | 3438 | 1460649813453 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] 09:05:45 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39645/tests/dromaeo/cssquery-ext.html) 09:05:46 INFO - PROCESS | 3438 | RSS: Main: 167424000 09:05:46 INFO - PROCESS | 3438 | 09:08:48 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-ext.html (next: http://localhost:39645/tests/dromaeo/cssquery-jquery.html) 09:08:49 INFO - PROCESS | 3438 | RSS: Main: 165318656 09:08:49 INFO - PROCESS | 3438 | 09:11:51 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39645/tests/dromaeo/cssquery-mootools.html) 09:11:51 INFO - PROCESS | 3438 | RSS: Main: 166965248 09:11:51 INFO - PROCESS | 3438 | 09:14:53 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39645/tests/dromaeo/cssquery-prototype.html) 09:14:54 INFO - PROCESS | 3438 | RSS: Main: 164786176 09:14:54 INFO - PROCESS | 3438 | 09:17:56 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39645/tests/dromaeo/cssquery-yui.html) 09:17:57 INFO - PROCESS | 3438 | RSS: Main: 165277696 09:17:57 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:39645/tests/dromaeo/cssquery-yui.html (next: http://localhost:39645/tests/dromaeo/cssquery-dojo.html) 09:21:00 INFO - PROCESS | 3438 | RSS: Main: 167563264 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | __start_tp_report 09:21:00 INFO - PROCESS | 3438 | _x_x_mozilla_page_load 09:21:00 INFO - PROCESS | 3438 | _x_x_mozilla_page_load_details 09:21:00 INFO - PROCESS | 3438 | |i|pagename|runs| 09:21:00 INFO - PROCESS | 3438 | |0;dojo.html;2646.126778163206;2726.563749800032;2757.2693236292384;2758.8896444142233;2773.5007698614254;4802.855914322571;4806.951930480698;4810.15822231109;4827.010462855115;4873.805047798084;4689.062187562484;4772.308015337774;4808.639352048593;4811.4226292844905;4888.926666100011;4359.455068116477;4450.844220452284;4453.844115455943;4455.331700244957;4476.149531588988;637.7376818103803;4037.702266167769;4284.892877678052;4320.719153255029;4415.80128894199;4360.062586543877;4360.236958532244;4373.562643735633;4394.3188805735;4402.581754733295;4353.695241333108;4362;4386.495553011381;4399.36209249657;4432.734035957853;4341.044970106572;4412.602865742098;4417.293233082723;4420.911581768379;4437.400950871655;4638.46657634373;4649.628029757611;4657.161710892038;4660.930086048712;4662.927526668851;4990.625703072248;5111.05445492585;5117.5650069744115;5117.84646460603;5163.044836705221;5157.535821776059;5173.689578625294;5186.818461353834;5208.5051920067535;5240.606954478391;4780.617550596014;4781.115493633689;4784.4497882743235;4802.279658051285;4843.709377437365;5104.18333066715;5201.921971170435;5248.8425347239645;5250.189631495246;5325.254464374991;4989.650724449326;5012.122878496249;5026.79892804291;5030.647854650212;5060.797568097309;5084.13569693153;5119.0529751996;5121.385433747974;5125.513076257749;5174.7930082796265;4997.90004199914;5025.39695236574;5079;5083.822066227664;5129;5080.847574572768;5088.440271570124;5129.454585233166;5129.666571672829;5132.743362831843;4327.307630779061;4330.696851220448;4330.848420305338;4373.016071383977;4384.649228061811;3682.705383569308;3712.201876596545;3733.1227161617;3836.2135762168687;3881.281962836828;4495.325701144789;4541.886452838706;4556.111558246176;4559.042601053749;4598.080383923162;5149.2791009258735;5154.690718556899;5157.974210128926;5158.071547121554;5165.560927321219;4395.582419670126;4489.483709373399;4538.455385353779;4559.475660299042;4583.427071616048;4554.95445045552;4581.65637577183;4585.899384147847;4601.8849528761375;4626.537346265414;4830.178869592178;4845.903081938412;4854.8786280341865;4864.902701946012;4901.411830580353;5037.546620804145;5136.460671629425;5194.74026298676;5234.842954711365;5235;4807.254875494304;4852.490488498657;4874.415070191458;4882;4904.558589726942;4914.901701966012;5079.5428411443145;5085.516875896784;5093.159628661378;5138.203578445347;5145.614078944169;5147.40804807452;5167.715775632376;5229.738513074407;5230.555402790653;4945.851624451272;4972.701637901738;4981.750912454435;4992.750362481789;5013.924791128063;4841.1285968526;4946.505349465168;4967.503249675004;4982.701037937735;4991.251312303184;4869.245266983623;4919.286703428054;4936.629752768485;4945.975270123627;4980.203167493184;5032.220005899091;5033.295338652519;5040.949590504048;5057.140286151437;5093.363329583802;4766.094442055998;4924.803007879645;4930.2604609307455;4987.625928055338;5028 09:21:00 INFO - PROCESS | 3438 | |1;ext.html;573.6414740787009;601.9428154325338;620.8665136995546;622.8816524860273;639.0063451333181;32775.83612081939;34054;34059.318813623715;34150.82924585377;34248.1437964051;34635.134121646974;35059.47410788834;35089.47365789515;35206.295874082505;35293.47059794105;7530.661120249588;7710.074791025085;7743.64486214913;7743.728969486069;7747.883781743279;7495.925040749577;7771.417143714216;7773.416993725465;7775.650095745705;7782.571958542278;7729.458937874351;7754.340881025091;7770.145284018753;7779.144294127642;7812.218778122199;7697.692092316301;7704.807379815494;7754.340881025119;7789.221077892222;7814.6483408246195;7719.421043421709;7785.883211751771;7802.375809935192;7816.452848300622;7823.2176782321885;29593.85203073971;34929.30141397158;35188.29623407543;35260.47109293363;35385.29229415423;2838.7870909681856;2934.193096898349;3002.8348440835744;3234.56333394991;3400.0989737719524;24132.155374561982;24331.148409805748;24402.633960490606;24439.511209775705;24691.38271543208;3213.453712868818;3229.8708051677904;3236.4659831127838;3290.3254832759226;3324.900252992414;149398;149808;150681.24659376743;151563;151677;31687.257200853714;31936.36127277488;31989.68010319867;31993.680063199536;32012.83993580064;32879.83560082184;58608;60662;60700;60852;14995.550133496012;15077.396904123712;15139.54581362561;15212.771808422882;15231.238438078051;11284.210105292716;11285.887141128647;11290.943545282222;11298.943505282421;11367.943160284145;18653.906730466533;18780.53048673767;18830.152643131092;18850.3402380916;18857;6904.896426553606;7058.329458701415;7126.645937271902;7167.390771784352;7270.854582908312;897.6902968475865;901.9909800901906;924.191332583989;945.8013817098349;994.0606127209862;27894.721052789617;28186.71813281882;28597.85701071481;28622.570661440095;29014.27464313409;1008.1128606825946;1011.8229309870743;1041.9739506512246;1065.1478816946412;1075.4300220882787;14539.709205816036;15249.923750381176;15335.233238338262;15368.224928892121;15425.460108896135;335538;344416;347006;347015;347444;49245.50754492481;50227.24659130116;50394.24408633873;50424;50561.74719126381;1224.369449733388;1257.8553466351304;1288.1948782011243;1294.4563283420987;1296.00415360344;26723.33191670224;27973;28284.15147545577;28640.713592863805;28641.42717145687;42737.78631106949;42922.14155716931;43250.78374608233;43316.35025474557;43341;321609;321979;322494;322841;324791;25419.87290063538;25550;25774;25801.354966125997;26027.609585855847;42531.57468425276;42753.100124951285;43032.35451468293;43696.344554832336;43729.56270437382;35851.64148358483;36010.4598431029;36127;36620;36851.81574092113;36432.45351319679;36554.8172259137;36746;36851.63148368482;36917.63082369142;32714.672853271164;34379;35897.28205435824;36410.27179456343;36898.63101368952;31641.36717265688;32529;32670;32759.836200818845;33119.50320745239;25696.743032569437;25851.83666734964;25976.480470390863;26305.60541591916;26618.33454163584 09:21:00 INFO - PROCESS | 3438 | |2;jquery.html;366.4027634955025;366.46130188622726;369.60821529179066;377.3264722470391;383.90594304395427;16788.664226715475;17093.82906170938;17938.73091903621;17948.461546153605;17980.100994950266;16585.66828663426;16910.492685219433;17467.388641397552;17577.73633395497;17655.646887062252;5068.49315068493;5218.2172674099;5241.135212689902;5244.056069907415;5252.52727254547;3641.380965235903;5578.63738856975;5889.087191485305;5941.257342832146;5942.405759424067;5650.858728531799;5857.355690874022;5863.472287494124;5867.70661466925;5873.618214816044;5852.707364631794;5856.590038697293;5886.735096920627;5887.205227294303;5915.142304365864;4524.524924882873;4899.730514821684;5043.848684539433;5103.515166059218;5110.540051395392;12311.815322770166;12427.254364738053;12539.435725392379;12556;17192.48422547313;1870.093004892626;1892.4890279624562;1901.1634880652468;1901.5246188452886;1920.1839218332152;9052.547372631341;9059.420990466133;9074.137956894085;9148.588313525906;9258.351915365927;1626.6868056521591;1636.6399392133712;1783.8394544490927;1784.357631252748;1850.500364901469;68183.65908170477;70469.6476517614;70644.64677676682;70716.6464167681;70842;9712.271579631555;9727.708168754949;10259.281850270409;10628;10878.945605272082;13979.09135906163;14008.159510429407;14044.648883777987;14110;14135.363908623931;6759.290274521203;6841.076454678654;6941.548799328028;6958.686859091252;6992.895106573405;6198.6280823150755;6202.534809889276;6249.937500625027;6293.559450838489;6302.653354065479;4259.787010649455;4261.722988005769;4313.0295683471595;4454.7549884756;4477.2164871147415;1632.3796957156205;1784.1436110666953;1827.45176447068;1846.2522678315304;1853.8691398247058;866.5840396609663;885.1458342699326;937.7936853892132;965.1940629574244;977.3256453047375;16484;16634.58413539671;16935.237914293888;17093;17112.401065962633;910.0762725833284;911.8951320598084;924.4083786376724;937.7889974755625;949.1837020162654;9068.682596109236;9371.203447707021;9454.347395523839;9462.858057129148;9517.095875891779;361689;365821;370361;372287;378844;79288.603556983;84629.57685211657;86087;86258;86461;1018.2261481274285;1018.7962407518526;1021.7292417509366;1045.9633912813015;1065.2064212161833;15861;15862.127582983047;15873.841261587237;15969.041857488588;16014.359425622844;33886.491702623985;35883.92348229557;36725.26549469049;36843.81578092092;37496.812515938334;45355.773221135;45653;45678;45758.54241457543;46138;7580.658870350737;7584.317411432998;7678.5392876427595;7683.0780306363595;7795.181505942021;8123.065847427385;10622.309549879234;11240.381779002233;11345.716357091138;11513.481893314653;9559.94840567551;9947.552360143956;9966.40201587907;10174.03346682064;10328.483575821328;4586.610138138296;8109.432339736398;8775.473471591726;9468.384555003902;9899.901000989898;10395.220358472994;10470.110040646327;10478.895211048097;10484.423356715453;10738.818310344543;7775.729906156724;7812.257835505618;7845.686172553034;7936.127026027248;8008.239217274349;9552.331336806357;10166.847497287694;10213.642522511676;10311.873479560893;10517.316374435637 09:21:00 INFO - PROCESS | 3438 | |3;mootools.html;1435.3612642374142;1479.6153000219942;1600.1599160440767;1754.60521382689;1799.532121648371;6900.7929762107215;7528.6235688215575;7662.846743065135;7878.881816772753;7895.763127106189;7657.310842024217;7659.387249020079;7703.49927254728;7742.187070357616;7747.1090824555195;2175.1299480207927;2207.459172502739;2219.411855858199;2220.057449731485;2221.31139346803;2151.741790985084;2159.5572907553915;2192.6162921488753;2203.3500117465305;2205.63607004844;2177.9128834846665;2204.0522575292616;2211.0492488230057;2217.6230040893006;2220.356096731946;2182.879941603211;2184.2682701295007;2192.1231507397088;2195.209724499179;2198.362474882282;2162.167565487283;2175.1516908405733;2186.387811412807;2186.8797216153107;2205.878676672782;7856.842863142762;7926.841463170705;7959.522428654242;7986.880196797053;8012.759617211493;4462.3975763271865;4599.264117741145;4602.401687780567;4606.654500912411;4607.539246075399;2873.5545990371525;2895.82625042496;2914.154895080424;2921.780866435026;2976.538636511344;920.4109370003204;936.840737074699;954.1603389017689;958.2046901072093;958.9089036541517;10123.088921996981;10142.645007424704;10155.28912976092;10188.439635820027;10249.33379330341;4128.938065929014;4146.647534959562;4278.037441575683;4284.67864910133;4303.548127446636;8781.385303028854;8781.473111613324;8783.736487905373;8784.077671844492;8790;4466.419365482467;4498.05540836428;4505.144022635689;4506.774661266923;4517.164324599959;3609.7653652512504;4051.817668204938;4083.4079058536345;4190.28765109932;4285.314349704033;3674.430463278196;3722.2555488902326;3800.771953682788;3811.123441608446;3826.311263972456;1240.274439452912;1246.993765031169;1248.0452453872795;1252.8872401483911;1267.340982689015;796.717165406284;891.2201823404521;897.0670502677273;902.5397047505819;928.865314529403;5295.819614885748;5331.893362132736;5506.174073888948;5621.381648018714;5653.660780353192;890.1587999340561;900.8648702694649;903.7379160043645;904.3850181876387;913.9314551408538;3623.61951995042;3809.8857034289017;3875.9224815504094;3887.5529314129235;3907.7459965102175;9105.135012173965;9502.477363744922;9640.951795241119;9942.204623630092;10071.647492337734;9302.53487325631;9471.715848524555;9480.431174129575;9524.809503809885;9558.904410955802;6992.54548454359;7118.679659415338;7126.144862616416;7132.4294056475355;7413.1104267488245;5562.694051827189;5581.051221292471;5644.181593668977;5644.8306550803545;5868.178455016387;9011.188992990663;9071.90928090737;9075.364724469488;9077.183053525214;9136.406133601295;8971.865422018544;9034.186923176945;9169.220616247694;9217.354785164975;9414.811703766023;6557.082008518716;6957.199922008831;7190.316919892602;7554.206808285271;7675.04061992251;7464.701411943462;7490.438217133846;7505.061867266591;7530;7585.658645361083;6579.2104947404705;6829.965850170916;6879.6560171992205;6931.930680693128;6954.47841411886;6711.9328806713265;6733.326667333424;6744.527883048336;6817.113775209191;6867.038614594061;6333.113364129118;6376.808695739135;6396.648184349905;6404.839879003062;6646.069550263063;4980.252962055576;5016.2224855147515;5036.346561858701;5075.822346217865;5085.694858308513;5066.189409694432;5077.949220507748;5086.364204474441;5118.43697193301;5143.048536020848 09:21:00 INFO - PROCESS | 3438 | |4;prototype.html;319.8113113263174;321.2434716243247;324.6412713951083;328.8273656330426;329.85816099077385;5378.300820893283;5379.246905433242;5413.431589683086;5464.26232458618;5494.120940649497;5369.543588794947;5373.838784836451;5377.489138531843;5388.380336261331;5388.407275199735;3981.1440540283834;4055.5944405559503;4191.2246234446575;4199.2651286024975;4199.475065616798;4179.226843034034;4189.601987811168;4196.202721482924;4208.263553878074;4214.557471465498;4155.4182414462;4177.12280421112;4180.916381672365;4190.2248084104385;4196.81114349855;4090.468239128924;4150.688698347606;4173.457450531442;4185.100203456272;4188.811503482335;3659.3230252403123;3673.1184515716036;3676.191237927652;3690.6309369063147;3690.8892733217776;5030.89938201234;5059.595232381401;5075.720835354054;5084.567811736007;5093.108705976476;4713.198756211452;4787.6648634595595;4818.34952281441;4821.397325334333;4831.202851529493;5590.91613625796;5611.859703507404;5630.662160270397;5638.859028524279;5648.876320286173;3986.800659967019;4012.4181993611055;4020.5376381716183;4024.537178224483;4029.174019326031;5754;5826.475617194473;5877.706904481008;5885.529157667376;5945.732442040118;4080.2655522006326;4107.116969851496;4118.732282401635;4124.237016152021;4130.524989626171;4184.058586818002;4208.032152604918;4210.431591735077;4227.661787057028;4236.533981262059;4670.193792059528;4769.833055843029;4786.545278198566;4793.041391721669;4794.832180873723;5633.774649014075;5648.915266271009;5669.469243304285;5680.801171958961;5688.288963879515;1463.5170393770031;1478.2534819915875;1480.5114312276924;1484.4136566056347;1487.910725356482;937.5031233446284;974.3325821812082;984.2814745235875;991.6231831903831;1011.4487604255698;4902.460729319772;4904.166291730415;4921.040397122527;4927.556519913153;4944.233643785219;5774.913376299359;5803.593748437654;5805.854853628609;5821.767129314865;5823.301203855564;4797.496262892416;4868.586170175504;4907.975460122677;4908.754562271872;4947.950520494749;3074.6156730408698;3089.1504836169784;3091.397177550356;3101.565780790691;3103.34829685764;5413.593980451482;5425.457454254543;5438.293021907127;5441.755121019563;5466.426025267369;5795.507381872504;5851.502622277069;5871.588988770831;5895.55783316253;5912.817436512714;5370.4361042090795;5422.75597598109;5447.373552041487;5449.918251226156;5469.741959349372;5623.550115990793;5747.1379293106365;5788.363280039108;5800.24596802413;5802.47777700009;5699.800506982236;5703.230063941481;5719.370869204301;5733.426657334233;5735.827925162252;5393.298871146726;5421.756020978986;5424.403315635198;5441.2654291670115;5471.890562188813;3803.2013277212095;4042.211768705192;4059.2748082064413;4156.501219853637;4176.4570605821045;5845;5871.2073870027;5886.087656413263;5887.470127688529;5887.735051922588;5668;5680.40355762639;5687.573431992534;5696.829095127153;5707.058335374617;5499.092649712753;5537.363203231519;5645.125005624135;5658.122990936411;5664.0937450007805;5296.285001524899;5525.668459892419;5548.0845660467185;5562.443755624567;5596.272484576979;5477.945220547744;5642.605017648725;5719.256496655408;5746.9712651436475;5749.195112684311;5592.679038199264;5597.076482380362;5604.523615492566;5623.859403514781;5634.549236061187 09:21:00 INFO - PROCESS | 3438 | |5;yui.html;662.907192992981;732.9335816387157;737.336397242482;790.833924875776;794.5828440068967;11051.226414151013;11574.53701851926;11639.301641901471;11658.417079146051;11692;11320.094392448606;11412.714682132952;11459.713507162325;11481.253718508291;11484.483198256077;632.0645444741762;809.0412860760018;821.0311832038193;824.0688022534528;827.0158511371479;793.0483419896148;821.7945513621595;822.3667775812621;824.2746383182791;824.6701319472199;843.1020962674762;845.6659619450313;850.8213275212213;854.150120629971;855.0722466124263;848.7326492154982;851.6976473351964;851.9787005324886;852.2755657690975;854.0690647194588;623.323693792236;625.9906101408483;626.0484064222402;626.5551458464496;626.8025571944822;11594.246373985749;11751.294922304603;11770.293782372999;11776.705582360424;11787;12699;12832.358382080858;12855.357232138356;12872.485100595964;12981;9869.654562090293;9926.2059035277;9929.90070099297;10196.74508137295;10254.897451025468;3318.8174650394217;3353.9496907546404;3360.8991730247885;3364.562606861117;3372.730181585467;43909.12181756347;44258.55741442609;44628.3305750414;44811.77594112041;45388.54611453876;9486.910994764397;9495;10113.69658910234;10130.645427410005;10245.180385569136;16914.661706765797;17051.914740426466;17073.231704573325;17200.31198752036;17225.65548689019;6704.698288577026;6925.792226233221;6952.791416257521;6964.408025317804;6991.126109236346;3619.2580520993133;3776.792276424823;3795.070207799052;3823.044238940265;3869.090763670535;2914.577386278978;2995.05655718448;2995.955060674092;3004.3090089279153;3015.9849200753856;548.8929658716592;549.5795716277051;555.8276934150426;557.631962904481;559.4712996218616;575.7351618255649;594.551113908996;601.5638661970037;613.1446631948407;616.202018386191;7395.334419902235;7595.202503737139;7655.961720191363;7904.960475197588;7961;500.3545426399976;526.4183077699164;554.3126523111313;622.0668996505242;622.6762083716442;3753.268112717994;3760.5863355030924;3775.8300876460626;3880.2239552089695;3908.7459315144993;49158.508414916105;49595.50404495981;49702.50297497051;49852;52579.21131183035;42002.369964450554;42067.57932420698;42464.78767606142;43571.56428435739;44669.10661786746;38925.41611875824;39180.608193917695;39473.80263098724;39637.20725585472;40104;7218.566885986857;7219.45854060937;7321.121465424183;7327.2672732726305;7494.850102997801;25096;26183.73816261813;27786.305342366602;28622.284442889093;28688.569671455363;33850.3229935395;34122.14694632654;34208.315833683686;34805.825970869984;34874;10683.51924163399;10706.89293107059;10901.182411319025;11057.668269951593;11077;11518.654440366803;11563.248388854698;11589.768204636028;11683.766324673628;11766.941165294118;11116.333020018501;11428.657140285804;11508.42457877086;11797.410129493663;11865.288082715064;10443.947780261355;10837.349759014485;10883.782324353628;10920.563177472812;10948.452577370941;10975.890241097806;11080.5567777288;11437.142214333791;11576.710582235512;11782.057435405319;9756.658516951873;9759.56081976327;9907.108360247612;9910.454924979196;10230.897691022994;9294;9486.383385079947;9547.33168678186;9651.420914745138;9757.609695612096 09:21:00 INFO - PROCESS | 3438 | __end_tp_report 09:21:00 INFO - PROCESS | 3438 | __start_cc_report 09:21:00 INFO - PROCESS | 3438 | _x_x_mozilla_cycle_collect,392 09:21:00 INFO - PROCESS | 3438 | __end_cc_report 09:21:00 INFO - PROCESS | 3438 | __startTimestamp1460650860466__endTimestamp 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | ------- Summary: start ------- 09:21:00 INFO - PROCESS | 3438 | Number of tests: 6 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#0] dojo.html Cycles:165 Average:4718.16 Median:4874.42 stddev:587.61 (12.1%) stddev-sans-first:566.49 09:21:00 INFO - PROCESS | 3438 | Values: 2646.1 2726.6 2757.3 2758.9 2773.5 4802.9 4807.0 4810.2 4827.0 4873.8 4689.1 4772.3 4808.6 4811.4 4888.9 4359.5 4450.8 4453.8 4455.3 4476.1 637.7 4037.7 4284.9 4320.7 4415.8 4360.1 4360.2 4373.6 4394.3 4402.6 4353.7 4362.0 4386.5 4399.4 4432.7 4341.0 4412.6 4417.3 4420.9 4437.4 4638.5 4649.6 4657.2 4660.9 4662.9 4990.6 5111.1 5117.6 5117.8 5163.0 5157.5 5173.7 5186.8 5208.5 5240.6 4780.6 4781.1 4784.4 4802.3 4843.7 5104.2 5201.9 5248.8 5250.2 5325.3 4989.7 5012.1 5026.8 5030.6 5060.8 5084.1 5119.1 5121.4 5125.5 5174.8 4997.9 5025.4 5079.0 5083.8 5129.0 5080.8 5088.4 5129.5 5129.7 5132.7 4327.3 4330.7 4330.8 4373.0 4384.6 3682.7 3712.2 3733.1 3836.2 3881.3 4495.3 4541.9 4556.1 4559.0 4598.1 5149.3 5154.7 5158.0 5158.1 5165.6 4395.6 4489.5 4538.5 4559.5 4583.4 4555.0 4581.7 4585.9 4601.9 4626.5 4830.2 4845.9 4854.9 4864.9 4901.4 5037.5 5136.5 5194.7 5234.8 5235.0 4807.3 4852.5 4874.4 4882.0 4904.6 4914.9 5079.5 5085.5 5093.2 5138.2 5145.6 5147.4 5167.7 5229.7 5230.6 4945.9 4972.7 4981.8 4992.8 5013.9 4841.1 4946.5 4967.5 4982.7 4991.3 4869.2 4919.3 4936.6 4946.0 4980.2 5032.2 5033.3 5040.9 5057.1 5093.4 4766.1 4924.8 4930.3 4987.6 5028.0 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#1] ext.html Cycles:180 Average:42602.65 Median:34056.66 stddev:75450.29 (221.5%) stddev-sans-first:75595.95 09:21:00 INFO - PROCESS | 3438 | Values: 573.6 601.9 620.9 622.9 639.0 32775.8 34054.0 34059.3 34150.8 34248.1 34635.1 35059.5 35089.5 35206.3 35293.5 7530.7 7710.1 7743.6 7743.7 7747.9 7495.9 7771.4 7773.4 7775.7 7782.6 7729.5 7754.3 7770.1 7779.1 7812.2 7697.7 7704.8 7754.3 7789.2 7814.6 7719.4 7785.9 7802.4 7816.5 7823.2 29593.9 34929.3 35188.3 35260.5 35385.3 2838.8 2934.2 3002.8 3234.6 3400.1 24132.2 24331.1 24402.6 24439.5 24691.4 3213.5 3229.9 3236.5 3290.3 3324.9 149398.0 149808.0 150681.2 151563.0 151677.0 31687.3 31936.4 31989.7 31993.7 32012.8 32879.8 58608.0 60662.0 60700.0 60852.0 14995.6 15077.4 15139.5 15212.8 15231.2 11284.2 11285.9 11290.9 11298.9 11367.9 18653.9 18780.5 18830.2 18850.3 18857.0 6904.9 7058.3 7126.6 7167.4 7270.9 897.7 902.0 924.2 945.8 994.1 27894.7 28186.7 28597.9 28622.6 29014.3 1008.1 1011.8 1042.0 1065.1 1075.4 14539.7 15249.9 15335.2 15368.2 15425.5 335538.0 344416.0 347006.0 347015.0 347444.0 49245.5 50227.2 50394.2 50424.0 50561.7 1224.4 1257.9 1288.2 1294.5 1296.0 26723.3 27973.0 28284.2 28640.7 28641.4 42737.8 42922.1 43250.8 43316.4 43341.0 321609.0 321979.0 322494.0 322841.0 324791.0 25419.9 25550.0 25774.0 25801.4 26027.6 42531.6 42753.1 43032.4 43696.3 43729.6 35851.6 36010.5 36127.0 36620.0 36851.8 36432.5 36554.8 36746.0 36851.6 36917.6 32714.7 34379.0 35897.3 36410.3 36898.6 31641.4 32529.0 32670.0 32759.8 33119.5 25696.7 25851.8 25976.5 26305.6 26618.3 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#2] jquery.html Cycles:180 Average:23569.92 Median:45504.39 stddev:61397.39 (134.9%) stddev-sans-first:61544.91 09:21:00 INFO - PROCESS | 3438 | Values: 366.4 366.5 369.6 377.3 383.9 16788.7 17093.8 17938.7 17948.5 17980.1 16585.7 16910.5 17467.4 17577.7 17655.6 5068.5 5218.2 5241.1 5244.1 5252.5 3641.4 5578.6 5889.1 5941.3 5942.4 5650.9 5857.4 5863.5 5867.7 5873.6 5852.7 5856.6 5886.7 5887.2 5915.1 4524.5 4899.7 5043.8 5103.5 5110.5 12311.8 12427.3 12539.4 12556.0 17192.5 1870.1 1892.5 1901.2 1901.5 1920.2 9052.5 9059.4 9074.1 9148.6 9258.4 1626.7 1636.6 1783.8 1784.4 1850.5 68183.7 70469.6 70644.6 70716.6 70842.0 9712.3 9727.7 10259.3 10628.0 10878.9 13979.1 14008.2 14044.6 14110.0 14135.4 6759.3 6841.1 6941.5 6958.7 6992.9 6198.6 6202.5 6249.9 6293.6 6302.7 4259.8 4261.7 4313.0 4454.8 4477.2 1632.4 1784.1 1827.5 1846.3 1853.9 866.6 885.1 937.8 965.2 977.3 16484.0 16634.6 16935.2 17093.0 17112.4 910.1 911.9 924.4 937.8 949.2 9068.7 9371.2 9454.3 9462.9 9517.1 361689.0 365821.0 370361.0 372287.0 378844.0 79288.6 84629.6 86087.0 86258.0 86461.0 1018.2 1018.8 1021.7 1046.0 1065.2 15861.0 15862.1 15873.8 15969.0 16014.4 33886.5 35883.9 36725.3 36843.8 37496.8 45355.8 45653.0 45678.0 45758.5 46138.0 7580.7 7584.3 7678.5 7683.1 7795.2 8123.1 10622.3 11240.4 11345.7 11513.5 9559.9 9947.6 9966.4 10174.0 10328.5 4586.6 8109.4 8775.5 9468.4 9899.9 10395.2 10470.1 10478.9 10484.4 10738.8 7775.7 7812.3 7845.7 7936.1 8008.2 9552.3 10166.8 10213.6 10311.9 10517.3 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#3] mootools.html Cycles:180 Average:5198.16 Median:5601.22 stddev:2834.80 (50.6%) stddev-sans-first:2828.65 09:21:00 INFO - PROCESS | 3438 | Values: 1435.4 1479.6 1600.2 1754.6 1799.5 6900.8 7528.6 7662.8 7878.9 7895.8 7657.3 7659.4 7703.5 7742.2 7747.1 2175.1 2207.5 2219.4 2220.1 2221.3 2151.7 2159.6 2192.6 2203.4 2205.6 2177.9 2204.1 2211.0 2217.6 2220.4 2182.9 2184.3 2192.1 2195.2 2198.4 2162.2 2175.2 2186.4 2186.9 2205.9 7856.8 7926.8 7959.5 7986.9 8012.8 4462.4 4599.3 4602.4 4606.7 4607.5 2873.6 2895.8 2914.2 2921.8 2976.5 920.4 936.8 954.2 958.2 958.9 10123.1 10142.6 10155.3 10188.4 10249.3 4128.9 4146.6 4278.0 4284.7 4303.5 8781.4 8781.5 8783.7 8784.1 8790.0 4466.4 4498.1 4505.1 4506.8 4517.2 3609.8 4051.8 4083.4 4190.3 4285.3 3674.4 3722.3 3800.8 3811.1 3826.3 1240.3 1247.0 1248.0 1252.9 1267.3 796.7 891.2 897.1 902.5 928.9 5295.8 5331.9 5506.2 5621.4 5653.7 890.2 900.9 903.7 904.4 913.9 3623.6 3809.9 3875.9 3887.6 3907.7 9105.1 9502.5 9641.0 9942.2 10071.6 9302.5 9471.7 9480.4 9524.8 9558.9 6992.5 7118.7 7126.1 7132.4 7413.1 5562.7 5581.1 5644.2 5644.8 5868.2 9011.2 9071.9 9075.4 9077.2 9136.4 8971.9 9034.2 9169.2 9217.4 9414.8 6557.1 6957.2 7190.3 7554.2 7675.0 7464.7 7490.4 7505.1 7530.0 7585.7 6579.2 6830.0 6879.7 6931.9 6954.5 6711.9 6733.3 6744.5 6817.1 6867.0 6333.1 6376.8 6396.6 6404.8 6646.1 4980.3 5016.2 5036.3 5075.8 5085.7 5066.2 5077.9 5086.4 5118.4 5143.0 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#4] prototype.html Cycles:180 Average:4677.09 Median:5377.89 stddev:1357.16 (25.2%) stddev-sans-first:1320.97 09:21:00 INFO - PROCESS | 3438 | Values: 319.8 321.2 324.6 328.8 329.9 5378.3 5379.2 5413.4 5464.3 5494.1 5369.5 5373.8 5377.5 5388.4 5388.4 3981.1 4055.6 4191.2 4199.3 4199.5 4179.2 4189.6 4196.2 4208.3 4214.6 4155.4 4177.1 4180.9 4190.2 4196.8 4090.5 4150.7 4173.5 4185.1 4188.8 3659.3 3673.1 3676.2 3690.6 3690.9 5030.9 5059.6 5075.7 5084.6 5093.1 4713.2 4787.7 4818.3 4821.4 4831.2 5590.9 5611.9 5630.7 5638.9 5648.9 3986.8 4012.4 4020.5 4024.5 4029.2 5754.0 5826.5 5877.7 5885.5 5945.7 4080.3 4107.1 4118.7 4124.2 4130.5 4184.1 4208.0 4210.4 4227.7 4236.5 4670.2 4769.8 4786.5 4793.0 4794.8 5633.8 5648.9 5669.5 5680.8 5688.3 1463.5 1478.3 1480.5 1484.4 1487.9 937.5 974.3 984.3 991.6 1011.4 4902.5 4904.2 4921.0 4927.6 4944.2 5774.9 5803.6 5805.9 5821.8 5823.3 4797.5 4868.6 4908.0 4908.8 4948.0 3074.6 3089.2 3091.4 3101.6 3103.3 5413.6 5425.5 5438.3 5441.8 5466.4 5795.5 5851.5 5871.6 5895.6 5912.8 5370.4 5422.8 5447.4 5449.9 5469.7 5623.6 5747.1 5788.4 5800.2 5802.5 5699.8 5703.2 5719.4 5733.4 5735.8 5393.3 5421.8 5424.4 5441.3 5471.9 3803.2 4042.2 4059.3 4156.5 4176.5 5845.0 5871.2 5886.1 5887.5 5887.7 5668.0 5680.4 5687.6 5696.8 5707.1 5499.1 5537.4 5645.1 5658.1 5664.1 5296.3 5525.7 5548.1 5562.4 5596.3 5477.9 5642.6 5719.3 5747.0 5749.2 5592.7 5597.1 5604.5 5623.9 5634.5 09:21:00 INFO - PROCESS | 3438 | 09:21:00 INFO - PROCESS | 3438 | [#5] yui.html Cycles:180 Average:12259.57 Median:41053.18 stddev:13498.90 (32.9%) stddev-sans-first:13508.67 09:21:00 INFO - PROCESS | 3438 | Values: 662.9 732.9 737.3 790.8 794.6 11051.2 11574.5 11639.3 11658.4 11692.0 11320.1 11412.7 11459.7 11481.3 11484.5 632.1 809.0 821.0 824.1 827.0 793.0 821.8 822.4 824.3 824.7 843.1 845.7 850.8 854.2 855.1 848.7 851.7 852.0 852.3 854.1 623.3 626.0 626.0 626.6 626.8 11594.2 11751.3 11770.3 11776.7 11787.0 12699.0 12832.4 12855.4 12872.5 12981.0 9869.7 9926.2 9929.9 10196.7 10254.9 3318.8 3353.9 3360.9 3364.6 3372.7 43909.1 44258.6 44628.3 44811.8 45388.5 9486.9 9495.0 10113.7 10130.6 10245.2 16914.7 17051.9 17073.2 17200.3 17225.7 6704.7 6925.8 6952.8 6964.4 6991.1 3619.3 3776.8 3795.1 3823.0 3869.1 2914.6 2995.1 2996.0 3004.3 3016.0 548.9 549.6 555.8 557.6 559.5 575.7 594.6 601.6 613.1 616.2 7395.3 7595.2 7656.0 7905.0 7961.0 500.4 526.4 554.3 622.1 622.7 3753.3 3760.6 3775.8 3880.2 3908.7 49158.5 49595.5 49702.5 49852.0 52579.2 42002.4 42067.6 42464.8 43571.6 44669.1 38925.4 39180.6 39473.8 39637.2 40104.0 7218.6 7219.5 7321.1 7327.3 7494.9 25096.0 26183.7 27786.3 28622.3 28688.6 33850.3 34122.1 34208.3 34805.8 34874.0 10683.5 10706.9 10901.2 11057.7 11077.0 11518.7 11563.2 11589.8 11683.8 11766.9 11116.3 11428.7 11508.4 11797.4 11865.3 10443.9 10837.3 10883.8 10920.6 10948.5 10975.9 11080.6 11437.1 11576.7 11782.1 9756.7 9759.6 9907.1 9910.5 10230.9 9294.0 9486.4 9547.3 9651.4 9757.6 09:21:00 INFO - PROCESS | 3438 | -------- Summary: end -------- 09:21:00 INFO - PROCESS | 3438 | 09:21:01 INFO - TEST-INFO | 3438: exit 0 09:21:01 INFO - TEST-OK | dromaeo_css | took 1116966ms 09:21:01 INFO - TEST-START | kraken 09:21:01 INFO - operating with platform_type : linux_ 09:21:01 INFO - Initialising browser for kraken test... 09:21:01 INFO - TEST-INFO | started process 3677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LKgr1/profile http://localhost:39645/getInfo.html) 09:21:05 INFO - PROCESS | 3677 | 09:21:05 INFO - PROCESS | 3677 | (process:3743): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:21:05 INFO - PROCESS | 3677 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:21:05 INFO - PROCESS | 3677 | __metrics Screen width/height:1600/1200 09:21:05 INFO - PROCESS | 3677 | colorDepth:24 09:21:05 INFO - PROCESS | 3677 | Browser inner width/height: 1024/697 09:21:05 INFO - PROCESS | 3677 | __metrics 09:21:06 ERROR - PROCESS | 3677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:21:07 INFO - TEST-INFO | 3677: exit 0 09:21:07 INFO - Browser initialized. 09:21:07 INFO - Running cycle 1/1 for kraken test... 09:21:07 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8LKgr1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:09 INFO - PROCESS | 3794 | 09:21:09 INFO - PROCESS | 3794 | (process:3852): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:21:19 INFO - PROCESS | 3794 | RSS: Main: 164335616 09:21:19 INFO - PROCESS | 3794 | 09:21:22 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39645/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:23 INFO - PROCESS | 3794 | RSS: Main: 168796160 09:21:23 INFO - PROCESS | 3794 | 09:21:25 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39645/tests/kraken/driver.html?testName=audio-dft) 09:21:26 INFO - PROCESS | 3794 | RSS: Main: 171900928 09:21:26 INFO - PROCESS | 3794 | 09:21:29 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39645/tests/kraken/driver.html?testName=audio-fft) 09:21:30 INFO - PROCESS | 3794 | RSS: Main: 162295808 09:21:30 INFO - PROCESS | 3794 | 09:21:32 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39645/tests/kraken/driver.html?testName=audio-oscillator) 09:21:32 INFO - PROCESS | 3794 | RSS: Main: 162721792 09:21:32 INFO - PROCESS | 3794 | 09:21:35 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39645/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:35 INFO - PROCESS | 3794 | RSS: Main: 164249600 09:21:35 INFO - PROCESS | 3794 | 09:21:38 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39645/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:39 INFO - PROCESS | 3794 | RSS: Main: 164311040 09:21:39 INFO - PROCESS | 3794 | 09:21:43 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39645/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:43 INFO - PROCESS | 3794 | RSS: Main: 163966976 09:21:43 INFO - PROCESS | 3794 | 09:21:46 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39645/tests/kraken/driver.html?testName=json-parse-financial) 09:21:47 INFO - PROCESS | 3794 | RSS: Main: 164397056 09:21:47 INFO - PROCESS | 3794 | 09:21:49 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39645/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:49 INFO - PROCESS | 3794 | RSS: Main: 165416960 09:21:49 INFO - PROCESS | 3794 | 09:21:51 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:52 INFO - PROCESS | 3794 | RSS: Main: 164782080 09:21:52 INFO - PROCESS | 3794 | 09:21:54 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:55 INFO - PROCESS | 3794 | RSS: Main: 165597184 09:21:55 INFO - PROCESS | 3794 | 09:21:58 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:58 INFO - PROCESS | 3794 | RSS: Main: 165855232 09:21:58 INFO - PROCESS | 3794 | 09:22:01 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:02 INFO - PROCESS | 3794 | RSS: Main: 165847040 09:22:02 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:39645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39645/tests/kraken/driver.html?testName=ai-astar) 09:22:04 INFO - PROCESS | 3794 | RSS: Main: 167268352 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | __start_tp_report 09:22:04 INFO - PROCESS | 3794 | _x_x_mozilla_page_load 09:22:04 INFO - PROCESS | 3794 | _x_x_mozilla_page_load_details 09:22:04 INFO - PROCESS | 3794 | |i|pagename|runs| 09:22:04 INFO - PROCESS | 3794 | |0;ai-astar;115;107;114;114;115;124;114;112;112;111 09:22:04 INFO - PROCESS | 3794 | |1;audio-beat-detection;154;133;159;180;141;155;160;136;185;137 09:22:04 INFO - PROCESS | 3794 | |2;audio-dft;161;166;165;166;167;162;161;162;165;163 09:22:04 INFO - PROCESS | 3794 | |3;audio-fft;75;73;77;152;76;74;74;79;151;78 09:22:04 INFO - PROCESS | 3794 | |4;audio-oscillator;94;94;146;94;94;94;139;94;94;140 09:22:04 INFO - PROCESS | 3794 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;118;121;117 09:22:04 INFO - PROCESS | 3794 | |6;imaging-darkroom;148;148;148;148;147;147;148;148;147;150 09:22:04 INFO - PROCESS | 3794 | |7;imaging-desaturate;96;96;100;96;96;96;97;96;96;95 09:22:04 INFO - PROCESS | 3794 | |8;json-parse-financial;74;66;75;69;68;67;68;86;67;64 09:22:04 INFO - PROCESS | 3794 | |9;json-stringify-tinderbox;66;65;66;65;66;66;67;66;65;66 09:22:04 INFO - PROCESS | 3794 | |10;stanford-crypto-aes;85;84;85;101;85;85;88;86;86;85 09:22:04 INFO - PROCESS | 3794 | |11;stanford-crypto-ccm;140;150;157;144;138;140;140;138;172;147 09:22:04 INFO - PROCESS | 3794 | |12;stanford-crypto-pbkdf2;180;185;177;177;179;176;194;177;180;176 09:22:04 INFO - PROCESS | 3794 | |13;stanford-crypto-sha256-iterative;73;75;73;72;72;77;72;75;73;72 09:22:04 INFO - PROCESS | 3794 | __end_tp_report 09:22:04 INFO - PROCESS | 3794 | __start_cc_report 09:22:04 INFO - PROCESS | 3794 | _x_x_mozilla_cycle_collect,895 09:22:04 INFO - PROCESS | 3794 | __end_cc_report 09:22:04 INFO - PROCESS | 3794 | __startTimestamp1460650924392__endTimestamp 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | ------- Summary: start ------- 09:22:04 INFO - PROCESS | 3794 | Number of tests: 14 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:4.32 (3.8%) stddev-sans-first:4.56 09:22:04 INFO - PROCESS | 3794 | Values: 115.0 107.0 114.0 114.0 115.0 124.0 114.0 112.0 112.0 111.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:157.00 stddev:18.02 (11.5%) stddev-sans-first:19.11 09:22:04 INFO - PROCESS | 3794 | Values: 154.0 133.0 159.0 180.0 141.0 155.0 160.0 136.0 185.0 137.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#2] audio-dft Cycles:10 Average:163.80 Median:165.00 stddev:2.25 (1.4%) stddev-sans-first:2.15 09:22:04 INFO - PROCESS | 3794 | Values: 161.0 166.0 165.0 166.0 167.0 162.0 161.0 162.0 165.0 163.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.50 stddev:31.99 (42.4%) stddev-sans-first:33.41 09:22:04 INFO - PROCESS | 3794 | Values: 75.0 73.0 77.0 152.0 76.0 74.0 74.0 79.0 151.0 78.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:23.09 (24.6%) stddev-sans-first:23.91 09:22:04 INFO - PROCESS | 3794 | Values: 94.0 94.0 146.0 94.0 94.0 94.0 139.0 94.0 94.0 140.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 09:22:04 INFO - PROCESS | 3794 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 121.0 117.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 09:22:04 INFO - PROCESS | 3794 | Values: 148.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 150.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 09:22:04 INFO - PROCESS | 3794 | Values: 96.0 96.0 100.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:68.50 stddev:6.45 (9.4%) stddev-sans-first:6.71 09:22:04 INFO - PROCESS | 3794 | Values: 74.0 66.0 75.0 69.0 68.0 67.0 68.0 86.0 67.0 64.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:22:04 INFO - PROCESS | 3794 | Values: 66.0 65.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 66.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:85.00 stddev:5.03 (5.9%) stddev-sans-first:5.29 09:22:04 INFO - PROCESS | 3794 | Values: 85.0 84.0 85.0 101.0 85.0 85.0 88.0 86.0 86.0 85.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:145.50 stddev:10.80 (7.4%) stddev-sans-first:11.19 09:22:04 INFO - PROCESS | 3794 | Values: 140.0 150.0 157.0 144.0 138.0 140.0 140.0 138.0 172.0 147.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:179.50 stddev:5.59 (3.1%) stddev-sans-first:5.93 09:22:04 INFO - PROCESS | 3794 | Values: 180.0 185.0 177.0 177.0 179.0 176.0 194.0 177.0 180.0 176.0 09:22:04 INFO - PROCESS | 3794 | 09:22:04 INFO - PROCESS | 3794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.00 stddev:1.71 (2.3%) stddev-sans-first:1.81 09:22:04 INFO - PROCESS | 3794 | Values: 73.0 75.0 73.0 72.0 72.0 77.0 72.0 75.0 73.0 72.0 09:22:04 INFO - PROCESS | 3794 | -------- Summary: end -------- 09:22:04 INFO - PROCESS | 3794 | 09:22:05 INFO - TEST-INFO | 3794: exit 0 09:22:05 INFO - TEST-OK | kraken | took 64159ms 09:22:05 INFO - SUITE-END | took 1181s 09:22:05 INFO - Completed test suite (00:19:41) 09:22:05 INFO - javascript benchmark 09:22:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.126778163206, 2726.563749800032, 2757.2693236292384, 2758.8896444142233, 2773.5007698614254, 4802.855914322571, 4806.951930480698, 4810.15822231109, 4827.010462855115, 4873.805047798084, 4689.062187562484, 4772.308015337774, 4808.639352048593, 4811.4226292844905, 4888.926666100011, 4359.455068116477, 4450.844220452284, 4453.844115455943, 4455.331700244957, 4476.149531588988, 637.7376818103803, 4037.702266167769, 4284.892877678052, 4320.719153255029, 4415.80128894199, 4360.062586543877, 4360.236958532244, 4373.562643735633, 4394.3188805735, 4402.581754733295, 4353.695241333108, 4362.0, 4386.495553011381, 4399.36209249657, 4432.734035957853, 4341.044970106572, 4412.602865742098, 4417.293233082723, 4420.911581768379, 4437.400950871655, 4638.46657634373, 4649.628029757611, 4657.161710892038, 4660.930086048712, 4662.927526668851, 4990.625703072248, 5111.05445492585, 5117.5650069744115, 5117.84646460603, 5163.044836705221, 5157.535821776059, 5173.689578625294, 5186.818461353834, 5208.5051920067535, 5240.606954478391, 4780.617550596014, 4781.115493633689, 4784.4497882743235, 4802.279658051285, 4843.709377437365, 5104.18333066715, 5201.921971170435, 5248.8425347239645, 5250.189631495246, 5325.254464374991, 4989.650724449326, 5012.122878496249, 5026.79892804291, 5030.647854650212, 5060.797568097309, 5084.13569693153, 5119.0529751996, 5121.385433747974, 5125.513076257749, 5174.7930082796265, 4997.90004199914, 5025.39695236574, 5079.0, 5083.822066227664, 5129.0, 5080.847574572768, 5088.440271570124, 5129.454585233166, 5129.666571672829, 5132.743362831843, 4327.307630779061, 4330.696851220448, 4330.848420305338, 4373.016071383977, 4384.649228061811, 3682.705383569308, 3712.201876596545, 3733.1227161617, 3836.2135762168687, 3881.281962836828, 4495.325701144789, 4541.886452838706, 4556.111558246176, 4559.042601053749, 4598.080383923162, 5149.2791009258735, 5154.690718556899, 5157.974210128926, 5158.071547121554, 5165.560927321219, 4395.582419670126, 4489.483709373399, 4538.455385353779, 4559.475660299042, 4583.427071616048, 4554.95445045552, 4581.65637577183, 4585.899384147847, 4601.8849528761375, 4626.537346265414, 4830.178869592178, 4845.903081938412, 4854.8786280341865, 4864.902701946012, 4901.411830580353, 5037.546620804145, 5136.460671629425, 5194.74026298676, 5234.842954711365, 5235.0, 4807.254875494304, 4852.490488498657, 4874.415070191458, 4882.0, 4904.558589726942, 4914.901701966012, 5079.5428411443145, 5085.516875896784, 5093.159628661378, 5138.203578445347, 5145.614078944169, 5147.40804807452, 5167.715775632376, 5229.738513074407, 5230.555402790653, 4945.851624451272, 4972.701637901738, 4981.750912454435, 4992.750362481789, 5013.924791128063, 4841.1285968526, 4946.505349465168, 4967.503249675004, 4982.701037937735, 4991.251312303184, 4869.245266983623, 4919.286703428054, 4936.629752768485, 4945.975270123627, 4980.203167493184, 5032.220005899091, 5033.295338652519, 5040.949590504048, 5057.140286151437, 5093.363329583802, 4766.094442055998, 4924.803007879645, 4930.2604609307455, 4987.625928055338, 5028.0], "value": 4682.607138521956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.6414740787009, 601.9428154325338, 620.8665136995546, 622.8816524860273, 639.0063451333181, 32775.83612081939, 34054.0, 34059.318813623715, 34150.82924585377, 34248.1437964051, 34635.134121646974, 35059.47410788834, 35089.47365789515, 35206.295874082505, 35293.47059794105, 7530.661120249588, 7710.074791025085, 7743.64486214913, 7743.728969486069, 7747.883781743279, 7495.925040749577, 7771.417143714216, 7773.416993725465, 7775.650095745705, 7782.571958542278, 7729.458937874351, 7754.340881025091, 7770.145284018753, 7779.144294127642, 7812.218778122199, 7697.692092316301, 7704.807379815494, 7754.340881025119, 7789.221077892222, 7814.6483408246195, 7719.421043421709, 7785.883211751771, 7802.375809935192, 7816.452848300622, 7823.2176782321885, 29593.85203073971, 34929.30141397158, 35188.29623407543, 35260.47109293363, 35385.29229415423, 2838.7870909681856, 2934.193096898349, 3002.8348440835744, 3234.56333394991, 3400.0989737719524, 24132.155374561982, 24331.148409805748, 24402.633960490606, 24439.511209775705, 24691.38271543208, 3213.453712868818, 3229.8708051677904, 3236.4659831127838, 3290.3254832759226, 3324.900252992414, 149398.0, 149808.0, 150681.24659376743, 151563.0, 151677.0, 31687.257200853714, 31936.36127277488, 31989.68010319867, 31993.680063199536, 32012.83993580064, 32879.83560082184, 58608.0, 60662.0, 60700.0, 60852.0, 14995.550133496012, 15077.396904123712, 15139.54581362561, 15212.771808422882, 15231.238438078051, 11284.210105292716, 11285.887141128647, 11290.943545282222, 11298.943505282421, 11367.943160284145, 18653.906730466533, 18780.53048673767, 18830.152643131092, 18850.3402380916, 18857.0, 6904.896426553606, 7058.329458701415, 7126.645937271902, 7167.390771784352, 7270.854582908312, 897.6902968475865, 901.9909800901906, 924.191332583989, 945.8013817098349, 994.0606127209862, 27894.721052789617, 28186.71813281882, 28597.85701071481, 28622.570661440095, 29014.27464313409, 1008.1128606825946, 1011.8229309870743, 1041.9739506512246, 1065.1478816946412, 1075.4300220882787, 14539.709205816036, 15249.923750381176, 15335.233238338262, 15368.224928892121, 15425.460108896135, 335538.0, 344416.0, 347006.0, 347015.0, 347444.0, 49245.50754492481, 50227.24659130116, 50394.24408633873, 50424.0, 50561.74719126381, 1224.369449733388, 1257.8553466351304, 1288.1948782011243, 1294.4563283420987, 1296.00415360344, 26723.33191670224, 27973.0, 28284.15147545577, 28640.713592863805, 28641.42717145687, 42737.78631106949, 42922.14155716931, 43250.78374608233, 43316.35025474557, 43341.0, 321609.0, 321979.0, 322494.0, 322841.0, 324791.0, 25419.87290063538, 25550.0, 25774.0, 25801.354966125997, 26027.609585855847, 42531.57468425276, 42753.100124951285, 43032.35451468293, 43696.344554832336, 43729.56270437382, 35851.64148358483, 36010.4598431029, 36127.0, 36620.0, 36851.81574092113, 36432.45351319679, 36554.8172259137, 36746.0, 36851.63148368482, 36917.63082369142, 32714.672853271164, 34379.0, 35897.28205435824, 36410.27179456343, 36898.63101368952, 31641.36717265688, 32529.0, 32670.0, 32759.836200818845, 33119.50320745239, 25696.743032569437, 25851.83666734964, 25976.480470390863, 26305.60541591916, 26618.33454163584], "value": 16907.36664060607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.4027634955025, 366.46130188622726, 369.60821529179066, 377.3264722470391, 383.90594304395427, 16788.664226715475, 17093.82906170938, 17938.73091903621, 17948.461546153605, 17980.100994950266, 16585.66828663426, 16910.492685219433, 17467.388641397552, 17577.73633395497, 17655.646887062252, 5068.49315068493, 5218.2172674099, 5241.135212689902, 5244.056069907415, 5252.52727254547, 3641.380965235903, 5578.63738856975, 5889.087191485305, 5941.257342832146, 5942.405759424067, 5650.858728531799, 5857.355690874022, 5863.472287494124, 5867.70661466925, 5873.618214816044, 5852.707364631794, 5856.590038697293, 5886.735096920627, 5887.205227294303, 5915.142304365864, 4524.524924882873, 4899.730514821684, 5043.848684539433, 5103.515166059218, 5110.540051395392, 12311.815322770166, 12427.254364738053, 12539.435725392379, 12556.0, 17192.48422547313, 1870.093004892626, 1892.4890279624562, 1901.1634880652468, 1901.5246188452886, 1920.1839218332152, 9052.547372631341, 9059.420990466133, 9074.137956894085, 9148.588313525906, 9258.351915365927, 1626.6868056521591, 1636.6399392133712, 1783.8394544490927, 1784.357631252748, 1850.500364901469, 68183.65908170477, 70469.6476517614, 70644.64677676682, 70716.6464167681, 70842.0, 9712.271579631555, 9727.708168754949, 10259.281850270409, 10628.0, 10878.945605272082, 13979.09135906163, 14008.159510429407, 14044.648883777987, 14110.0, 14135.363908623931, 6759.290274521203, 6841.076454678654, 6941.548799328028, 6958.686859091252, 6992.895106573405, 6198.6280823150755, 6202.534809889276, 6249.937500625027, 6293.559450838489, 6302.653354065479, 4259.787010649455, 4261.722988005769, 4313.0295683471595, 4454.7549884756, 4477.2164871147415, 1632.3796957156205, 1784.1436110666953, 1827.45176447068, 1846.2522678315304, 1853.8691398247058, 866.5840396609663, 885.1458342699326, 937.7936853892132, 965.1940629574244, 977.3256453047375, 16484.0, 16634.58413539671, 16935.237914293888, 17093.0, 17112.401065962633, 910.0762725833284, 911.8951320598084, 924.4083786376724, 937.7889974755625, 949.1837020162654, 9068.682596109236, 9371.203447707021, 9454.347395523839, 9462.858057129148, 9517.095875891779, 361689.0, 365821.0, 370361.0, 372287.0, 378844.0, 79288.603556983, 84629.57685211657, 86087.0, 86258.0, 86461.0, 1018.2261481274285, 1018.7962407518526, 1021.7292417509366, 1045.9633912813015, 1065.2064212161833, 15861.0, 15862.127582983047, 15873.841261587237, 15969.041857488588, 16014.359425622844, 33886.491702623985, 35883.92348229557, 36725.26549469049, 36843.81578092092, 37496.812515938334, 45355.773221135, 45653.0, 45678.0, 45758.54241457543, 46138.0, 7580.658870350737, 7584.317411432998, 7678.5392876427595, 7683.0780306363595, 7795.181505942021, 8123.065847427385, 10622.309549879234, 11240.381779002233, 11345.716357091138, 11513.481893314653, 9559.94840567551, 9947.552360143956, 9966.40201587907, 10174.03346682064, 10328.483575821328, 4586.610138138296, 8109.432339736398, 8775.473471591726, 9468.384555003902, 9899.901000989898, 10395.220358472994, 10470.110040646327, 10478.895211048097, 10484.423356715453, 10738.818310344543, 7775.729906156724, 7812.257835505618, 7845.686172553034, 7936.127026027248, 8008.239217274349, 9552.331336806357, 10166.847497287694, 10213.642522511676, 10311.873479560893, 10517.316374435637], "value": 8083.634024920642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.3612642374142, 1479.6153000219942, 1600.1599160440767, 1754.60521382689, 1799.532121648371, 6900.7929762107215, 7528.6235688215575, 7662.846743065135, 7878.881816772753, 7895.763127106189, 7657.310842024217, 7659.387249020079, 7703.49927254728, 7742.187070357616, 7747.1090824555195, 2175.1299480207927, 2207.459172502739, 2219.411855858199, 2220.057449731485, 2221.31139346803, 2151.741790985084, 2159.5572907553915, 2192.6162921488753, 2203.3500117465305, 2205.63607004844, 2177.9128834846665, 2204.0522575292616, 2211.0492488230057, 2217.6230040893006, 2220.356096731946, 2182.879941603211, 2184.2682701295007, 2192.1231507397088, 2195.209724499179, 2198.362474882282, 2162.167565487283, 2175.1516908405733, 2186.387811412807, 2186.8797216153107, 2205.878676672782, 7856.842863142762, 7926.841463170705, 7959.522428654242, 7986.880196797053, 8012.759617211493, 4462.3975763271865, 4599.264117741145, 4602.401687780567, 4606.654500912411, 4607.539246075399, 2873.5545990371525, 2895.82625042496, 2914.154895080424, 2921.780866435026, 2976.538636511344, 920.4109370003204, 936.840737074699, 954.1603389017689, 958.2046901072093, 958.9089036541517, 10123.088921996981, 10142.645007424704, 10155.28912976092, 10188.439635820027, 10249.33379330341, 4128.938065929014, 4146.647534959562, 4278.037441575683, 4284.67864910133, 4303.548127446636, 8781.385303028854, 8781.473111613324, 8783.736487905373, 8784.077671844492, 8790.0, 4466.419365482467, 4498.05540836428, 4505.144022635689, 4506.774661266923, 4517.164324599959, 3609.7653652512504, 4051.817668204938, 4083.4079058536345, 4190.28765109932, 4285.314349704033, 3674.430463278196, 3722.2555488902326, 3800.771953682788, 3811.123441608446, 3826.311263972456, 1240.274439452912, 1246.993765031169, 1248.0452453872795, 1252.8872401483911, 1267.340982689015, 796.717165406284, 891.2201823404521, 897.0670502677273, 902.5397047505819, 928.865314529403, 5295.819614885748, 5331.893362132736, 5506.174073888948, 5621.381648018714, 5653.660780353192, 890.1587999340561, 900.8648702694649, 903.7379160043645, 904.3850181876387, 913.9314551408538, 3623.61951995042, 3809.8857034289017, 3875.9224815504094, 3887.5529314129235, 3907.7459965102175, 9105.135012173965, 9502.477363744922, 9640.951795241119, 9942.204623630092, 10071.647492337734, 9302.53487325631, 9471.715848524555, 9480.431174129575, 9524.809503809885, 9558.904410955802, 6992.54548454359, 7118.679659415338, 7126.144862616416, 7132.4294056475355, 7413.1104267488245, 5562.694051827189, 5581.051221292471, 5644.181593668977, 5644.8306550803545, 5868.178455016387, 9011.188992990663, 9071.90928090737, 9075.364724469488, 9077.183053525214, 9136.406133601295, 8971.865422018544, 9034.186923176945, 9169.220616247694, 9217.354785164975, 9414.811703766023, 6557.082008518716, 6957.199922008831, 7190.316919892602, 7554.206808285271, 7675.04061992251, 7464.701411943462, 7490.438217133846, 7505.061867266591, 7530.0, 7585.658645361083, 6579.2104947404705, 6829.965850170916, 6879.6560171992205, 6931.930680693128, 6954.47841411886, 6711.9328806713265, 6733.326667333424, 6744.527883048336, 6817.113775209191, 6867.038614594061, 6333.113364129118, 6376.808695739135, 6396.648184349905, 6404.839879003062, 6646.069550263063, 4980.252962055576, 5016.2224855147515, 5036.346561858701, 5075.822346217865, 5085.694858308513, 5066.189409694432, 5077.949220507748, 5086.364204474441, 5118.43697193301, 5143.048536020848], "value": 4222.450607283508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8113113263174, 321.2434716243247, 324.6412713951083, 328.8273656330426, 329.85816099077385, 5378.300820893283, 5379.246905433242, 5413.431589683086, 5464.26232458618, 5494.120940649497, 5369.543588794947, 5373.838784836451, 5377.489138531843, 5388.380336261331, 5388.407275199735, 3981.1440540283834, 4055.5944405559503, 4191.2246234446575, 4199.2651286024975, 4199.475065616798, 4179.226843034034, 4189.601987811168, 4196.202721482924, 4208.263553878074, 4214.557471465498, 4155.4182414462, 4177.12280421112, 4180.916381672365, 4190.2248084104385, 4196.81114349855, 4090.468239128924, 4150.688698347606, 4173.457450531442, 4185.100203456272, 4188.811503482335, 3659.3230252403123, 3673.1184515716036, 3676.191237927652, 3690.6309369063147, 3690.8892733217776, 5030.89938201234, 5059.595232381401, 5075.720835354054, 5084.567811736007, 5093.108705976476, 4713.198756211452, 4787.6648634595595, 4818.34952281441, 4821.397325334333, 4831.202851529493, 5590.91613625796, 5611.859703507404, 5630.662160270397, 5638.859028524279, 5648.876320286173, 3986.800659967019, 4012.4181993611055, 4020.5376381716183, 4024.537178224483, 4029.174019326031, 5754.0, 5826.475617194473, 5877.706904481008, 5885.529157667376, 5945.732442040118, 4080.2655522006326, 4107.116969851496, 4118.732282401635, 4124.237016152021, 4130.524989626171, 4184.058586818002, 4208.032152604918, 4210.431591735077, 4227.661787057028, 4236.533981262059, 4670.193792059528, 4769.833055843029, 4786.545278198566, 4793.041391721669, 4794.832180873723, 5633.774649014075, 5648.915266271009, 5669.469243304285, 5680.801171958961, 5688.288963879515, 1463.5170393770031, 1478.2534819915875, 1480.5114312276924, 1484.4136566056347, 1487.910725356482, 937.5031233446284, 974.3325821812082, 984.2814745235875, 991.6231831903831, 1011.4487604255698, 4902.460729319772, 4904.166291730415, 4921.040397122527, 4927.556519913153, 4944.233643785219, 5774.913376299359, 5803.593748437654, 5805.854853628609, 5821.767129314865, 5823.301203855564, 4797.496262892416, 4868.586170175504, 4907.975460122677, 4908.754562271872, 4947.950520494749, 3074.6156730408698, 3089.1504836169784, 3091.397177550356, 3101.565780790691, 3103.34829685764, 5413.593980451482, 5425.457454254543, 5438.293021907127, 5441.755121019563, 5466.426025267369, 5795.507381872504, 5851.502622277069, 5871.588988770831, 5895.55783316253, 5912.817436512714, 5370.4361042090795, 5422.75597598109, 5447.373552041487, 5449.918251226156, 5469.741959349372, 5623.550115990793, 5747.1379293106365, 5788.363280039108, 5800.24596802413, 5802.47777700009, 5699.800506982236, 5703.230063941481, 5719.370869204301, 5733.426657334233, 5735.827925162252, 5393.298871146726, 5421.756020978986, 5424.403315635198, 5441.2654291670115, 5471.890562188813, 3803.2013277212095, 4042.211768705192, 4059.2748082064413, 4156.501219853637, 4176.4570605821045, 5845.0, 5871.2073870027, 5886.087656413263, 5887.470127688529, 5887.735051922588, 5668.0, 5680.40355762639, 5687.573431992534, 5696.829095127153, 5707.058335374617, 5499.092649712753, 5537.363203231519, 5645.125005624135, 5658.122990936411, 5664.0937450007805, 5296.285001524899, 5525.668459892419, 5548.0845660467185, 5562.443755624567, 5596.272484576979, 5477.945220547744, 5642.605017648725, 5719.256496655408, 5746.9712651436475, 5749.195112684311, 5592.679038199264, 5597.076482380362, 5604.523615492566, 5623.859403514781, 5634.549236061187], "value": 4246.336043413113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.907192992981, 732.9335816387157, 737.336397242482, 790.833924875776, 794.5828440068967, 11051.226414151013, 11574.53701851926, 11639.301641901471, 11658.417079146051, 11692.0, 11320.094392448606, 11412.714682132952, 11459.713507162325, 11481.253718508291, 11484.483198256077, 632.0645444741762, 809.0412860760018, 821.0311832038193, 824.0688022534528, 827.0158511371479, 793.0483419896148, 821.7945513621595, 822.3667775812621, 824.2746383182791, 824.6701319472199, 843.1020962674762, 845.6659619450313, 850.8213275212213, 854.150120629971, 855.0722466124263, 848.7326492154982, 851.6976473351964, 851.9787005324886, 852.2755657690975, 854.0690647194588, 623.323693792236, 625.9906101408483, 626.0484064222402, 626.5551458464496, 626.8025571944822, 11594.246373985749, 11751.294922304603, 11770.293782372999, 11776.705582360424, 11787.0, 12699.0, 12832.358382080858, 12855.357232138356, 12872.485100595964, 12981.0, 9869.654562090293, 9926.2059035277, 9929.90070099297, 10196.74508137295, 10254.897451025468, 3318.8174650394217, 3353.9496907546404, 3360.8991730247885, 3364.562606861117, 3372.730181585467, 43909.12181756347, 44258.55741442609, 44628.3305750414, 44811.77594112041, 45388.54611453876, 9486.910994764397, 9495.0, 10113.69658910234, 10130.645427410005, 10245.180385569136, 16914.661706765797, 17051.914740426466, 17073.231704573325, 17200.31198752036, 17225.65548689019, 6704.698288577026, 6925.792226233221, 6952.791416257521, 6964.408025317804, 6991.126109236346, 3619.2580520993133, 3776.792276424823, 3795.070207799052, 3823.044238940265, 3869.090763670535, 2914.577386278978, 2995.05655718448, 2995.955060674092, 3004.3090089279153, 3015.9849200753856, 548.8929658716592, 549.5795716277051, 555.8276934150426, 557.631962904481, 559.4712996218616, 575.7351618255649, 594.551113908996, 601.5638661970037, 613.1446631948407, 616.202018386191, 7395.334419902235, 7595.202503737139, 7655.961720191363, 7904.960475197588, 7961.0, 500.3545426399976, 526.4183077699164, 554.3126523111313, 622.0668996505242, 622.6762083716442, 3753.268112717994, 3760.5863355030924, 3775.8300876460626, 3880.2239552089695, 3908.7459315144993, 49158.508414916105, 49595.50404495981, 49702.50297497051, 49852.0, 52579.21131183035, 42002.369964450554, 42067.57932420698, 42464.78767606142, 43571.56428435739, 44669.10661786746, 38925.41611875824, 39180.608193917695, 39473.80263098724, 39637.20725585472, 40104.0, 7218.566885986857, 7219.45854060937, 7321.121465424183, 7327.2672732726305, 7494.850102997801, 25096.0, 26183.73816261813, 27786.305342366602, 28622.284442889093, 28688.569671455363, 33850.3229935395, 34122.14694632654, 34208.315833683686, 34805.825970869984, 34874.0, 10683.51924163399, 10706.89293107059, 10901.182411319025, 11057.668269951593, 11077.0, 11518.654440366803, 11563.248388854698, 11589.768204636028, 11683.766324673628, 11766.941165294118, 11116.333020018501, 11428.657140285804, 11508.42457877086, 11797.410129493663, 11865.288082715064, 10443.947780261355, 10837.349759014485, 10883.782324353628, 10920.563177472812, 10948.452577370941, 10975.890241097806, 11080.5567777288, 11437.142214333791, 11576.710582235512, 11782.057435405319, 9756.658516951873, 9759.56081976327, 9907.108360247612, 9910.454924979196, 10230.897691022994, 9294.0, 9486.383385079947, 9547.33168678186, 9651.420914745138, 9757.609695612096], "value": 5869.728749402074, "unit": "score"}], "name": "dromaeo_css", "value": 6378.7416138565895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 114.0, 114.0, 115.0, 124.0, 114.0, 112.0, 112.0, 111.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 159.0, 180.0, 141.0, 155.0, 160.0, 136.0, 185.0, 137.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 165.0, 166.0, 167.0, 162.0, 161.0, 162.0, 165.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 77.0, 152.0, 76.0, 74.0, 74.0, 79.0, 151.0, 78.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 146.0, 94.0, 94.0, 94.0, 139.0, 94.0, 94.0, 140.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 121.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 150.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 100.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 75.0, 69.0, 68.0, 67.0, 68.0, 86.0, 67.0, 64.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 101.0, 85.0, 85.0, 88.0, 86.0, 86.0, 85.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 157.0, 144.0, 138.0, 140.0, 140.0, 138.0, 172.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 177.0, 177.0, 179.0, 176.0, 194.0, 177.0, 180.0, 176.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 72.0, 72.0, 77.0, 72.0, 75.0, 73.0, 72.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1616.2999999999997, "alertThreshold": 2.0}]} 09:22:05 INFO - Return code: 0 09:22:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:22:05 ERROR - # TBPL SUCCESS # 09:22:05 INFO - Running post-action listener: _resource_record_post_action 09:22:05 INFO - Running post-run listener: _resource_record_post_run 09:22:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7667712; Write bytes: 353591296; Read time: 848; Write time: 199340 09:22:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 74817536; Read time: 0; Write time: 33688 09:22:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 7172096; Write bytes: 278773760; Read time: 820; Write time: 165652 09:22:06 INFO - Running post-run listener: _upload_blobber_files 09:22:06 INFO - Blob upload gear active. 09:22:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:22:06 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:22:06 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:22:06 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:22:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:07 INFO - (blobuploader) - INFO - Done attempting. 09:22:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:22:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:08 INFO - (blobuploader) - INFO - Done attempting. 09:22:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:22:08 INFO - Return code: 0 09:22:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:22:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:22:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b969cf1a85f35d8d05df5e10ce924edafe430d641b13380d68ec32e8108fb3764fb03998e6c757e02177d656a6af3d1f0efe0bfb58a771e1871dd103075f3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7539ddd9e9317ddaa83e8b88815aee29ecfeffd725a1bdbfec143ec11ff4d27282cd80323a69f1fc1f4ef659bae0aec294019e41f0302f0ece78b28283c0b37"} 09:22:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:22:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:22:08 INFO - Contents: 09:22:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b969cf1a85f35d8d05df5e10ce924edafe430d641b13380d68ec32e8108fb3764fb03998e6c757e02177d656a6af3d1f0efe0bfb58a771e1871dd103075f3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7539ddd9e9317ddaa83e8b88815aee29ecfeffd725a1bdbfec143ec11ff4d27282cd80323a69f1fc1f4ef659bae0aec294019e41f0302f0ece78b28283c0b37"} 09:22:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:22:08 INFO - Copying logs to upload dir... 09:22:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:22:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.074220 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-14 09:22:09.130847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:09.138833) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 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/7b969cf1a85f35d8d05df5e10ce924edafe430d641b13380d68ec32e8108fb3764fb03998e6c757e02177d656a6af3d1f0efe0bfb58a771e1871dd103075f3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7539ddd9e9317ddaa83e8b88815aee29ecfeffd725a1bdbfec143ec11ff4d27282cd80323a69f1fc1f4ef659bae0aec294019e41f0302f0ece78b28283c0b37"} build_url:https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/M231uVHtT223nVzRbPAm_A/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/7b969cf1a85f35d8d05df5e10ce924edafe430d641b13380d68ec32e8108fb3764fb03998e6c757e02177d656a6af3d1f0efe0bfb58a771e1871dd103075f3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e7539ddd9e9317ddaa83e8b88815aee29ecfeffd725a1bdbfec143ec11ff4d27282cd80323a69f1fc1f4ef659bae0aec294019e41f0302f0ece78b28283c0b37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:09.166031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:09.166425) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460646932.809336-1252276590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 09:22:09.441160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:22:09.444618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 09:22:09.445008) ========= ========= Total master_lag: 0.73 =========