builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1453306734.48 results: success (0) buildid: 20160120071126 builduid: c79ee04d3d444aad95e38b18b76197ec revision: 92016fe68730f7f2257fb9a12b242fb85c541fa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.477395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.477891) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.478200) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.501415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.501761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.515435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.515857) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.565241) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.565566) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.566042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.566347) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 08:18:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-01-20 08:18:54 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.703690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.704011) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:54.753695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 08:18:54.754051) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92016fe68730f7f2257fb9a12b242fb85c541fa7 --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 92016fe68730f7f2257fb9a12b242fb85c541fa7 --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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 08:18:55,099 truncating revision to first 12 chars 2016-01-20 08:18:55,099 Setting DEBUG logging. 2016-01-20 08:18:55,099 attempt 1/10 2016-01-20 08:18:55,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92016fe68730?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 08:18:55,781 unpacking tar archive at: fx-team-92016fe68730/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 08:18:56.059218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.059868) ========= echo 92016fe68730f7f2257fb9a12b242fb85c541fa7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'92016fe68730f7f2257fb9a12b242fb85c541fa7'] 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 92016fe68730f7f2257fb9a12b242fb85c541fa7 program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: '92016fe68730f7f2257fb9a12b242fb85c541fa7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.112126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.112494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.123379) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.123791) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/92016fe68730f7f2257fb9a12b242fb85c541fa7 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 08:18:56.124259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-20 08:18:56.124553) ========= /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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:56 INFO - MultiFileLogger online at 20160120 08:18:56 in /builds/slave/test 08:18:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:18:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:56 INFO - {'append_to_log': False, 08:18:56 INFO - 'base_work_dir': '/builds/slave/test', 08:18:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:18:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:56 INFO - 'branch': 'Fx-Team-Non-PGO', 08:18:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:56 INFO - 'config_files': ('talos/linux_config.py',), 08:18:56 INFO - 'default_actions': ('clobber', 08:18:56 INFO - 'read-buildbot-config', 08:18:56 INFO - 'download-and-extract', 08:18:56 INFO - 'populate-webroot', 08:18:56 INFO - 'create-virtualenv', 08:18:56 INFO - 'install', 08:18:56 INFO - 'run-tests'), 08:18:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:56 INFO - 'download_minidump_stackwalk': True, 08:18:56 INFO - 'download_symbols': 'ondemand', 08:18:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:56 INFO - 'installer_path': 'installer.exe', 08:18:56 INFO - 'log_level': 'info', 08:18:56 INFO - 'log_name': 'talos', 08:18:56 INFO - 'log_to_console': True, 08:18:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:56 INFO - 'opt_config_files': (), 08:18:56 INFO - 'pip_index': False, 08:18:56 INFO - 'sps_profile': False, 08:18:56 INFO - 'sps_profile_interval': 0, 08:18:56 INFO - 'suite': 'dromaeojs-e10s', 08:18:56 INFO - 'system_bits': '32', 08:18:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:56 INFO - 'title': 'talos-linux64-ix-030', 08:18:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:56 INFO - 'use_talos_json': True, 08:18:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:56 INFO - 'work_dir': 'build'} 08:18:56 INFO - ##### 08:18:56 INFO - ##### Running clobber step. 08:18:56 INFO - ##### 08:18:56 INFO - Running pre-action listener: _resource_record_pre_action 08:18:56 INFO - Running main action method: clobber 08:18:56 INFO - rmtree: /builds/slave/test/build 08:18:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:57 INFO - Running post-action listener: _resource_record_post_action 08:18:57 INFO - ##### 08:18:57 INFO - ##### Running read-buildbot-config step. 08:18:57 INFO - ##### 08:18:57 INFO - Running pre-action listener: _resource_record_pre_action 08:18:57 INFO - Running main action method: read_buildbot_config 08:18:57 INFO - Using buildbot properties: 08:18:57 INFO - { 08:18:57 INFO - "project": "", 08:18:57 INFO - "product": "firefox", 08:18:57 INFO - "script_repo_revision": "production", 08:18:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:18:57 INFO - "repository": "", 08:18:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:18:57 INFO - "buildid": "20160120071126", 08:18:57 INFO - "pgo_build": "False", 08:18:57 INFO - "basedir": "/builds/slave/test", 08:18:57 INFO - "buildnumber": 672, 08:18:57 INFO - "slavename": "talos-linux64-ix-030", 08:18:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:18:57 INFO - "platform": "ubuntu64_hw", 08:18:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:18:57 INFO - "branch": "fx-team", 08:18:57 INFO - "repo_path": "integration/fx-team", 08:18:57 INFO - "revision": "92016fe68730f7f2257fb9a12b242fb85c541fa7", 08:18:57 INFO - "stage_platform": "linux64", 08:18:57 INFO - "builduid": "c79ee04d3d444aad95e38b18b76197ec", 08:18:57 INFO - "slavebuilddir": "test" 08:18:57 INFO - } 08:18:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:18:57 INFO - Running post-action listener: _resource_record_post_action 08:18:57 INFO - ##### 08:18:57 INFO - ##### Running download-and-extract step. 08:18:57 INFO - ##### 08:18:57 INFO - Running pre-action listener: _resource_record_pre_action 08:18:57 INFO - Running main action method: download_and_extract 08:18:57 INFO - mkdir: /builds/slave/test/build/tests 08:18: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')]} 08:18:57 INFO - https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/test_packages.json 08:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/test_packages.json 08:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:18:58 INFO - Downloaded 1448 bytes. 08:18:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:18:58 INFO - Using the following test package requirements: 08:18:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:58 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:18:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'jsshell-linux-x86_64.zip'], 08:18:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:58 INFO - https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:18:59 INFO - Downloaded 21217723 bytes. 08:18:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:19:00 INFO - Return code: 0 08:19:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:19:01 INFO - Downloaded 21217723 bytes. 08:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:19:02 INFO - Return code: 0 08:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:02 INFO - https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:19:03 INFO - Downloaded 11132144 bytes. 08:19:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:19:03 INFO - Return code: 0 08:19: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')]} 08:19:03 INFO - https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:19:05 INFO - Downloaded 54183587 bytes. 08:19:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:05 INFO - mkdir: /builds/slave/test/properties 08:19:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:05 INFO - Contents: 08:19:05 INFO - build_url:https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:05 INFO - Running post-action listener: _resource_record_post_action 08:19:05 INFO - Running post-action listener: set_extra_try_arguments 08:19:05 INFO - ##### 08:19:05 INFO - ##### Running populate-webroot step. 08:19:05 INFO - ##### 08:19:05 INFO - Running pre-action listener: _resource_record_pre_action 08:19:05 INFO - Running main action method: populate_webroot 08:19:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:05 INFO - '--tppagecycles', 08:19:05 INFO - '7'], 08:19:05 INFO - 'tests': ['tsvgm']}}, 08:19:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:19:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'tests': ['damp', 'tps']}, 08:19:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['damp', 'tps']}, 08:19:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:19:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:05 INFO - 'other': {'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'other_l64': {'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'other_nol64': {'tests': ['a11yr', 08:19:05 INFO - 'ts_paint', 08:19:05 INFO - 'tpaint', 08:19:05 INFO - 'sessionrestore', 08:19:05 INFO - 'sessionrestore_no_auto_restore']}, 08:19:05 INFO - 'svgr': {'tests': ['tsvgx', 08:19:05 INFO - 'tsvgr_opacity', 08:19:05 INFO - 'tart', 08:19:05 INFO - 'tscrollx', 08:19:05 INFO - 'cart']}, 08:19:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['tsvgx', 08:19:05 INFO - 'tsvgr_opacity', 08:19:05 INFO - 'tart', 08:19:05 INFO - 'tscrollx', 08:19:05 INFO - 'cart']}, 08:19:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'tests': ['tp5o']}, 08:19:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'talos_options': ['--e10s'], 08:19:05 INFO - 'tests': ['tp5o']}, 08:19:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'talos_options': ['--xperf_path', 08:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:05 INFO - 'tests': ['tp5n']}, 08:19:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:05 INFO - 'talos_options': ['--e10s', 08:19:05 INFO - '--xperf_path', 08:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:05 INFO - 'tests': ['tp5n']}}, 08:19:05 INFO - 'talos.zip': {'path': '', 08:19:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:05 INFO - Running post-action listener: _resource_record_post_action 08:19:05 INFO - ##### 08:19:05 INFO - ##### Running create-virtualenv step. 08:19:05 INFO - ##### 08:19:05 INFO - Running pre-action listener: _resource_record_pre_action 08:19:05 INFO - Running main action method: create_virtualenv 08:19:05 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:19:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:05 INFO - Using real prefix '/usr' 08:19:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:07 INFO - Installing pip.................done. 08:19:07 INFO - Return code: 0 08:19:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:07 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:07 INFO - Using env: {'DISPLAY': ':0', 08:19:07 INFO - 'HOME': '/home/cltbld', 08:19:07 INFO - 'LANG': 'en_US.UTF-8', 08:19:07 INFO - 'LANGUAGE': 'en_US:en', 08:19:07 INFO - 'LOGNAME': 'cltbld', 08:19:07 INFO - 'MAIL': '/var/mail/cltbld', 08:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:07 INFO - 'MOZ_NO_REMOTE': '1', 08:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:07 INFO - 'NO_EM_RESTART': '1', 08:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:07 INFO - 'PWD': '/builds/slave/test', 08:19:07 INFO - 'SHELL': '/bin/bash', 08:19:07 INFO - 'SHLVL': '1', 08:19:07 INFO - 'TERM': 'linux', 08:19:07 INFO - 'TMOUT': '86400', 08:19:07 INFO - 'USER': 'cltbld', 08:19:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:07 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:19:08 INFO - Using env: {'DISPLAY': ':0', 08:19:08 INFO - 'HOME': '/home/cltbld', 08:19:08 INFO - 'LANG': 'en_US.UTF-8', 08:19:08 INFO - 'LANGUAGE': 'en_US:en', 08:19:08 INFO - 'LOGNAME': 'cltbld', 08:19:08 INFO - 'MAIL': '/var/mail/cltbld', 08:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:08 INFO - 'MOZ_NO_REMOTE': '1', 08:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:08 INFO - 'NO_EM_RESTART': '1', 08:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:08 INFO - 'PWD': '/builds/slave/test', 08:19:08 INFO - 'SHELL': '/bin/bash', 08:19:08 INFO - 'SHLVL': '1', 08:19:08 INFO - 'TERM': 'linux', 08:19:08 INFO - 'TMOUT': '86400', 08:19:08 INFO - 'USER': 'cltbld', 08:19:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:08 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Downloading/unpacking psutil>=0.7.1 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:10 INFO - Installing collected packages: psutil 08:19:10 INFO - Running setup.py install for psutil 08:19:10 INFO - building 'psutil._psutil_linux' extension 08:19:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:19:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:19:10 INFO - building 'psutil._psutil_posix' extension 08:19:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:19:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:10 INFO - Successfully installed psutil 08:19:10 INFO - Cleaning up... 08:19:10 INFO - Return code: 0 08:19:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:10 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:19:10 INFO - Using env: {'DISPLAY': ':0', 08:19:10 INFO - 'HOME': '/home/cltbld', 08:19:10 INFO - 'LANG': 'en_US.UTF-8', 08:19:10 INFO - 'LANGUAGE': 'en_US:en', 08:19:10 INFO - 'LOGNAME': 'cltbld', 08:19:10 INFO - 'MAIL': '/var/mail/cltbld', 08:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:10 INFO - 'MOZ_NO_REMOTE': '1', 08:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:10 INFO - 'NO_EM_RESTART': '1', 08:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:10 INFO - 'PWD': '/builds/slave/test', 08:19:10 INFO - 'SHELL': '/bin/bash', 08:19:10 INFO - 'SHLVL': '1', 08:19:10 INFO - 'TERM': 'linux', 08:19:10 INFO - 'TMOUT': '86400', 08:19:10 INFO - 'USER': 'cltbld', 08:19:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:10 INFO - '_': '/tools/buildbot/bin/python'} 08:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:12 INFO - Installing collected packages: mozsystemmonitor 08:19:12 INFO - Running setup.py install for mozsystemmonitor 08:19:13 INFO - Successfully installed mozsystemmonitor 08:19:13 INFO - Cleaning up... 08:19:13 INFO - Return code: 0 08:19:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:13 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:19:13 INFO - Using env: {'DISPLAY': ':0', 08:19:13 INFO - 'HOME': '/home/cltbld', 08:19:13 INFO - 'LANG': 'en_US.UTF-8', 08:19:13 INFO - 'LANGUAGE': 'en_US:en', 08:19:13 INFO - 'LOGNAME': 'cltbld', 08:19:13 INFO - 'MAIL': '/var/mail/cltbld', 08:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:13 INFO - 'MOZ_NO_REMOTE': '1', 08:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:13 INFO - 'NO_EM_RESTART': '1', 08:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:13 INFO - 'PWD': '/builds/slave/test', 08:19:13 INFO - 'SHELL': '/bin/bash', 08:19:13 INFO - 'SHLVL': '1', 08:19:13 INFO - 'TERM': 'linux', 08:19:13 INFO - 'TMOUT': '86400', 08:19:13 INFO - 'USER': 'cltbld', 08:19:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:13 INFO - '_': '/tools/buildbot/bin/python'} 08:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:15 INFO - Downloading docopt-0.6.1.tar.gz 08:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:15 INFO - Running setup.py install for blobuploader 08:19:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:15 INFO - Running setup.py install for requests 08:19:16 INFO - Running setup.py install for docopt 08:19:16 INFO - Successfully installed blobuploader requests docopt 08:19:16 INFO - Cleaning up... 08:19:16 INFO - Return code: 0 08:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:16 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:16 INFO - Using env: {'DISPLAY': ':0', 08:19:16 INFO - 'HOME': '/home/cltbld', 08:19:16 INFO - 'LANG': 'en_US.UTF-8', 08:19:16 INFO - 'LANGUAGE': 'en_US:en', 08:19:16 INFO - 'LOGNAME': 'cltbld', 08:19:16 INFO - 'MAIL': '/var/mail/cltbld', 08:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:16 INFO - 'MOZ_NO_REMOTE': '1', 08:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:16 INFO - 'NO_EM_RESTART': '1', 08:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:16 INFO - 'PWD': '/builds/slave/test', 08:19:16 INFO - 'SHELL': '/bin/bash', 08:19:16 INFO - 'SHLVL': '1', 08:19:16 INFO - 'TERM': 'linux', 08:19:16 INFO - 'TMOUT': '86400', 08:19:16 INFO - 'USER': 'cltbld', 08:19:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:16 INFO - '_': '/tools/buildbot/bin/python'} 08:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:16 INFO - Running setup.py (path:/tmp/pip-rEJ10n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:16 INFO - Running setup.py (path:/tmp/pip-D5Xs30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:16 INFO - Running setup.py (path:/tmp/pip-hiWwrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:16 INFO - Running setup.py (path:/tmp/pip-PEumKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:16 INFO - Running setup.py (path:/tmp/pip-dCdaix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:16 INFO - Running setup.py (path:/tmp/pip-vSSNf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:17 INFO - Running setup.py (path:/tmp/pip-jF_6CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:17 INFO - Running setup.py (path:/tmp/pip-D4mznK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:17 INFO - Running setup.py (path:/tmp/pip-L8E3PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:17 INFO - Running setup.py (path:/tmp/pip-0ZfIGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:17 INFO - Running setup.py (path:/tmp/pip-KXBPq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:17 INFO - Running setup.py (path:/tmp/pip-6dIDNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Running setup.py (path:/tmp/pip-6A8TyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Running setup.py (path:/tmp/pip-r0Butu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:17 INFO - Running setup.py (path:/tmp/pip-buhEyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:17 INFO - Running setup.py (path:/tmp/pip-M5G6Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:17 INFO - Running setup.py (path:/tmp/pip-kdKkNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:17 INFO - Running setup.py install for manifestparser 08:19:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:17 INFO - Running setup.py install for mozcrash 08:19:17 INFO - Running setup.py install for mozdebug 08:19:18 INFO - Running setup.py install for mozdevice 08:19:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for mozfile 08:19:18 INFO - Running setup.py install for mozhttpd 08:19:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for mozinfo 08:19:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for mozInstall 08:19:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for mozleak 08:19:18 INFO - Running setup.py install for mozlog 08:19:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for moznetwork 08:19:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:18 INFO - Running setup.py install for mozprocess 08:19:19 INFO - Running setup.py install for mozprofile 08:19:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:19 INFO - Running setup.py install for mozrunner 08:19:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:19 INFO - Running setup.py install for mozscreenshot 08:19:19 INFO - Running setup.py install for moztest 08:19:19 INFO - Running setup.py install for mozversion 08:19:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:19 INFO - Cleaning up... 08:19:19 INFO - Return code: 0 08:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:19 INFO - Using env: {'DISPLAY': ':0', 08:19:19 INFO - 'HOME': '/home/cltbld', 08:19:19 INFO - 'LANG': 'en_US.UTF-8', 08:19:19 INFO - 'LANGUAGE': 'en_US:en', 08:19:19 INFO - 'LOGNAME': 'cltbld', 08:19:19 INFO - 'MAIL': '/var/mail/cltbld', 08:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:19 INFO - 'MOZ_NO_REMOTE': '1', 08:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:19 INFO - 'NO_EM_RESTART': '1', 08:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:19 INFO - 'PWD': '/builds/slave/test', 08:19:19 INFO - 'SHELL': '/bin/bash', 08:19:19 INFO - 'SHLVL': '1', 08:19:19 INFO - 'TERM': 'linux', 08:19:19 INFO - 'TMOUT': '86400', 08:19:19 INFO - 'USER': 'cltbld', 08:19:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:19 INFO - '_': '/tools/buildbot/bin/python'} 08:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:19 INFO - Running setup.py (path:/tmp/pip-_SZpqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:19 INFO - Running setup.py (path:/tmp/pip-DUIFi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:19 INFO - Running setup.py (path:/tmp/pip-GlF86s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:20 INFO - Running setup.py (path:/tmp/pip-o3OZkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:20 INFO - Running setup.py (path:/tmp/pip-Qb5CsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:20 INFO - Running setup.py (path:/tmp/pip-kUwvaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:20 INFO - Running setup.py (path:/tmp/pip-iO6eHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:20 INFO - Running setup.py (path:/tmp/pip-Oex1B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:20 INFO - Running setup.py (path:/tmp/pip-qIElE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:20 INFO - Running setup.py (path:/tmp/pip-LDu03b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:20 INFO - Running setup.py (path:/tmp/pip-N6y1s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:20 INFO - Running setup.py (path:/tmp/pip-HzzMB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:20 INFO - Running setup.py (path:/tmp/pip-SSSy8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:20 INFO - Running setup.py (path:/tmp/pip-DhK3rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:20 INFO - Running setup.py (path:/tmp/pip-0L_yZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:20 INFO - Running setup.py (path:/tmp/pip-sIYw9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:20 INFO - Running setup.py (path:/tmp/pip-bBhsRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:19:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:21 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:22 INFO - Downloading blessings-1.5.1.tar.gz 08:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:22 INFO - Installing collected packages: blessings 08:19:22 INFO - Running setup.py install for blessings 08:19:22 INFO - Successfully installed blessings 08:19:22 INFO - Cleaning up... 08:19:22 INFO - Return code: 0 08:19:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:23 INFO - Reading from file tmpfile_stdout 08:19:23 INFO - Current package versions: 08:19:23 INFO - argparse == 1.2.1 08:19:23 INFO - blessings == 1.5.1 08:19:23 INFO - blobuploader == 1.2.4 08:19:23 INFO - docopt == 0.6.1 08:19:23 INFO - manifestparser == 1.1 08:19:23 INFO - mozInstall == 1.12 08:19:23 INFO - mozcrash == 0.16 08:19:23 INFO - mozdebug == 0.1 08:19:23 INFO - mozdevice == 0.48 08:19:23 INFO - mozfile == 1.2 08:19:23 INFO - mozhttpd == 0.7 08:19:23 INFO - mozinfo == 0.9 08:19:23 INFO - mozleak == 0.1 08:19:23 INFO - mozlog == 3.1 08:19:23 INFO - moznetwork == 0.27 08:19:23 INFO - mozprocess == 0.22 08:19:23 INFO - mozprofile == 0.28 08:19:23 INFO - mozrunner == 6.11 08:19:23 INFO - mozscreenshot == 0.1 08:19:23 INFO - mozsystemmonitor == 0.0 08:19:23 INFO - moztest == 0.7 08:19:23 INFO - mozversion == 1.4 08:19:23 INFO - psutil == 3.1.1 08:19:23 INFO - requests == 1.2.3 08:19:23 INFO - wsgiref == 0.1.2 08:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:23 INFO - Using env: {'DISPLAY': ':0', 08:19:23 INFO - 'HOME': '/home/cltbld', 08:19:23 INFO - 'LANG': 'en_US.UTF-8', 08:19:23 INFO - 'LANGUAGE': 'en_US:en', 08:19:23 INFO - 'LOGNAME': 'cltbld', 08:19:23 INFO - 'MAIL': '/var/mail/cltbld', 08:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:23 INFO - 'MOZ_NO_REMOTE': '1', 08:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:23 INFO - 'NO_EM_RESTART': '1', 08:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:23 INFO - 'PWD': '/builds/slave/test', 08:19:23 INFO - 'SHELL': '/bin/bash', 08:19:23 INFO - 'SHLVL': '1', 08:19:23 INFO - 'TERM': 'linux', 08:19:23 INFO - 'TMOUT': '86400', 08:19:23 INFO - 'USER': 'cltbld', 08:19:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:23 INFO - '_': '/tools/buildbot/bin/python'} 08:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:23 INFO - Cleaning up... 08:19:23 INFO - Return code: 0 08:19:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:23 INFO - Using env: {'DISPLAY': ':0', 08:19:23 INFO - 'HOME': '/home/cltbld', 08:19:23 INFO - 'LANG': 'en_US.UTF-8', 08:19:23 INFO - 'LANGUAGE': 'en_US:en', 08:19:23 INFO - 'LOGNAME': 'cltbld', 08:19:23 INFO - 'MAIL': '/var/mail/cltbld', 08:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:23 INFO - 'MOZ_NO_REMOTE': '1', 08:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:23 INFO - 'NO_EM_RESTART': '1', 08:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:23 INFO - 'PWD': '/builds/slave/test', 08:19:23 INFO - 'SHELL': '/bin/bash', 08:19:23 INFO - 'SHLVL': '1', 08:19:23 INFO - 'TERM': 'linux', 08:19:23 INFO - 'TMOUT': '86400', 08:19:23 INFO - 'USER': 'cltbld', 08:19:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:23 INFO - '_': '/tools/buildbot/bin/python'} 08:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:23 INFO - Downloading/unpacking jsonschema 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:25 INFO - Downloading/unpacking functools32 (from jsonschema) 08:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:25 INFO - warning: no files found matching '*.txt' 08:19:25 INFO - no previously-included directories found matching 'build' 08:19:25 INFO - no previously-included directories found matching 'dist' 08:19:25 INFO - no previously-included directories found matching '.git*' 08:19:25 INFO - Installing collected packages: jsonschema, functools32 08:19:25 INFO - Running setup.py install for functools32 08:19:25 INFO - warning: no files found matching '*.txt' 08:19:25 INFO - no previously-included directories found matching 'build' 08:19:25 INFO - no previously-included directories found matching 'dist' 08:19:25 INFO - no previously-included directories found matching '.git*' 08:19:25 INFO - Successfully installed jsonschema functools32 08:19:25 INFO - Cleaning up... 08:19:25 INFO - Return code: 0 08:19:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:25 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 0x7fd52bc16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, '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': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:19:25 INFO - Using env: {'DISPLAY': ':0', 08:19:25 INFO - 'HOME': '/home/cltbld', 08:19:25 INFO - 'LANG': 'en_US.UTF-8', 08:19:25 INFO - 'LANGUAGE': 'en_US:en', 08:19:25 INFO - 'LOGNAME': 'cltbld', 08:19:25 INFO - 'MAIL': '/var/mail/cltbld', 08:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:25 INFO - 'MOZ_NO_REMOTE': '1', 08:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:25 INFO - 'NO_EM_RESTART': '1', 08:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:25 INFO - 'PWD': '/builds/slave/test', 08:19:25 INFO - 'SHELL': '/bin/bash', 08:19:25 INFO - 'SHLVL': '1', 08:19:25 INFO - 'TERM': 'linux', 08:19:25 INFO - 'TMOUT': '86400', 08:19:25 INFO - 'USER': 'cltbld', 08:19:25 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:25 INFO - '_': '/tools/buildbot/bin/python'} 08:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:26 INFO - Downloading/unpacking flake8 08:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:28 INFO - no previously-included directories found matching 'docs/_build' 08:19:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:28 INFO - Running setup.py install for pep8 08:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:28 INFO - no previously-included directories found matching 'docs/_build' 08:19:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:19:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:28 INFO - Cleaning up... 08:19:28 INFO - Return code: 0 08:19:28 INFO - Running post-action listener: _resource_record_post_action 08:19:28 INFO - Running post-action listener: _start_resource_monitoring 08:19:28 INFO - Starting resource monitoring. 08:19:28 INFO - ##### 08:19:28 INFO - ##### Running install step. 08:19:28 INFO - ##### 08:19:28 INFO - Running pre-action listener: _resource_record_pre_action 08:19:28 INFO - Running main action method: install 08:19:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:28 INFO - Reading from file tmpfile_stdout 08:19:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:28 INFO - Reading from file tmpfile_stdout 08:19:28 INFO - Output received: 08:19:28 INFO - Usage: mozinstall [options] installer 08:19:28 INFO - Options: 08:19:28 INFO - -h, --help show this help message and exit 08:19:28 INFO - -d DEST, --destination=DEST 08:19:28 INFO - Directory to install application into. [default: 08:19:28 INFO - "/builds/slave/test"] 08:19:28 INFO - --app=APP Application being installed. [default: firefox] 08:19:28 INFO - mkdir: /builds/slave/test/build/application 08:19:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:19:44 INFO - Reading from file tmpfile_stdout 08:19:44 INFO - Output received: 08:19:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:44 INFO - Running post-action listener: _resource_record_post_action 08:19:44 INFO - ##### 08:19:44 INFO - ##### Running run-tests step. 08:19:44 INFO - ##### 08:19:44 INFO - Running pre-action listener: _resource_record_pre_action 08:19:44 INFO - Running main action method: run_tests 08:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:44 INFO - Python 2.7.3 08:19:44 INFO - Return code: 0 08:19:44 INFO - grabbing minidump binary from tooltool 08:19: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')]} 08:19:44 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 0x235c3d0>, '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 0x22c7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c8360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:19:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:19:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:44 INFO - Return code: 0 08:19:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:19:45 INFO - Return code: 0 08:19:45 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/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:19:45 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/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:19:45 INFO - Using env: {'DISPLAY': ':0', 08:19:45 INFO - 'HOME': '/home/cltbld', 08:19:45 INFO - 'LANG': 'en_US.UTF-8', 08:19:45 INFO - 'LANGUAGE': 'en_US:en', 08:19:45 INFO - 'LOGNAME': 'cltbld', 08:19:45 INFO - 'MAIL': '/var/mail/cltbld', 08:19:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:45 INFO - 'MOZ_NO_REMOTE': '1', 08:19:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:45 INFO - 'NO_EM_RESTART': '1', 08:19:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:45 INFO - 'PWD': '/builds/slave/test', 08:19:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:45 INFO - 'SHELL': '/bin/bash', 08:19:45 INFO - 'SHLVL': '1', 08:19:45 INFO - 'TERM': 'linux', 08:19:45 INFO - 'TMOUT': '86400', 08:19:45 INFO - 'USER': 'cltbld', 08:19:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251', 08:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:45 INFO - '_': '/tools/buildbot/bin/python'} 08:19:45 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/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:19:45 INFO - mozversion application_buildid: 20160120071126 08:19:45 INFO - mozversion application_changeset: 92016fe68730f7f2257fb9a12b242fb85c541fa7 08:19:45 INFO - mozversion application_display_name: Nightly 08:19:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:45 INFO - mozversion application_name: Firefox 08:19:45 INFO - mozversion application_remotingname: firefox 08:19:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:45 INFO - mozversion application_vendor: Mozilla 08:19:45 INFO - mozversion application_version: 46.0a1 08:19:45 INFO - mozversion platform_buildid: 20160120071126 08:19:45 INFO - mozversion platform_changeset: 92016fe68730f7f2257fb9a12b242fb85c541fa7 08:19:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:45 INFO - mozversion platform_version: 46.0a1 08:19:45 INFO - using testdate: 1453306785 08:19:45 INFO - actual date: 1453306785 08:19:45 INFO - starting webserver on 'localhost:52639' 08:19:45 INFO - SUITE-START | Running 3 tests 08:19:45 INFO - TEST-START | dromaeo_css 08:19:45 INFO - operating with platform_type : linux_ 08:19:45 INFO - Initialising browser for dromaeo_css test... 08:19:45 INFO - TEST-INFO | started process 18242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkq8xUr/profile http://localhost:52639/getInfo.html) 08:19:49 INFO - PROCESS | 18242 | 08:19:49 INFO - PROCESS | 18242 | (process:18320): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:19:50 INFO - PROCESS | 18242 | __metrics Screen width/height:1600/1200 08:19:50 INFO - PROCESS | 18242 | colorDepth:24 08:19:50 INFO - PROCESS | 18242 | Browser inner width/height: 1024/697 08:19:50 INFO - PROCESS | 18242 | __metrics 08:19:50 INFO - PROCESS | 18242 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:51 INFO - TEST-INFO | 18242: exit 0 08:19:51 INFO - Browser initialized. 08:19:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:51 INFO - TEST-INFO | started process 18369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkq8xUr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:52 INFO - PROCESS | 18369 | -- checkerboarding starts below -- 08:19:52 INFO - PROCESS | 18369 | RENDERTRACE 0.042127 rect red 0 0 10 10 // viewport 08:19:52 INFO - PROCESS | 18369 | RENDERTRACE 28.6947 rect brown 0 0 10 10 // page 08:19:52 INFO - PROCESS | 18369 | RENDERTRACE 28.7144 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:19:52 INFO - PROCESS | 18369 | Checkerboarded for 1 frames (38.9574 ms), 100 peak, 1 severity. 08:19:52 INFO - PROCESS | 18369 | 08:19:52 INFO - PROCESS | 18369 | (process:18425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:20:03 INFO - PROCESS | 18369 | RSS: Main: 150462464 08:20:03 INFO - PROCESS | 18369 | 08:20:52 INFO - PROCESS | 18369 | 1453306852951 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:23:03 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52639/tests/dromaeo/cssquery-ext.html) 08:23:04 INFO - PROCESS | 18369 | RSS: Main: 155107328 08:23:04 INFO - PROCESS | 18369 | 08:26:06 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-ext.html (next: http://localhost:52639/tests/dromaeo/cssquery-jquery.html) 08:26:07 INFO - PROCESS | 18369 | RSS: Main: 150777856 08:26:07 INFO - PROCESS | 18369 | 08:29:09 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52639/tests/dromaeo/cssquery-mootools.html) 08:29:09 INFO - PROCESS | 18369 | RSS: Main: 153317376 08:29:09 INFO - PROCESS | 18369 | 08:32:11 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52639/tests/dromaeo/cssquery-prototype.html) 08:32:12 INFO - PROCESS | 18369 | RSS: Main: 150155264 08:32:12 INFO - PROCESS | 18369 | 08:35:15 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52639/tests/dromaeo/cssquery-yui.html) 08:35:15 INFO - PROCESS | 18369 | RSS: Main: 150065152 08:35:15 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:52639/tests/dromaeo/cssquery-yui.html (next: http://localhost:52639/tests/dromaeo/cssquery-dojo.html) 08:38:18 INFO - PROCESS | 18369 | RSS: Main: 153202688 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | __start_tp_report 08:38:18 INFO - PROCESS | 18369 | _x_x_mozilla_page_load 08:38:18 INFO - PROCESS | 18369 | _x_x_mozilla_page_load_details 08:38:18 INFO - PROCESS | 18369 | |i|pagename|runs| 08:38:18 INFO - PROCESS | 18369 | |0;dojo.html;2567.3068271566676;2592.027989503936;2627.855467949263;2640.1155612869693;2645.748653877882;4431.889202769932;4457.732536047839;4519.683622146451;4519.819207231711;4539.364488971542;4433.401490798741;4459.264221403472;4482.462104547459;4490.30400287955;4584.7478388688605;4113.732607380525;4169.499660040799;4220.620144187023;4227.788610569474;4237.682173836959;256.3044302979519;4153.252414565377;4196.727212731178;4233.216854881842;4277.978610106945;4105.4252404663375;4183;4252.298370768819;4256.297710877701;4283.186194623043;4229.38673892287;4243.681723870722;4250.362445633149;4260.08408192237;4296.548862369469;4020.296448121567;4111.8897897567485;4222.78886055696;4242.193983143193;4245.787710614457;4283.079137985348;4330.545292744279;4392.34114882767;4402.559744025604;4436.201483732927;4708.434987801452;4735;4749.050189961987;4765.070811191819;4776.928346074812;4627.791749371287;4726.692764970266;4729.929051064237;4732;4737.455192652855;4401.141777353418;4404.471463424377;4413.360062790909;4417.602415782595;4473.731576105444;4861.756912154378;4866.31871537985;4867.221244600918;4872;4918;4679.9298010529865;4688.226442636927;4694.413198350207;4696.671233013656;4728.550787675165;4620.468646105741;4723.7874295656775;4801.4718380978065;4808.951910480921;4890.217565189552;4794.712317260975;4819.2530157825595;4819.903601927942;4830.541098595698;4866.099771542276;4602.585767280961;4792.329073929653;4797.64017698674;4809.422869255712;4839.588634965997;3969.285528604821;3978.522577290744;4012.4382586437923;4039.6768258539246;4044.3529035354204;3541.9197144871064;3542.98228508861;3550.7692000019915;3573.857045718142;3586.3903136466865;4125.546189919107;4181.686373521998;4184.707070505096;4198.685098617555;4202.684798640114;4704.623630109583;4753.643476739258;4758.357621721023;4775.785089670903;4784.617230621542;4125.8968525787095;4163.208990291835;4184.8744537663915;4194;4223.408722778752;4181.832726690959;4230.746155230696;4246.723962942398;4271.743695378287;4272.807723652443;4621.214393553104;4623.93064104032;4639.420072490939;4642.234031384851;4681.7190968542;4807.18277892766;4851.151048566558;4858.392700912386;4862.270659401118;4908.141075311878;4468.151051300242;4542.613877820422;4544.977275113603;4598.103369842982;4617.8152873884665;4671.089137618132;4678.812847486062;4681.110588988081;4696.929546056744;4716.434027916672;4759.452662943667;4768.523147685204;4773.04539092176;4779.928301075556;4808.807647694193;4510.977445112753;4596.701214421052;4618.399608050931;4696.718196908197;4718.811247550059;4592.839250626212;4604.1252162089095;4606.309053641847;4631.76841157934;4653.046125544188;4494.483134439451;4547.567981041796;4555.453345598549;4556;4583.54164583539;4565.908681826279;4642.257238841769;4661.883452913704;4694.600958918393;4734.33719279308;4549.340345649928;4565.6119229865835;4581.060882519142;4607.470140933836;4625.283081122431 08:38:18 INFO - PROCESS | 18369 | |1;ext.html;484.3799936081817;503.8110060257793;521.8987935456187;524.6904326447395;547.7507733981039;30835.22911927203;31616.20959476014;31650;31806;31818.68181318186;34356.31287374251;34897.65102348976;35083.122921926966;35215.647843521554;35315.2936941261;7579.6589153488085;7812.140664526926;7817.843643127134;7823.647935842901;7828.608569571527;7728.497647652913;7787.299143077122;7798.532088074705;7812.726554570591;7818.530888146701;7800.063992320929;7824.608769561528;7831.4909530880595;7853.5680537570415;7890.960545197295;7763.068431788165;7815.413843961697;7843.137254901956;7843.764687059397;7845.686172553091;7782.571958542278;7889.684412623488;7893.605319733991;7905.367570594339;7925.643346049442;34712.652873471445;34793.82603086994;34815.4777678335;34969.65030349689;35028.47457288143;2698.9878795451705;2708.6485625547566;2724.5913113033007;2731.3171707073234;2740.657417822772;26619.866900665373;27003.594946075824;27131.45737085267;27194.728052719416;27933.441331173464;3446.7414943879307;3480.286541259036;3503.9474407883904;3510.1751088494184;3617.6924961378313;204070;204961;205026.99999999852;205096;205409;44421.55578444174;45380.54619453829;50907;51028.489715102376;51976;46339;46372;46374.76812615915;46596.3010554842;46675.29987050197;12949.870501294867;13194;13216.074874758675;13225.404856781468;13225.933870330588;9469.621215151317;9540.713778586654;9624.66313679018;9640.517974101407;9642.42145471274;17550.912245438692;17750.91124544369;17852.55368615795;17858.821411785975;17914.5521361967;7120.465965052642;7293.416526677853;7294.869295259244;7403.297241634346;7435.776926692208;856.6359297298624;860.2515811244133;926.4441335198827;943.4150826487621;946.6024269806697;23293.301200963997;23377;23444.64833027506;23465.882670586878;23501.764982350298;970.5826494607387;1000.5497526113278;1011.7672935224939;1013.99493002536;1063.3141623652855;12530.68673283157;12547.184433012008;12657;12677.683057923441;12689.428975695932;246647;248835;248986;249200;251214;42156.15687686229;42434.57565424368;42509.36235956463;42614.36078458826;42622;1149.4425203776161;1171.9296842189497;1174.1194104421684;1185.6739396665814;1185.8814118588073;23092.307230783103;23490.647640285068;23670.17154399588;23734.169304074276;23765;34403.31193376169;35156.824215878754;35215.82392088023;35226;35307.82346088253;229667;231464;231955;232355;232524;23531.647025294293;24089.879550602134;27195.320116997234;27609.119028525027;27962.580561292005;31988;32087;32684.34631307313;32855.67144328526;32856;27856.44287114287;28065;28084;28231.43537129205;28346.2913427166;27819.582706259018;27927.860360698065;29905.401891961603;31228.531572025982;32297;28375.71624283731;28960.42079158447;29126.854365728035;29134.854325728236;29206.70793292125;24969.625455617817;25001;27748.30629234285;27790.86104569464;27932.581011285252;22193.334199974026;22254.443638909157;22293.888530557244;22459.764712940945;22478.887605561868 08:38:18 INFO - PROCESS | 18369 | |2;jquery.html;343.62888080872654;345.3679766028167;347.4996005751718;349.6817895714897;351.0819207771678;13917.721645567082;14165.858341416582;14984.400623975029;15723.292451839667;16132.596685082879;10385.584576616946;10698.411587362692;13290.933545332284;15201.087934723924;15230.390784368612;4553.362529245908;4557.248054071074;4704.717716936994;4705.952940470585;4754.334393184957;4628.352030715686;4706.247000479907;4707.317438971347;4711.081339138852;4712.6229901607785;4668.136394766979;4700.482946875841;4902.166631672624;5125.308083408748;5125.794968201268;4874.171390863562;4923.876903077416;4935.1116798976345;4959.603231741452;5289.3917199521775;5095.363079615048;5106.463821298785;5107.872303192413;5114.3862736471865;5123.487651234884;11211.439428028565;16345.427910023092;17215.139243037796;18053;18104.63790724178;1589.6264377871191;1614.0557773702399;1843.7094034175996;1851.7314989326608;1852.2961274715522;8729.912700873037;8755.605997730117;8871.733847984571;9041.050689677555;9085.727428177099;1732.748751431048;1744.389463687712;1769.2392271323454;1790.811964743696;1866.225516410688;47708.284375734394;49424.258636120125;49750.253746193834;50204.49795502035;50827.237591436155;9272.629094836131;9435.528223588793;9540.475273860004;9638.277129215337;9680.661176858775;12284.631461056182;12285.078619103424;12292.139550231577;12303.32331721746;12361.258324500559;6735.461163106939;6818.897716534256;6828.419584335387;6846.760363387258;7000.334968178015;6292.653904035231;6323.146375239376;6359.141515895388;6401.775937842153;6416.422521973045;4120.361343991626;4125.23683118624;4128.566500517462;4156.085661154541;4167.083241686824;1684.107423065777;1739.5216315513335;1783.179737320821;1796.6765982123081;1848.0944337274639;885.181207383168;893.9374243802871;953.609020301673;965.7682156282442;972.2853702528636;12710.491580336868;14812.481563145238;14951.551453456414;15378.231088445757;15472.92263538675;834.6285902773329;840.1220724343076;847.3306088190384;855.7732200966749;883.4478450968145;8678.435901666371;8766.12338766131;8781.07798681142;8987.550622468982;8988.775280617907;290086;297620;297625;299671;300254;62083.37916620776;64885.35114648887;65075.67462162659;65424;66282.66858665676;830.8504469195602;855.7389996051139;857.2884505860121;858.1547176031604;985.8964808695271;13787.241701706502;14021.5092471763;14184.219867907364;14268;14291.28543572838;27702.307442314104;27738.722612773614;28200.576991344737;28621.570676439453;28646;36015.63984360228;36216.63783362238;36531.452028219064;37605.81197094107;38900.41649375205;6110.205673262448;6163.229596300463;6239.594426362272;6322.683865806599;6357.93642063592;7365.410767138723;9480.099390557885;9592.9040709592;9634.325597208408;9665.3234273603;7801.609919504115;8552.914470855461;8575.785605359915;8579.871301930601;8694.82610347802;7879.409044321814;8276.586170691562;8585.957070214608;8647.956760216159;8665.393422460367;7756.534607923542;8424.789380265298;8494.150584941457;8751.474911505331;8923.598438070172;6446.0975463434215;6533.803985880431;6580.80257592273;6691.933080669131;6813.693383797642;8119.75640730779;8293.751187464386;8404.579771011548;8484.194001570087;8506.61720222579 08:38:18 INFO - PROCESS | 18369 | |3;mootools.html;1316.473410635746;1333.866613338666;1400.3838311143097;1629.405267077517;1637.3368785641812;5671.262735844345;5755.280589926259;6361.459275961543;6530.346965303467;6545.672716364181;6467.126937863387;6608.942569188931;6637.668116594175;6715.093462382577;6719.294474080212;1994.8803071815664;2004.208337706605;2020.7474065741783;2021.2218295956015;2021.5653634468586;1964.2535836382226;1967.9016049197483;1971.7732460767052;2017.0519855667812;2028.4117605894273;1994.9900250498727;1999.1803360622148;2000.7098970649247;2006.6388050150968;2017.8385729141633;2021.8483613728956;2025.1393157907978;2026.1895241903358;2028.9999999999927;2030.3198428526462;1968.8228059474716;1990.3431867483696;2007.6085163393145;2024.908879100444;2026.8986550672555;6792.150981127359;6794.150731158606;6795.38841504262;6846.486513511507;6847.863042739117;3889.863854765098;4000.7999600019884;4002.799860006988;4003.539592946819;4006.4991876015497;2460.772104607721;2485.155047283914;2494.4013436775226;2609.29549021765;2632.88152033159;809.5709274084744;816.8856360109589;829.5396055189367;833.0960907415462;837.1628371628371;9076.909230907673;9116.635334586608;9141.405808622418;9144.725658230263;9163.496007719572;3583.032581203113;3603.5405660706933;3645.489631451599;3650.379435495972;3672.081979505124;7906.248906353887;7909;7911.28798408146;7916.258423146898;7938.04743430792;4008.3386241269864;4019.738716983387;4030.1738143680477;4030.899227519277;4042.191561687674;3067.785255032171;3134.2634480896972;3444.6727560881677;3642.653947874948;3662.377395842713;3268.166617512519;3294.6046474423224;3304.1244070321386;3305.1241421023446;3341.281624450706;995.2088089968493;1008.6973907827769;1009.2228983682523;1021.9131373833159;1060.4061725433783;943.9952800235955;984.7095106943469;1130.3895896215952;1150.1201580790703;1152.464104191555;6217.875642487125;6223.657698826608;6224.688765561704;6237.251529816451;6264.718087686065;395.10114489536534;403.0508153298997;404.4014858010161;406.0478178671012;406.57309824683966;5056.898862022739;5075.695458272516;5110.054639891632;5111.923321150186;5116.923246151311;7475.252474752481;7640.465167438226;7969.880451793228;8164.632591533276;8261.752147435587;7557.508761930457;7584.772456826304;7588;7595.392368610498;7625.199354067743;6282.937170628235;6358.205224346957;6359.523035772243;6367.522435817425;6404.839879003062;5942.6731529766275;6101.298350689727;6108.144859719731;6110.877782444415;6120.296165940974;6855.383015528626;6885.586864788129;7027.051348067946;7098.183708873546;7119.67961441726;6982.511224214256;7165.462590305644;7177.533460325062;7195.964020179866;7223.674934628059;4996.375453068366;5142.6914385137015;6040.305364882919;6118.969405152946;6137.907931380943;6166.445019948226;6228.5951413158;6265.467435268053;6286.18279623646;6286.245650521967;5940.970295148497;5969.343372229138;6000.489958353414;6106.175666284995;6116.5412594056515;5781.4507621775865;5822.097574875901;5836.795712150054;5836.970815146067;5918.674472904032;5999.5800293979;6024.638521688713;6025.698715064317;6027.276726792813;6028.577999540165;5627.718614069362;5652.236948012131;5660.179274005164;5665.065264231355;5670.234518340137;5688.40271771458;5693.231413759255;5708.885822283448;5720.542356611378;5728.914066288926 08:38:18 INFO - PROCESS | 18369 | |4;prototype.html;293.2331951945662;299.8380874327863;305.3907454628016;306.22983197258895;307.02672528085964;5494.862628434291;5574.804881829137;5639.2105105285245;5650.51970582501;5677.716114194294;5385.488378604036;5569.554435645149;5628.915566266499;5630.746616402262;5655.7172141392975;4239.894002649928;4246.936295955563;4249.235137675225;4251.914961700764;4256.638185754215;4243.342281946303;4246.3205887058075;4248.192843359751;4248.617624413802;4249.681273904454;4085.4679495189303;4195.685323600727;4206.1377417629465;4214.957850421502;4217.894552636178;4203.642690371322;4222.556631553689;4223.176480586287;4228.154369126187;4228.957710422918;3662.963370366289;3663.0292972362345;3669.743117981742;3673.963260367389;3675.6140605236333;5293.258943747878;5411.485908838654;5414.377346605152;5417.8103766367985;5418.810341638064;4843.491433399513;4849.587785038276;4856;4861.8784530386665;4862.319275301461;5762.942370576283;5798.681072541009;5810.535157187415;5812.273465816773;5823.5923485355615;3762.473253744478;3925.9803700981597;3928.0376307804772;3934.6852251819787;3937.547182074041;6098.786542470993;6171.506279497629;6176.073588961647;6186.319504854462;6211.875762484725;4127.360259159835;4132.462779838602;4133.689973252018;4135.214309281227;4136.9793151034055;4195.559466255999;4200.6429453496185;4200.831966721297;4201.075763332062;4202.390653355246;4749.2876068589985;4855.927161092586;4857.805687772449;4860.8298709545;4863.319135321058;5891.911621325684;5892.734826932799;5893.44012318829;5898.233229680114;5907.438793314628;1458.2562892924473;1460.8612181842707;1462.436961769705;1463.8389777124507;1467.6551010512521;960.8270511308032;966.7244835222068;976.9706908792748;987.9012098790207;991.548845275398;5117.437081920985;5118.411382690963;5121.28302037715;5122.974385128051;5123.718195499208;6087.482563982111;6094.878102437927;6115.602485838406;6125.387461253839;6146.815595532141;5102.872428189325;5112.36095488064;5115.18157094863;5115.667481613757;5128.256402821645;3254.23525471514;3296.1100502864574;3311.03979845842;3324.1191084362663;3330.6835850594157;5717.742701578439;5754.251947246915;5762.423757624288;5764.855878603068;5775.047117225695;6359.395857393541;6393.680315984182;6394.136791533177;6397.904031439532;6402.295747467775;5822.505087067647;5829.7085145743395;5834.066549352084;5839.240898683144;5840.919429905481;6180.598261113193;6183.505319574513;6190.164327815687;6191.19514463117;6204.7828326008375;5827.388124246893;6042.486388657014;6052.092186172109;6053.273607166992;6092.847678808065;5823.563232757476;5840.2115714379715;5842.883142337045;5848;5859.970700146472;3982.064214909552;4008.1983603278877;4015.1969606079483;4017.035911381189;4017.718759686794;6054.878902421839;6114.357992410733;6186.072089186478;6189.721462534107;6208.751649934133;5939.049752039826;5945.286565612154;5951.55363347742;5955.642661440327;5962.135490353788;5916.934951708734;5922.141289512911;5939.613925094855;5948.405159484017;5949.1076338549565;5599.776008959759;5793.565482588739;5809.8547536311935;5810.796622118375;5829.15477255804;5933.931892259435;5939.940600594112;5957.314908785545;5962.165296858357;5977.970110149421;5801.680907550125;5830.358660547252;5840.707964601838;5853.326867410302;5860.882782344414 08:38:18 INFO - PROCESS | 18369 | |5;yui.html;673.2661399075007;730.6894569807831;751.4138971602152;756.1833220122272;761.3224230434914;10790.028897399232;10842.349459032454;10868.565257389704;10884.510197041142;10885.23803333767;10276.640317588886;10339.638112666058;10349.534270957805;10365.067143957041;10391.064804167623;581.4534337722548;744.694675183175;753.1038064702985;753.1113286322137;753.9359154471877;589.0957380421055;726.1576571177435;742.3170682971679;742.5915746339518;748.0462410426722;779.5829231361223;783.0251337085336;789.9967041856838;790.6046976511744;792.1207459719707;772.5635016215848;777.0481160578303;777.9377649788004;778.353966208046;782.5500337306044;580.1124279851833;581.1631250998548;581.2066529187629;581.9505342045932;582.2808831093596;12010.699732506757;12105.15263931525;12168.14822962393;12178.147529672926;12192;11155.274907131092;11402.885971140266;11632.651020469399;11845.94077029618;12039.6388108356;9532.094451027142;9579;9588.712338629852;9600.90399096007;9785.461799601018;3226.2579606690356;3250;3272;3273.099897528175;3381.2899291148888;40517;41221.38167927483;41265.58734412648;41279.79360103211;41296.58703412987;9571.676157464719;9699.903000970042;9815.656452024145;9883.456409897524;9895.802083958424;15348.309326080353;15866.286017129258;15992.680146397008;16001.439949601709;16014.27935742871;6513.088167656532;6585.374389432996;6588.73645054202;6648.867022659617;6668.799936001928;3632.055665526982;3710.8515659373325;3730.906727331784;3731.906702332409;3761.5298087739034;2651.125128707522;2665.8000649950945;2678.076063758;2679.678438587343;2681.839089654627;455.0852785900364;470.7975570504716;477.82081719355244;478.7103802199689;487.5270987142466;521.7964993652479;533.9385970613351;543.8830651409887;554.2074832988865;566.1366416215222;6951.7219311228;7085.822854428578;7137.714491420285;7248.710051597983;8210.671573137128;440.1680823244071;480.57229066131174;546.2298159594952;571.9428057194331;594.1444320178929;3251.9674803252137;3271.4275001874576;3419.9829000855334;3514.7188224941942;3534.2048039190977;47059.294110588366;47181;47230.76384618055;47526;48643.27035094477;40642.79678601588;41050.38424423636;42251.7887410561;42380.57619423828;42789.57210427856;37864.62135378666;38161.809190954424;38411.42382864204;38621.42067868984;38961.80519097443;6678.131842860397;6682.966585167043;6690.966545167243;6755.392014718699;6775.966120169368;28201.57697634496;28559.42881142324;29325.706742932296;29341.706582933897;29391.85304073466;33852;34280.657193427745;36951.445728313556;37151.6284837159;37398;8613.26787223093;8738.868916966123;8816.735497935073;8894.955525222591;8908.064653211319;9542.666006689733;9874.358166719141;10219.693409197736;10275.280730348804;11210.878912108725;9430.434173949585;9577.138057574852;9669.178119859891;9742;10101.797964040825;9688.660896868576;9719.56261968199;9799.510024498604;9893.109620134222;9919.15687166599;9899.901000989898;9929.205663546754;9935.950320248641;10000.449975251431;10576;8250.298724608476;8341.874871876806;8365.205305495969;8399.328053755808;8758.868616970878;8301.128381520095;8608.698695545625;9031.227378248224;9032.593533291149;9123.589438475417 08:38:18 INFO - PROCESS | 18369 | __end_tp_report 08:38:18 INFO - PROCESS | 18369 | __start_cc_report 08:38:18 INFO - PROCESS | 18369 | _x_x_mozilla_cycle_collect,329 08:38:18 INFO - PROCESS | 18369 | __end_cc_report 08:38:18 INFO - PROCESS | 18369 | __startTimestamp1453307898422__endTimestamp 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | ------- Summary: start ------- 08:38:18 INFO - PROCESS | 18369 | Number of tests: 6 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#0] dojo.html Cycles:165 Average:4409.80 Median:4556.00 stddev:544.28 (11.9%) stddev-sans-first:526.41 08:38:18 INFO - PROCESS | 18369 | Values: 2567.3 2592.0 2627.9 2640.1 2645.7 4431.9 4457.7 4519.7 4519.8 4539.4 4433.4 4459.3 4482.5 4490.3 4584.7 4113.7 4169.5 4220.6 4227.8 4237.7 256.3 4153.3 4196.7 4233.2 4278.0 4105.4 4183.0 4252.3 4256.3 4283.2 4229.4 4243.7 4250.4 4260.1 4296.5 4020.3 4111.9 4222.8 4242.2 4245.8 4283.1 4330.5 4392.3 4402.6 4436.2 4708.4 4735.0 4749.1 4765.1 4776.9 4627.8 4726.7 4729.9 4732.0 4737.5 4401.1 4404.5 4413.4 4417.6 4473.7 4861.8 4866.3 4867.2 4872.0 4918.0 4679.9 4688.2 4694.4 4696.7 4728.6 4620.5 4723.8 4801.5 4809.0 4890.2 4794.7 4819.3 4819.9 4830.5 4866.1 4602.6 4792.3 4797.6 4809.4 4839.6 3969.3 3978.5 4012.4 4039.7 4044.4 3541.9 3543.0 3550.8 3573.9 3586.4 4125.5 4181.7 4184.7 4198.7 4202.7 4704.6 4753.6 4758.4 4775.8 4784.6 4125.9 4163.2 4184.9 4194.0 4223.4 4181.8 4230.7 4246.7 4271.7 4272.8 4621.2 4623.9 4639.4 4642.2 4681.7 4807.2 4851.2 4858.4 4862.3 4908.1 4468.2 4542.6 4545.0 4598.1 4617.8 4671.1 4678.8 4681.1 4696.9 4716.4 4759.5 4768.5 4773.0 4779.9 4808.8 4511.0 4596.7 4618.4 4696.7 4718.8 4592.8 4604.1 4606.3 4631.8 4653.0 4494.5 4547.6 4555.5 4556.0 4583.5 4565.9 4642.3 4661.9 4694.6 4734.3 4549.3 4565.6 4581.1 4607.5 4625.3 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#1] ext.html Cycles:180 Average:37157.43 Median:31728.00 stddev:59646.48 (188.0%) stddev-sans-first:59750.25 08:38:18 INFO - PROCESS | 18369 | Values: 484.4 503.8 521.9 524.7 547.8 30835.2 31616.2 31650.0 31806.0 31818.7 34356.3 34897.7 35083.1 35215.6 35315.3 7579.7 7812.1 7817.8 7823.6 7828.6 7728.5 7787.3 7798.5 7812.7 7818.5 7800.1 7824.6 7831.5 7853.6 7891.0 7763.1 7815.4 7843.1 7843.8 7845.7 7782.6 7889.7 7893.6 7905.4 7925.6 34712.7 34793.8 34815.5 34969.7 35028.5 2699.0 2708.6 2724.6 2731.3 2740.7 26619.9 27003.6 27131.5 27194.7 27933.4 3446.7 3480.3 3503.9 3510.2 3617.7 204070.0 204961.0 205027.0 205096.0 205409.0 44421.6 45380.5 50907.0 51028.5 51976.0 46339.0 46372.0 46374.8 46596.3 46675.3 12949.9 13194.0 13216.1 13225.4 13225.9 9469.6 9540.7 9624.7 9640.5 9642.4 17550.9 17750.9 17852.6 17858.8 17914.6 7120.5 7293.4 7294.9 7403.3 7435.8 856.6 860.3 926.4 943.4 946.6 23293.3 23377.0 23444.6 23465.9 23501.8 970.6 1000.5 1011.8 1014.0 1063.3 12530.7 12547.2 12657.0 12677.7 12689.4 246647.0 248835.0 248986.0 249200.0 251214.0 42156.2 42434.6 42509.4 42614.4 42622.0 1149.4 1171.9 1174.1 1185.7 1185.9 23092.3 23490.6 23670.2 23734.2 23765.0 34403.3 35156.8 35215.8 35226.0 35307.8 229667.0 231464.0 231955.0 232355.0 232524.0 23531.6 24089.9 27195.3 27609.1 27962.6 31988.0 32087.0 32684.3 32855.7 32856.0 27856.4 28065.0 28084.0 28231.4 28346.3 27819.6 27927.9 29905.4 31228.5 32297.0 28375.7 28960.4 29126.9 29134.9 29206.7 24969.6 25001.0 27748.3 27790.9 27932.6 22193.3 22254.4 22293.9 22459.8 22478.9 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#2] jquery.html Cycles:180 Average:19299.52 Median:50515.87 stddev:48965.15 (96.9%) stddev-sans-first:49081.83 08:38:18 INFO - PROCESS | 18369 | Values: 343.6 345.4 347.5 349.7 351.1 13917.7 14165.9 14984.4 15723.3 16132.6 10385.6 10698.4 13290.9 15201.1 15230.4 4553.4 4557.2 4704.7 4706.0 4754.3 4628.4 4706.2 4707.3 4711.1 4712.6 4668.1 4700.5 4902.2 5125.3 5125.8 4874.2 4923.9 4935.1 4959.6 5289.4 5095.4 5106.5 5107.9 5114.4 5123.5 11211.4 16345.4 17215.1 18053.0 18104.6 1589.6 1614.1 1843.7 1851.7 1852.3 8729.9 8755.6 8871.7 9041.1 9085.7 1732.7 1744.4 1769.2 1790.8 1866.2 47708.3 49424.3 49750.3 50204.5 50827.2 9272.6 9435.5 9540.5 9638.3 9680.7 12284.6 12285.1 12292.1 12303.3 12361.3 6735.5 6818.9 6828.4 6846.8 7000.3 6292.7 6323.1 6359.1 6401.8 6416.4 4120.4 4125.2 4128.6 4156.1 4167.1 1684.1 1739.5 1783.2 1796.7 1848.1 885.2 893.9 953.6 965.8 972.3 12710.5 14812.5 14951.6 15378.2 15472.9 834.6 840.1 847.3 855.8 883.4 8678.4 8766.1 8781.1 8987.6 8988.8 290086.0 297620.0 297625.0 299671.0 300254.0 62083.4 64885.4 65075.7 65424.0 66282.7 830.9 855.7 857.3 858.2 985.9 13787.2 14021.5 14184.2 14268.0 14291.3 27702.3 27738.7 28200.6 28621.6 28646.0 36015.6 36216.6 36531.5 37605.8 38900.4 6110.2 6163.2 6239.6 6322.7 6357.9 7365.4 9480.1 9592.9 9634.3 9665.3 7801.6 8552.9 8575.8 8579.9 8694.8 7879.4 8276.6 8586.0 8648.0 8665.4 7756.5 8424.8 8494.2 8751.5 8923.6 6446.1 6533.8 6580.8 6691.9 6813.7 8119.8 8293.8 8404.6 8484.2 8506.6 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#3] mootools.html Cycles:180 Average:4636.99 Median:5768.37 stddev:2394.84 (41.5%) stddev-sans-first:2388.55 08:38:18 INFO - PROCESS | 18369 | Values: 1316.5 1333.9 1400.4 1629.4 1637.3 5671.3 5755.3 6361.5 6530.3 6545.7 6467.1 6608.9 6637.7 6715.1 6719.3 1994.9 2004.2 2020.7 2021.2 2021.6 1964.3 1967.9 1971.8 2017.1 2028.4 1995.0 1999.2 2000.7 2006.6 2017.8 2021.8 2025.1 2026.2 2029.0 2030.3 1968.8 1990.3 2007.6 2024.9 2026.9 6792.2 6794.2 6795.4 6846.5 6847.9 3889.9 4000.8 4002.8 4003.5 4006.5 2460.8 2485.2 2494.4 2609.3 2632.9 809.6 816.9 829.5 833.1 837.2 9076.9 9116.6 9141.4 9144.7 9163.5 3583.0 3603.5 3645.5 3650.4 3672.1 7906.2 7909.0 7911.3 7916.3 7938.0 4008.3 4019.7 4030.2 4030.9 4042.2 3067.8 3134.3 3444.7 3642.7 3662.4 3268.2 3294.6 3304.1 3305.1 3341.3 995.2 1008.7 1009.2 1021.9 1060.4 944.0 984.7 1130.4 1150.1 1152.5 6217.9 6223.7 6224.7 6237.3 6264.7 395.1 403.1 404.4 406.0 406.6 5056.9 5075.7 5110.1 5111.9 5116.9 7475.3 7640.5 7969.9 8164.6 8261.8 7557.5 7584.8 7588.0 7595.4 7625.2 6282.9 6358.2 6359.5 6367.5 6404.8 5942.7 6101.3 6108.1 6110.9 6120.3 6855.4 6885.6 7027.1 7098.2 7119.7 6982.5 7165.5 7177.5 7196.0 7223.7 4996.4 5142.7 6040.3 6119.0 6137.9 6166.4 6228.6 6265.5 6286.2 6286.2 5941.0 5969.3 6000.5 6106.2 6116.5 5781.5 5822.1 5836.8 5837.0 5918.7 5999.6 6024.6 6025.7 6027.3 6028.6 5627.7 5652.2 5660.2 5665.1 5670.2 5688.4 5693.2 5708.9 5720.5 5728.9 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#4] prototype.html Cycles:180 Average:4859.93 Median:5629.83 stddev:1470.29 (26.1%) stddev-sans-first:1433.90 08:38:18 INFO - PROCESS | 18369 | Values: 293.2 299.8 305.4 306.2 307.0 5494.9 5574.8 5639.2 5650.5 5677.7 5385.5 5569.6 5628.9 5630.7 5655.7 4239.9 4246.9 4249.2 4251.9 4256.6 4243.3 4246.3 4248.2 4248.6 4249.7 4085.5 4195.7 4206.1 4215.0 4217.9 4203.6 4222.6 4223.2 4228.2 4229.0 3663.0 3663.0 3669.7 3674.0 3675.6 5293.3 5411.5 5414.4 5417.8 5418.8 4843.5 4849.6 4856.0 4861.9 4862.3 5762.9 5798.7 5810.5 5812.3 5823.6 3762.5 3926.0 3928.0 3934.7 3937.5 6098.8 6171.5 6176.1 6186.3 6211.9 4127.4 4132.5 4133.7 4135.2 4137.0 4195.6 4200.6 4200.8 4201.1 4202.4 4749.3 4855.9 4857.8 4860.8 4863.3 5891.9 5892.7 5893.4 5898.2 5907.4 1458.3 1460.9 1462.4 1463.8 1467.7 960.8 966.7 977.0 987.9 991.5 5117.4 5118.4 5121.3 5123.0 5123.7 6087.5 6094.9 6115.6 6125.4 6146.8 5102.9 5112.4 5115.2 5115.7 5128.3 3254.2 3296.1 3311.0 3324.1 3330.7 5717.7 5754.3 5762.4 5764.9 5775.0 6359.4 6393.7 6394.1 6397.9 6402.3 5822.5 5829.7 5834.1 5839.2 5840.9 6180.6 6183.5 6190.2 6191.2 6204.8 5827.4 6042.5 6052.1 6053.3 6092.8 5823.6 5840.2 5842.9 5848.0 5860.0 3982.1 4008.2 4015.2 4017.0 4017.7 6054.9 6114.4 6186.1 6189.7 6208.8 5939.0 5945.3 5951.6 5955.6 5962.1 5916.9 5922.1 5939.6 5948.4 5949.1 5599.8 5793.6 5809.9 5810.8 5829.2 5933.9 5939.9 5957.3 5962.2 5978.0 5801.7 5830.4 5840.7 5853.3 5860.9 08:38:18 INFO - PROCESS | 18369 | 08:38:18 INFO - PROCESS | 18369 | [#5] yui.html Cycles:180 Average:11648.34 Median:545.06 stddev:13139.90 (2410.7%) stddev-sans-first:13150.91 08:38:18 INFO - PROCESS | 18369 | Values: 673.3 730.7 751.4 756.2 761.3 10790.0 10842.3 10868.6 10884.5 10885.2 10276.6 10339.6 10349.5 10365.1 10391.1 581.5 744.7 753.1 753.1 753.9 589.1 726.2 742.3 742.6 748.0 779.6 783.0 790.0 790.6 792.1 772.6 777.0 777.9 778.4 782.6 580.1 581.2 581.2 582.0 582.3 12010.7 12105.2 12168.1 12178.1 12192.0 11155.3 11402.9 11632.7 11845.9 12039.6 9532.1 9579.0 9588.7 9600.9 9785.5 3226.3 3250.0 3272.0 3273.1 3381.3 40517.0 41221.4 41265.6 41279.8 41296.6 9571.7 9699.9 9815.7 9883.5 9895.8 15348.3 15866.3 15992.7 16001.4 16014.3 6513.1 6585.4 6588.7 6648.9 6668.8 3632.1 3710.9 3730.9 3731.9 3761.5 2651.1 2665.8 2678.1 2679.7 2681.8 455.1 470.8 477.8 478.7 487.5 521.8 533.9 543.9 554.2 566.1 6951.7 7085.8 7137.7 7248.7 8210.7 440.2 480.6 546.2 571.9 594.1 3252.0 3271.4 3420.0 3514.7 3534.2 47059.3 47181.0 47230.8 47526.0 48643.3 40642.8 41050.4 42251.8 42380.6 42789.6 37864.6 38161.8 38411.4 38621.4 38961.8 6678.1 6683.0 6691.0 6755.4 6776.0 28201.6 28559.4 29325.7 29341.7 29391.9 33852.0 34280.7 36951.4 37151.6 37398.0 8613.3 8738.9 8816.7 8895.0 8908.1 9542.7 9874.4 10219.7 10275.3 11210.9 9430.4 9577.1 9669.2 9742.0 10101.8 9688.7 9719.6 9799.5 9893.1 9919.2 9899.9 9929.2 9936.0 10000.4 10576.0 8250.3 8341.9 8365.2 8399.3 8758.9 8301.1 8608.7 9031.2 9032.6 9123.6 08:38:18 INFO - PROCESS | 18369 | -------- Summary: end -------- 08:38:18 INFO - PROCESS | 18369 | 08:38:19 INFO - TEST-INFO | 18369: exit 0 08:38:19 INFO - TEST-OK | dromaeo_css | took 1113274ms 08:38:19 INFO - TEST-START | kraken 08:38:19 INFO - operating with platform_type : linux_ 08:38:19 INFO - Initialising browser for kraken test... 08:38:19 INFO - TEST-INFO | started process 18609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXy9AMa/profile http://localhost:52639/getInfo.html) 08:38:22 INFO - PROCESS | 18609 | -- checkerboarding starts below -- 08:38:22 INFO - PROCESS | 18609 | RENDERTRACE 0.041079 rect red 0 0 1024 768 // viewport 08:38:22 INFO - PROCESS | 18609 | RENDERTRACE 340.43 rect brown 0 0 1024 768 // page 08:38:22 INFO - PROCESS | 18609 | RENDERTRACE 340.463 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 08:38:22 INFO - PROCESS | 18609 | Checkerboarded for 1 frames (350.467 ms), 786432 peak, 13517 severity. 08:38:22 INFO - PROCESS | 18609 | 08:38:22 INFO - PROCESS | 18609 | (process:18679): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:38:23 INFO - PROCESS | 18609 | __metrics Screen width/height:1600/1200 08:38:23 INFO - PROCESS | 18609 | colorDepth:24 08:38:23 INFO - PROCESS | 18609 | Browser inner width/height: 1024/697 08:38:23 INFO - PROCESS | 18609 | __metrics 08:38:23 INFO - PROCESS | 18609 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:38:24 INFO - TEST-INFO | 18609: exit 0 08:38:24 INFO - Browser initialized. 08:38:24 INFO - Running cycle 1/1 for kraken test... 08:38:24 INFO - TEST-INFO | started process 18728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXy9AMa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:25 INFO - PROCESS | 18728 | -- checkerboarding starts below -- 08:38:25 INFO - PROCESS | 18728 | RENDERTRACE 0.041189 rect red 0 0 10 10 // viewport 08:38:25 INFO - PROCESS | 18728 | RENDERTRACE 34.3825 rect brown 0 0 10 10 // page 08:38:25 INFO - PROCESS | 18728 | RENDERTRACE 34.4137 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:38:25 INFO - PROCESS | 18728 | Checkerboarded for 1 frames (40.5308 ms), 100 peak, 0 severity. 08:38:25 INFO - PROCESS | 18728 | 08:38:25 INFO - PROCESS | 18728 | (process:18782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:38:36 INFO - PROCESS | 18728 | RSS: Main: 149946368 08:38:36 INFO - PROCESS | 18728 | 08:38:39 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52639/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:39 INFO - PROCESS | 18728 | RSS: Main: 149696512 08:38:39 INFO - PROCESS | 18728 | 08:38:42 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52639/tests/kraken/driver.html?testName=audio-dft) 08:38:43 INFO - PROCESS | 18728 | RSS: Main: 153624576 08:38:43 INFO - PROCESS | 18728 | 08:38:46 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52639/tests/kraken/driver.html?testName=audio-fft) 08:38:46 INFO - PROCESS | 18728 | RSS: Main: 147132416 08:38:46 INFO - PROCESS | 18728 | 08:38:48 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52639/tests/kraken/driver.html?testName=audio-oscillator) 08:38:49 INFO - PROCESS | 18728 | RSS: Main: 147759104 08:38:49 INFO - PROCESS | 18728 | 08:38:51 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:52 INFO - PROCESS | 18728 | RSS: Main: 146743296 08:38:52 INFO - PROCESS | 18728 | 08:38:55 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52639/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:55 INFO - PROCESS | 18728 | RSS: Main: 148660224 08:38:55 INFO - PROCESS | 18728 | 08:38:59 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52639/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:59 INFO - PROCESS | 18728 | RSS: Main: 146763776 08:38:59 INFO - PROCESS | 18728 | 08:39:02 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52639/tests/kraken/driver.html?testName=json-parse-financial) 08:39:03 INFO - PROCESS | 18728 | RSS: Main: 148303872 08:39:03 INFO - PROCESS | 18728 | 08:39:05 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:05 INFO - PROCESS | 18728 | RSS: Main: 147226624 08:39:05 INFO - PROCESS | 18728 | 08:39:07 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:08 INFO - PROCESS | 18728 | RSS: Main: 147607552 08:39:08 INFO - PROCESS | 18728 | 08:39:10 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:11 INFO - PROCESS | 18728 | RSS: Main: 147537920 08:39:11 INFO - PROCESS | 18728 | 08:39:13 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:14 INFO - PROCESS | 18728 | RSS: Main: 147218432 08:39:14 INFO - PROCESS | 18728 | 08:39:16 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:17 INFO - PROCESS | 18728 | RSS: Main: 147673088 08:39:17 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | Cycle 1(1): loaded http://localhost:52639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52639/tests/kraken/driver.html?testName=ai-astar) 08:39:19 INFO - PROCESS | 18728 | RSS: Main: 149696512 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | __start_tp_report 08:39:19 INFO - PROCESS | 18728 | _x_x_mozilla_page_load 08:39:19 INFO - PROCESS | 18728 | _x_x_mozilla_page_load_details 08:39:19 INFO - PROCESS | 18728 | |i|pagename|runs| 08:39:19 INFO - PROCESS | 18728 | |0;ai-astar;116;112;117;118;116;128;115;117;116;120 08:39:19 INFO - PROCESS | 18728 | |1;audio-beat-detection;162;137;160;169;136;161;159;140;171;134 08:39:19 INFO - PROCESS | 18728 | |2;audio-dft;166;164;165;164;167;167;173;166;166;164 08:39:19 INFO - PROCESS | 18728 | |3;audio-fft;74;76;78;74;77;132;74;75;76;74 08:39:19 INFO - PROCESS | 18728 | |4;audio-oscillator;97;97;139;96;97;97;139;98;97;140 08:39:19 INFO - PROCESS | 18728 | |5;imaging-gaussian-blur;110;111;111;109;110;110;110;110;110;110 08:39:19 INFO - PROCESS | 18728 | |6;imaging-darkroom;147;147;148;149;148;149;148;148;148;147 08:39:19 INFO - PROCESS | 18728 | |7;imaging-desaturate;97;99;97;97;96;96;97;96;97;96 08:39:19 INFO - PROCESS | 18728 | |8;json-parse-financial;72;73;71;72;72;71;71;73;78;70 08:39:19 INFO - PROCESS | 18728 | |9;json-stringify-tinderbox;70;68;67;68;69;68;68;68;68;69 08:39:19 INFO - PROCESS | 18728 | |10;stanford-crypto-aes;82;83;85;83;83;84;84;85;84;84 08:39:19 INFO - PROCESS | 18728 | |11;stanford-crypto-ccm;120;130;136;122;128;130;124;129;124;127 08:39:19 INFO - PROCESS | 18728 | |12;stanford-crypto-pbkdf2;138;154;154;151;151;150;147;156;149;137 08:39:19 INFO - PROCESS | 18728 | |13;stanford-crypto-sha256-iterative;70;74;73;72;73;70;71;72;70;72 08:39:19 INFO - PROCESS | 18728 | __end_tp_report 08:39:19 INFO - PROCESS | 18728 | __start_cc_report 08:39:19 INFO - PROCESS | 18728 | _x_x_mozilla_cycle_collect,806 08:39:19 INFO - PROCESS | 18728 | __end_cc_report 08:39:19 INFO - PROCESS | 18728 | __startTimestamp1453307959598__endTimestamp 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | ------- Summary: start ------- 08:39:19 INFO - PROCESS | 18728 | Number of tests: 14 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#0] ai-astar Cycles:10 Average:117.50 Median:117.00 stddev:4.22 (3.6%) stddev-sans-first:4.44 08:39:19 INFO - PROCESS | 18728 | Values: 116.0 112.0 117.0 118.0 116.0 128.0 115.0 117.0 116.0 120.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:160.50 stddev:14.47 (9.0%) stddev-sans-first:14.97 08:39:19 INFO - PROCESS | 18728 | Values: 162.0 137.0 160.0 169.0 136.0 161.0 159.0 140.0 171.0 134.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:2.66 (1.6%) stddev-sans-first:2.82 08:39:19 INFO - PROCESS | 18728 | Values: 166.0 164.0 165.0 164.0 167.0 167.0 173.0 166.0 166.0 164.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:17.98 (23.8%) stddev-sans-first:18.89 08:39:19 INFO - PROCESS | 18728 | Values: 74.0 76.0 78.0 74.0 77.0 132.0 74.0 75.0 76.0 74.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:97.00 stddev:20.46 (21.1%) stddev-sans-first:21.17 08:39:19 INFO - PROCESS | 18728 | Values: 97.0 97.0 139.0 96.0 97.0 97.0 139.0 98.0 97.0 140.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:39:19 INFO - PROCESS | 18728 | Values: 110.0 111.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:39:19 INFO - PROCESS | 18728 | Values: 147.0 147.0 148.0 149.0 148.0 149.0 148.0 148.0 148.0 147.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.97 08:39:19 INFO - PROCESS | 18728 | Values: 97.0 99.0 97.0 97.0 96.0 96.0 97.0 96.0 97.0 96.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#8] json-parse-financial Cycles:10 Average:72.30 Median:72.00 stddev:2.21 (3.1%) stddev-sans-first:2.35 08:39:19 INFO - PROCESS | 18728 | Values: 72.0 73.0 71.0 72.0 72.0 71.0 71.0 73.0 78.0 70.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 08:39:19 INFO - PROCESS | 18728 | Values: 70.0 68.0 67.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.95 (1.1%) stddev-sans-first:0.78 08:39:19 INFO - PROCESS | 18728 | Values: 82.0 83.0 85.0 83.0 83.0 84.0 84.0 85.0 84.0 84.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.50 stddev:4.67 (3.6%) stddev-sans-first:4.21 08:39:19 INFO - PROCESS | 18728 | Values: 120.0 130.0 136.0 122.0 128.0 130.0 124.0 129.0 124.0 127.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:151.00 stddev:6.46 (4.3%) stddev-sans-first:5.58 08:39:19 INFO - PROCESS | 18728 | Values: 138.0 154.0 154.0 151.0 151.0 150.0 147.0 156.0 149.0 137.0 08:39:19 INFO - PROCESS | 18728 | 08:39:19 INFO - PROCESS | 18728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:1.42 (2.0%) stddev-sans-first:1.36 08:39:19 INFO - PROCESS | 18728 | Values: 70.0 74.0 73.0 72.0 73.0 70.0 71.0 72.0 70.0 72.0 08:39:19 INFO - PROCESS | 18728 | -------- Summary: end -------- 08:39:19 INFO - PROCESS | 18728 | 08:39:20 INFO - TEST-INFO | 18728: exit 0 08:39:20 INFO - TEST-OK | kraken | took 61402ms 08:39:20 INFO - TEST-START | v8_7 08:39:20 INFO - operating with platform_type : linux_ 08:39:20 INFO - Initialising browser for v8_7 test... 08:39:20 INFO - TEST-INFO | started process 19010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL9fJyO/profile http://localhost:52639/getInfo.html) 08:39:24 INFO - PROCESS | 19010 | 08:39:24 INFO - PROCESS | 19010 | (process:19079): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:39:24 INFO - PROCESS | 19010 | __metrics Screen width/height:1600/1200 08:39:24 INFO - PROCESS | 19010 | colorDepth:24 08:39:24 INFO - PROCESS | 19010 | Browser inner width/height: 1024/697 08:39:24 INFO - PROCESS | 19010 | __metrics 08:39:25 INFO - PROCESS | 19010 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:39:26 INFO - TEST-INFO | 19010: exit 0 08:39:26 INFO - Browser initialized. 08:39:26 INFO - Running cycle 1/1 for v8_7 test... 08:39:26 INFO - TEST-INFO | started process 19128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL9fJyO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:26 INFO - PROCESS | 19128 | -- checkerboarding starts below -- 08:39:26 INFO - PROCESS | 19128 | RENDERTRACE 0.033592 rect red 0 0 10 10 // viewport 08:39:26 INFO - PROCESS | 19128 | RENDERTRACE 5.75225 rect red 0 0 10 10 // viewport 08:39:26 INFO - PROCESS | 19128 | RENDERTRACE 40.0239 rect brown 0 0 10 10 // page 08:39:26 INFO - PROCESS | 19128 | RENDERTRACE 40.0416 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:39:26 INFO - PROCESS | 19128 | Checkerboarded for 2 frames (51.0941 ms), 100 peak, 574 severity. 08:39:27 INFO - PROCESS | 19128 | 08:39:27 INFO - PROCESS | 19128 | (process:19185): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:39:37 INFO - PROCESS | 19128 | RSS: Main: 150249472 08:39:37 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | Cycle 1(1): loaded http://localhost:52639/tests/v8_7/run.html (next: http://localhost:52639/tests/v8_7/run.html) 08:40:00 INFO - PROCESS | 19128 | RSS: Main: 145342464 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | __start_tp_report 08:40:00 INFO - PROCESS | 19128 | _x_x_mozilla_page_load 08:40:00 INFO - PROCESS | 19128 | _x_x_mozilla_page_load_details 08:40:00 INFO - PROCESS | 19128 | |i|pagename|runs| 08:40:00 INFO - PROCESS | 19128 | |0;Richards;166.25103906899417 08:40:00 INFO - PROCESS | 19128 | |1;DeltaBlue;186.25442354255912 08:40:00 INFO - PROCESS | 19128 | |2;Encrypt;278.00945232137894 08:40:00 INFO - PROCESS | 19128 | |3;Decrypt;5223.958333333333 08:40:00 INFO - PROCESS | 19128 | |4;RayTrace;1088.0434782608695 08:40:00 INFO - PROCESS | 19128 | |5;Earley;706.7137809187279 08:40:00 INFO - PROCESS | 19128 | |6;Boyer;12268.292682926829 08:40:00 INFO - PROCESS | 19128 | |7;RegExp;43042.55319148936 08:40:00 INFO - PROCESS | 19128 | |8;Splay;604.2042042042042 08:40:00 INFO - PROCESS | 19128 | |9;NavierStokes;4835.748792270531 08:40:00 INFO - PROCESS | 19128 | __end_tp_report 08:40:00 INFO - PROCESS | 19128 | __startTimestamp1453308000766__endTimestamp 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | ------- Summary: start ------- 08:40:00 INFO - PROCESS | 19128 | Number of tests: 10 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 166.3 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 186.3 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 278.0 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 5224.0 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#4] RayTrace Cycles:1 Average:1088.04 Median:1088.04 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 1088.0 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#5] Earley Cycles:1 Average:706.71 Median:706.71 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 706.7 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 12268.3 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#7] RegExp Cycles:1 Average:43042.55 Median:43042.55 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 43042.6 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#8] Splay Cycles:1 Average:604.20 Median:604.20 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 604.2 08:40:00 INFO - PROCESS | 19128 | 08:40:00 INFO - PROCESS | 19128 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:40:00 INFO - PROCESS | 19128 | Values: 4835.7 08:40:00 INFO - PROCESS | 19128 | -------- Summary: end -------- 08:40:00 INFO - PROCESS | 19128 | 08:40:01 INFO - TEST-INFO | 19128: exit 0 08:40:01 INFO - TEST-OK | v8_7 | took 41137ms 08:40:01 INFO - SUITE-END | took 1215s 08:40:01 INFO - Completed test suite (00:20:15) 08:40:01 INFO - Working with test: dromaeo_css 08:40:01 INFO - Generating results file: dromaeo_css 08:40:01 INFO - Working with test: kraken 08:40:01 INFO - Generating results file: kraken 08:40:01 INFO - javascript benchmark 08:40:01 INFO - Working with test: v8_7 08:40:01 INFO - Generating results file: v8_7 08:40:01 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:40:01 INFO - process_Request line: dromaeo_css 5946.89 graph.html#tests=[[72,132,43]] 08:40:01 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:01 INFO - process_Request line: kraken 1553.80 graph.html#tests=[[232,132,43]] 08:40:01 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:01 INFO - process_Request line: v8_7 20298.60 graph.html#tests=[[230,132,43]] 08:40:01 INFO - RETURN: dromaeo_css: 5946.89 08:40:01 INFO - RETURN: kraken: 1553.80 08:40:01 INFO - RETURN: v8_7: 20298.60 08:40:01 INFO - javascript benchmark 08:40:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2567.3068271566676, 2592.027989503936, 2627.855467949263, 2640.1155612869693, 2645.748653877882, 4431.889202769932, 4457.732536047839, 4519.683622146451, 4519.819207231711, 4539.364488971542, 4433.401490798741, 4459.264221403472, 4482.462104547459, 4490.30400287955, 4584.7478388688605, 4113.732607380525, 4169.499660040799, 4220.620144187023, 4227.788610569474, 4237.682173836959, 256.3044302979519, 4153.252414565377, 4196.727212731178, 4233.216854881842, 4277.978610106945, 4105.4252404663375, 4183.0, 4252.298370768819, 4256.297710877701, 4283.186194623043, 4229.38673892287, 4243.681723870722, 4250.362445633149, 4260.08408192237, 4296.548862369469, 4020.296448121567, 4111.8897897567485, 4222.78886055696, 4242.193983143193, 4245.787710614457, 4283.079137985348, 4330.545292744279, 4392.34114882767, 4402.559744025604, 4436.201483732927, 4708.434987801452, 4735.0, 4749.050189961987, 4765.070811191819, 4776.928346074812, 4627.791749371287, 4726.692764970266, 4729.929051064237, 4732.0, 4737.455192652855, 4401.141777353418, 4404.471463424377, 4413.360062790909, 4417.602415782595, 4473.731576105444, 4861.756912154378, 4866.31871537985, 4867.221244600918, 4872.0, 4918.0, 4679.9298010529865, 4688.226442636927, 4694.413198350207, 4696.671233013656, 4728.550787675165, 4620.468646105741, 4723.7874295656775, 4801.4718380978065, 4808.951910480921, 4890.217565189552, 4794.712317260975, 4819.2530157825595, 4819.903601927942, 4830.541098595698, 4866.099771542276, 4602.585767280961, 4792.329073929653, 4797.64017698674, 4809.422869255712, 4839.588634965997, 3969.285528604821, 3978.522577290744, 4012.4382586437923, 4039.6768258539246, 4044.3529035354204, 3541.9197144871064, 3542.98228508861, 3550.7692000019915, 3573.857045718142, 3586.3903136466865, 4125.546189919107, 4181.686373521998, 4184.707070505096, 4198.685098617555, 4202.684798640114, 4704.623630109583, 4753.643476739258, 4758.357621721023, 4775.785089670903, 4784.617230621542, 4125.8968525787095, 4163.208990291835, 4184.8744537663915, 4194.0, 4223.408722778752, 4181.832726690959, 4230.746155230696, 4246.723962942398, 4271.743695378287, 4272.807723652443, 4621.214393553104, 4623.93064104032, 4639.420072490939, 4642.234031384851, 4681.7190968542, 4807.18277892766, 4851.151048566558, 4858.392700912386, 4862.270659401118, 4908.141075311878, 4468.151051300242, 4542.613877820422, 4544.977275113603, 4598.103369842982, 4617.8152873884665, 4671.089137618132, 4678.812847486062, 4681.110588988081, 4696.929546056744, 4716.434027916672, 4759.452662943667, 4768.523147685204, 4773.04539092176, 4779.928301075556, 4808.807647694193, 4510.977445112753, 4596.701214421052, 4618.399608050931, 4696.718196908197, 4718.811247550059, 4592.839250626212, 4604.1252162089095, 4606.309053641847, 4631.76841157934, 4653.046125544188, 4494.483134439451, 4547.567981041796, 4555.453345598549, 4556.0, 4583.54164583539, 4565.908681826279, 4642.257238841769, 4661.883452913704, 4694.600958918393, 4734.33719279308, 4549.340345649928, 4565.6119229865835, 4581.060882519142, 4607.470140933836, 4625.283081122431], "unit": "score", "name": "dojo.html", "value": 4380.239566765716}, {"lowerIsBetter": false, "replicates": [484.3799936081817, 503.8110060257793, 521.8987935456187, 524.6904326447395, 547.7507733981039, 30835.22911927203, 31616.20959476014, 31650.0, 31806.0, 31818.68181318186, 34356.31287374251, 34897.65102348976, 35083.122921926966, 35215.647843521554, 35315.2936941261, 7579.6589153488085, 7812.140664526926, 7817.843643127134, 7823.647935842901, 7828.608569571527, 7728.497647652913, 7787.299143077122, 7798.532088074705, 7812.726554570591, 7818.530888146701, 7800.063992320929, 7824.608769561528, 7831.4909530880595, 7853.5680537570415, 7890.960545197295, 7763.068431788165, 7815.413843961697, 7843.137254901956, 7843.764687059397, 7845.686172553091, 7782.571958542278, 7889.684412623488, 7893.605319733991, 7905.367570594339, 7925.643346049442, 34712.652873471445, 34793.82603086994, 34815.4777678335, 34969.65030349689, 35028.47457288143, 2698.9878795451705, 2708.6485625547566, 2724.5913113033007, 2731.3171707073234, 2740.657417822772, 26619.866900665373, 27003.594946075824, 27131.45737085267, 27194.728052719416, 27933.441331173464, 3446.7414943879307, 3480.286541259036, 3503.9474407883904, 3510.1751088494184, 3617.6924961378313, 204070.0, 204961.0, 205026.99999999852, 205096.0, 205409.0, 44421.55578444174, 45380.54619453829, 50907.0, 51028.489715102376, 51976.0, 46339.0, 46372.0, 46374.76812615915, 46596.3010554842, 46675.29987050197, 12949.870501294867, 13194.0, 13216.074874758675, 13225.404856781468, 13225.933870330588, 9469.621215151317, 9540.713778586654, 9624.66313679018, 9640.517974101407, 9642.42145471274, 17550.912245438692, 17750.91124544369, 17852.55368615795, 17858.821411785975, 17914.5521361967, 7120.465965052642, 7293.416526677853, 7294.869295259244, 7403.297241634346, 7435.776926692208, 856.6359297298624, 860.2515811244133, 926.4441335198827, 943.4150826487621, 946.6024269806697, 23293.301200963997, 23377.0, 23444.64833027506, 23465.882670586878, 23501.764982350298, 970.5826494607387, 1000.5497526113278, 1011.7672935224939, 1013.99493002536, 1063.3141623652855, 12530.68673283157, 12547.184433012008, 12657.0, 12677.683057923441, 12689.428975695932, 246647.0, 248835.0, 248986.0, 249200.0, 251214.0, 42156.15687686229, 42434.57565424368, 42509.36235956463, 42614.36078458826, 42622.0, 1149.4425203776161, 1171.9296842189497, 1174.1194104421684, 1185.6739396665814, 1185.8814118588073, 23092.307230783103, 23490.647640285068, 23670.17154399588, 23734.169304074276, 23765.0, 34403.31193376169, 35156.824215878754, 35215.82392088023, 35226.0, 35307.82346088253, 229667.0, 231464.0, 231955.0, 232355.0, 232524.0, 23531.647025294293, 24089.879550602134, 27195.320116997234, 27609.119028525027, 27962.580561292005, 31988.0, 32087.0, 32684.34631307313, 32855.67144328526, 32856.0, 27856.44287114287, 28065.0, 28084.0, 28231.43537129205, 28346.2913427166, 27819.582706259018, 27927.860360698065, 29905.401891961603, 31228.531572025982, 32297.0, 28375.71624283731, 28960.42079158447, 29126.854365728035, 29134.854325728236, 29206.70793292125, 24969.625455617817, 25001.0, 27748.30629234285, 27790.86104569464, 27932.581011285252, 22193.334199974026, 22254.443638909157, 22293.888530557244, 22459.764712940945, 22478.887605561868], "unit": "score", "name": "ext.html", "value": 15607.226712512476}, {"lowerIsBetter": false, "replicates": [343.62888080872654, 345.3679766028167, 347.4996005751718, 349.6817895714897, 351.0819207771678, 13917.721645567082, 14165.858341416582, 14984.400623975029, 15723.292451839667, 16132.596685082879, 10385.584576616946, 10698.411587362692, 13290.933545332284, 15201.087934723924, 15230.390784368612, 4553.362529245908, 4557.248054071074, 4704.717716936994, 4705.952940470585, 4754.334393184957, 4628.352030715686, 4706.247000479907, 4707.317438971347, 4711.081339138852, 4712.6229901607785, 4668.136394766979, 4700.482946875841, 4902.166631672624, 5125.308083408748, 5125.794968201268, 4874.171390863562, 4923.876903077416, 4935.1116798976345, 4959.603231741452, 5289.3917199521775, 5095.363079615048, 5106.463821298785, 5107.872303192413, 5114.3862736471865, 5123.487651234884, 11211.439428028565, 16345.427910023092, 17215.139243037796, 18053.0, 18104.63790724178, 1589.6264377871191, 1614.0557773702399, 1843.7094034175996, 1851.7314989326608, 1852.2961274715522, 8729.912700873037, 8755.605997730117, 8871.733847984571, 9041.050689677555, 9085.727428177099, 1732.748751431048, 1744.389463687712, 1769.2392271323454, 1790.811964743696, 1866.225516410688, 47708.284375734394, 49424.258636120125, 49750.253746193834, 50204.49795502035, 50827.237591436155, 9272.629094836131, 9435.528223588793, 9540.475273860004, 9638.277129215337, 9680.661176858775, 12284.631461056182, 12285.078619103424, 12292.139550231577, 12303.32331721746, 12361.258324500559, 6735.461163106939, 6818.897716534256, 6828.419584335387, 6846.760363387258, 7000.334968178015, 6292.653904035231, 6323.146375239376, 6359.141515895388, 6401.775937842153, 6416.422521973045, 4120.361343991626, 4125.23683118624, 4128.566500517462, 4156.085661154541, 4167.083241686824, 1684.107423065777, 1739.5216315513335, 1783.179737320821, 1796.6765982123081, 1848.0944337274639, 885.181207383168, 893.9374243802871, 953.609020301673, 965.7682156282442, 972.2853702528636, 12710.491580336868, 14812.481563145238, 14951.551453456414, 15378.231088445757, 15472.92263538675, 834.6285902773329, 840.1220724343076, 847.3306088190384, 855.7732200966749, 883.4478450968145, 8678.435901666371, 8766.12338766131, 8781.07798681142, 8987.550622468982, 8988.775280617907, 290086.0, 297620.0, 297625.0, 299671.0, 300254.0, 62083.37916620776, 64885.35114648887, 65075.67462162659, 65424.0, 66282.66858665676, 830.8504469195602, 855.7389996051139, 857.2884505860121, 858.1547176031604, 985.8964808695271, 13787.241701706502, 14021.5092471763, 14184.219867907364, 14268.0, 14291.28543572838, 27702.307442314104, 27738.722612773614, 28200.576991344737, 28621.570676439453, 28646.0, 36015.63984360228, 36216.63783362238, 36531.452028219064, 37605.81197094107, 38900.41649375205, 6110.205673262448, 6163.229596300463, 6239.594426362272, 6322.683865806599, 6357.93642063592, 7365.410767138723, 9480.099390557885, 9592.9040709592, 9634.325597208408, 9665.3234273603, 7801.609919504115, 8552.914470855461, 8575.785605359915, 8579.871301930601, 8694.82610347802, 7879.409044321814, 8276.586170691562, 8585.957070214608, 8647.956760216159, 8665.393422460367, 7756.534607923542, 8424.789380265298, 8494.150584941457, 8751.474911505331, 8923.598438070172, 6446.0975463434215, 6533.803985880431, 6580.80257592273, 6691.933080669131, 6813.693383797642, 8119.75640730779, 8293.751187464386, 8404.579771011548, 8484.194001570087, 8506.61720222579], "unit": "score", "name": "jquery.html", "value": 7205.668072285583}, {"lowerIsBetter": false, "replicates": [1316.473410635746, 1333.866613338666, 1400.3838311143097, 1629.405267077517, 1637.3368785641812, 5671.262735844345, 5755.280589926259, 6361.459275961543, 6530.346965303467, 6545.672716364181, 6467.126937863387, 6608.942569188931, 6637.668116594175, 6715.093462382577, 6719.294474080212, 1994.8803071815664, 2004.208337706605, 2020.7474065741783, 2021.2218295956015, 2021.5653634468586, 1964.2535836382226, 1967.9016049197483, 1971.7732460767052, 2017.0519855667812, 2028.4117605894273, 1994.9900250498727, 1999.1803360622148, 2000.7098970649247, 2006.6388050150968, 2017.8385729141633, 2021.8483613728956, 2025.1393157907978, 2026.1895241903358, 2028.9999999999927, 2030.3198428526462, 1968.8228059474716, 1990.3431867483696, 2007.6085163393145, 2024.908879100444, 2026.8986550672555, 6792.150981127359, 6794.150731158606, 6795.38841504262, 6846.486513511507, 6847.863042739117, 3889.863854765098, 4000.7999600019884, 4002.799860006988, 4003.539592946819, 4006.4991876015497, 2460.772104607721, 2485.155047283914, 2494.4013436775226, 2609.29549021765, 2632.88152033159, 809.5709274084744, 816.8856360109589, 829.5396055189367, 833.0960907415462, 837.1628371628371, 9076.909230907673, 9116.635334586608, 9141.405808622418, 9144.725658230263, 9163.496007719572, 3583.032581203113, 3603.5405660706933, 3645.489631451599, 3650.379435495972, 3672.081979505124, 7906.248906353887, 7909.0, 7911.28798408146, 7916.258423146898, 7938.04743430792, 4008.3386241269864, 4019.738716983387, 4030.1738143680477, 4030.899227519277, 4042.191561687674, 3067.785255032171, 3134.2634480896972, 3444.6727560881677, 3642.653947874948, 3662.377395842713, 3268.166617512519, 3294.6046474423224, 3304.1244070321386, 3305.1241421023446, 3341.281624450706, 995.2088089968493, 1008.6973907827769, 1009.2228983682523, 1021.9131373833159, 1060.4061725433783, 943.9952800235955, 984.7095106943469, 1130.3895896215952, 1150.1201580790703, 1152.464104191555, 6217.875642487125, 6223.657698826608, 6224.688765561704, 6237.251529816451, 6264.718087686065, 395.10114489536534, 403.0508153298997, 404.4014858010161, 406.0478178671012, 406.57309824683966, 5056.898862022739, 5075.695458272516, 5110.054639891632, 5111.923321150186, 5116.923246151311, 7475.252474752481, 7640.465167438226, 7969.880451793228, 8164.632591533276, 8261.752147435587, 7557.508761930457, 7584.772456826304, 7588.0, 7595.392368610498, 7625.199354067743, 6282.937170628235, 6358.205224346957, 6359.523035772243, 6367.522435817425, 6404.839879003062, 5942.6731529766275, 6101.298350689727, 6108.144859719731, 6110.877782444415, 6120.296165940974, 6855.383015528626, 6885.586864788129, 7027.051348067946, 7098.183708873546, 7119.67961441726, 6982.511224214256, 7165.462590305644, 7177.533460325062, 7195.964020179866, 7223.674934628059, 4996.375453068366, 5142.6914385137015, 6040.305364882919, 6118.969405152946, 6137.907931380943, 6166.445019948226, 6228.5951413158, 6265.467435268053, 6286.18279623646, 6286.245650521967, 5940.970295148497, 5969.343372229138, 6000.489958353414, 6106.175666284995, 6116.5412594056515, 5781.4507621775865, 5822.097574875901, 5836.795712150054, 5836.970815146067, 5918.674472904032, 5999.5800293979, 6024.638521688713, 6025.698715064317, 6027.276726792813, 6028.577999540165, 5627.718614069362, 5652.236948012131, 5660.179274005164, 5665.065264231355, 5670.234518340137, 5688.40271771458, 5693.231413759255, 5708.885822283448, 5720.542356611378, 5728.914066288926], "unit": "score", "name": "mootools.html", "value": 3761.8823960274644}, {"lowerIsBetter": false, "replicates": [293.2331951945662, 299.8380874327863, 305.3907454628016, 306.22983197258895, 307.02672528085964, 5494.862628434291, 5574.804881829137, 5639.2105105285245, 5650.51970582501, 5677.716114194294, 5385.488378604036, 5569.554435645149, 5628.915566266499, 5630.746616402262, 5655.7172141392975, 4239.894002649928, 4246.936295955563, 4249.235137675225, 4251.914961700764, 4256.638185754215, 4243.342281946303, 4246.3205887058075, 4248.192843359751, 4248.617624413802, 4249.681273904454, 4085.4679495189303, 4195.685323600727, 4206.1377417629465, 4214.957850421502, 4217.894552636178, 4203.642690371322, 4222.556631553689, 4223.176480586287, 4228.154369126187, 4228.957710422918, 3662.963370366289, 3663.0292972362345, 3669.743117981742, 3673.963260367389, 3675.6140605236333, 5293.258943747878, 5411.485908838654, 5414.377346605152, 5417.8103766367985, 5418.810341638064, 4843.491433399513, 4849.587785038276, 4856.0, 4861.8784530386665, 4862.319275301461, 5762.942370576283, 5798.681072541009, 5810.535157187415, 5812.273465816773, 5823.5923485355615, 3762.473253744478, 3925.9803700981597, 3928.0376307804772, 3934.6852251819787, 3937.547182074041, 6098.786542470993, 6171.506279497629, 6176.073588961647, 6186.319504854462, 6211.875762484725, 4127.360259159835, 4132.462779838602, 4133.689973252018, 4135.214309281227, 4136.9793151034055, 4195.559466255999, 4200.6429453496185, 4200.831966721297, 4201.075763332062, 4202.390653355246, 4749.2876068589985, 4855.927161092586, 4857.805687772449, 4860.8298709545, 4863.319135321058, 5891.911621325684, 5892.734826932799, 5893.44012318829, 5898.233229680114, 5907.438793314628, 1458.2562892924473, 1460.8612181842707, 1462.436961769705, 1463.8389777124507, 1467.6551010512521, 960.8270511308032, 966.7244835222068, 976.9706908792748, 987.9012098790207, 991.548845275398, 5117.437081920985, 5118.411382690963, 5121.28302037715, 5122.974385128051, 5123.718195499208, 6087.482563982111, 6094.878102437927, 6115.602485838406, 6125.387461253839, 6146.815595532141, 5102.872428189325, 5112.36095488064, 5115.18157094863, 5115.667481613757, 5128.256402821645, 3254.23525471514, 3296.1100502864574, 3311.03979845842, 3324.1191084362663, 3330.6835850594157, 5717.742701578439, 5754.251947246915, 5762.423757624288, 5764.855878603068, 5775.047117225695, 6359.395857393541, 6393.680315984182, 6394.136791533177, 6397.904031439532, 6402.295747467775, 5822.505087067647, 5829.7085145743395, 5834.066549352084, 5839.240898683144, 5840.919429905481, 6180.598261113193, 6183.505319574513, 6190.164327815687, 6191.19514463117, 6204.7828326008375, 5827.388124246893, 6042.486388657014, 6052.092186172109, 6053.273607166992, 6092.847678808065, 5823.563232757476, 5840.2115714379715, 5842.883142337045, 5848.0, 5859.970700146472, 3982.064214909552, 4008.1983603278877, 4015.1969606079483, 4017.035911381189, 4017.718759686794, 6054.878902421839, 6114.357992410733, 6186.072089186478, 6189.721462534107, 6208.751649934133, 5939.049752039826, 5945.286565612154, 5951.55363347742, 5955.642661440327, 5962.135490353788, 5916.934951708734, 5922.141289512911, 5939.613925094855, 5948.405159484017, 5949.1076338549565, 5599.776008959759, 5793.565482588739, 5809.8547536311935, 5810.796622118375, 5829.15477255804, 5933.931892259435, 5939.940600594112, 5957.314908785545, 5962.165296858357, 5977.970110149421, 5801.680907550125, 5830.358660547252, 5840.707964601838, 5853.326867410302, 5860.882782344414], "unit": "score", "name": "prototype.html", "value": 4379.496812058933}, {"lowerIsBetter": false, "replicates": [673.2661399075007, 730.6894569807831, 751.4138971602152, 756.1833220122272, 761.3224230434914, 10790.028897399232, 10842.349459032454, 10868.565257389704, 10884.510197041142, 10885.23803333767, 10276.640317588886, 10339.638112666058, 10349.534270957805, 10365.067143957041, 10391.064804167623, 581.4534337722548, 744.694675183175, 753.1038064702985, 753.1113286322137, 753.9359154471877, 589.0957380421055, 726.1576571177435, 742.3170682971679, 742.5915746339518, 748.0462410426722, 779.5829231361223, 783.0251337085336, 789.9967041856838, 790.6046976511744, 792.1207459719707, 772.5635016215848, 777.0481160578303, 777.9377649788004, 778.353966208046, 782.5500337306044, 580.1124279851833, 581.1631250998548, 581.2066529187629, 581.9505342045932, 582.2808831093596, 12010.699732506757, 12105.15263931525, 12168.14822962393, 12178.147529672926, 12192.0, 11155.274907131092, 11402.885971140266, 11632.651020469399, 11845.94077029618, 12039.6388108356, 9532.094451027142, 9579.0, 9588.712338629852, 9600.90399096007, 9785.461799601018, 3226.2579606690356, 3250.0, 3272.0, 3273.099897528175, 3381.2899291148888, 40517.0, 41221.38167927483, 41265.58734412648, 41279.79360103211, 41296.58703412987, 9571.676157464719, 9699.903000970042, 9815.656452024145, 9883.456409897524, 9895.802083958424, 15348.309326080353, 15866.286017129258, 15992.680146397008, 16001.439949601709, 16014.27935742871, 6513.088167656532, 6585.374389432996, 6588.73645054202, 6648.867022659617, 6668.799936001928, 3632.055665526982, 3710.8515659373325, 3730.906727331784, 3731.906702332409, 3761.5298087739034, 2651.125128707522, 2665.8000649950945, 2678.076063758, 2679.678438587343, 2681.839089654627, 455.0852785900364, 470.7975570504716, 477.82081719355244, 478.7103802199689, 487.5270987142466, 521.7964993652479, 533.9385970613351, 543.8830651409887, 554.2074832988865, 566.1366416215222, 6951.7219311228, 7085.822854428578, 7137.714491420285, 7248.710051597983, 8210.671573137128, 440.1680823244071, 480.57229066131174, 546.2298159594952, 571.9428057194331, 594.1444320178929, 3251.9674803252137, 3271.4275001874576, 3419.9829000855334, 3514.7188224941942, 3534.2048039190977, 47059.294110588366, 47181.0, 47230.76384618055, 47526.0, 48643.27035094477, 40642.79678601588, 41050.38424423636, 42251.7887410561, 42380.57619423828, 42789.57210427856, 37864.62135378666, 38161.809190954424, 38411.42382864204, 38621.42067868984, 38961.80519097443, 6678.131842860397, 6682.966585167043, 6690.966545167243, 6755.392014718699, 6775.966120169368, 28201.57697634496, 28559.42881142324, 29325.706742932296, 29341.706582933897, 29391.85304073466, 33852.0, 34280.657193427745, 36951.445728313556, 37151.6284837159, 37398.0, 8613.26787223093, 8738.868916966123, 8816.735497935073, 8894.955525222591, 8908.064653211319, 9542.666006689733, 9874.358166719141, 10219.693409197736, 10275.280730348804, 11210.878912108725, 9430.434173949585, 9577.138057574852, 9669.178119859891, 9742.0, 10101.797964040825, 9688.660896868576, 9719.56261968199, 9799.510024498604, 9893.109620134222, 9919.15687166599, 9899.901000989898, 9929.205663546754, 9935.950320248641, 10000.449975251431, 10576.0, 8250.298724608476, 8341.874871876806, 8365.205305495969, 8399.328053755808, 8758.868616970878, 8301.128381520095, 8608.698695545625, 9031.227378248224, 9032.593533291149, 9123.589438475417], "unit": "score", "name": "yui.html", "value": 5449.659454434828}], "name": "dromaeo_css", "value": 5946.891323123927}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 117.0, 118.0, 116.0, 128.0, 115.0, 117.0, 116.0, 120.0], "unit": "score", "name": "ai-astar", "value": 117.5}, {"lowerIsBetter": true, "replicates": [162.0, 137.0, 160.0, 169.0, 136.0, 161.0, 159.0, 140.0, 171.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 165.0, 164.0, 167.0, 167.0, 173.0, 166.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 166.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 78.0, 74.0, 77.0, 132.0, 74.0, 75.0, 76.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 96.0, 97.0, 97.0, 139.0, 98.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 72.0, 72.0, 71.0, 71.0, 73.0, 78.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 83.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [120.0, 130.0, 136.0, 122.0, 128.0, 130.0, 124.0, 129.0, 124.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [138.0, 154.0, 154.0, 151.0, 151.0, 150.0, 147.0, 156.0, 149.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 73.0, 72.0, 73.0, 70.0, 71.0, 72.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1553.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "DeltaBlue", "value": 354.98754199999996}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1088.0434782608695], "unit": "score", "name": "RayTrace", "value": 680.1097702297704}, {"lowerIsBetter": false, "replicates": [706.7137809187279], "unit": "score", "name": "Earley", "value": 943.0451449999999}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [43042.55319148936], "unit": "score", "name": "RegExp", "value": 21.16475284231339}, {"lowerIsBetter": false, "replicates": [604.2042042042042], "unit": "score", "name": "Splay", "value": 134.8732753479125}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20298.595856018874}]} 08:40:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20298.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1553.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5946.89"}}} 08:40:01 INFO - Return code: 0 08:40:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:40:02 INFO - # TBPL SUCCESS # 08:40:02 INFO - Running post-action listener: _resource_record_post_action 08:40:02 INFO - Running post-run listener: _resource_record_post_run 08:40:03 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 544083968; Read time: 0; Write time: 490668 08:40:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230064128; Read time: 0; Write time: 268896 08:40:03 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 309796864; Read time: 0; Write time: 220968 08:40:03 INFO - Running post-run listener: _upload_blobber_files 08:40:03 INFO - Blob upload gear active. 08:40:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:03 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 08:40:03 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'] 08:40:03 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 08:40:03 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:40:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:04 INFO - (blobuploader) - INFO - Done attempting. 08:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:40:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:05 INFO - (blobuploader) - INFO - Done attempting. 08:40:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:05 INFO - Return code: 0 08:40:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0d9e38c964b75cd1a7866c172b7d286cbebb4b410bcf450cc4b98c7024d3e30ed903168cc0f9dc540af00e4e0a0bc0765e2617ce8885c9a86c8162728cb9da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e16ce634dad425a33b86d45df1f159aa3c2b6bec9fc6961d97f33642649b5260ab9b84764b79c5fa66c781c2d2786858abd10cba00ddc2367d63280e0dc86521"} 08:40:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:05 INFO - Contents: 08:40:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0d9e38c964b75cd1a7866c172b7d286cbebb4b410bcf450cc4b98c7024d3e30ed903168cc0f9dc540af00e4e0a0bc0765e2617ce8885c9a86c8162728cb9da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e16ce634dad425a33b86d45df1f159aa3c2b6bec9fc6961d97f33642649b5260ab9b84764b79c5fa66c781c2d2786858abd10cba00ddc2367d63280e0dc86521"} 08:40:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:05 INFO - Copying logs to upload dir... 08:40:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.087379 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-20 08:40:05.240211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 08:40:05.244080) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 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/c0d9e38c964b75cd1a7866c172b7d286cbebb4b410bcf450cc4b98c7024d3e30ed903168cc0f9dc540af00e4e0a0bc0765e2617ce8885c9a86c8162728cb9da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e16ce634dad425a33b86d45df1f159aa3c2b6bec9fc6961d97f33642649b5260ab9b84764b79c5fa66c781c2d2786858abd10cba00ddc2367d63280e0dc86521"} build_url:https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/NVNRHtJ3RAmfC5GedTdvpg/artifacts/public/build/firefox-46.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/c0d9e38c964b75cd1a7866c172b7d286cbebb4b410bcf450cc4b98c7024d3e30ed903168cc0f9dc540af00e4e0a0bc0765e2617ce8885c9a86c8162728cb9da4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e16ce634dad425a33b86d45df1f159aa3c2b6bec9fc6961d97f33642649b5260ab9b84764b79c5fa66c781c2d2786858abd10cba00ddc2367d63280e0dc86521"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 08:40:05.268957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:40:05.269283) ========= 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=4ac8d263c7293b36a1be1aed000001be-1453306729.508544-447404251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 08:40:05.351757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 08:40:05.352065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 08:40:05.352368) ========= ========= Total master_lag: 0.29 =========