builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1451308164.63 results: success (0) buildid: 20151228041348 builduid: c28b3731877e4ad3abf2d136f6bede2c revision: 7c83da46ea740bc14028aca9f9a662f062de5586 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.631924) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.632417) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.632775) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006488 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.660830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.661181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.716117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.716497) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004755 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.782141) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.782504) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.782938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.783325) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 05:09:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2015-12-28 05:09:24 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092608 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.903225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.903545) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019229 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.961957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:24.962318) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7c83da46ea740bc14028aca9f9a662f062de5586 --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 7c83da46ea740bc14028aca9f9a662f062de5586 --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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 05:09:25,130 truncating revision to first 12 chars 2015-12-28 05:09:25,130 Setting DEBUG logging. 2015-12-28 05:09:25,130 attempt 1/10 2015-12-28 05:09:25,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7c83da46ea74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 05:09:25,468 unpacking tar archive at: fx-team-7c83da46ea74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:25.606631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:25.606938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:25.616046) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:25.616374) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 05:09:25.616770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-28 05:09:25.617116) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:25 INFO - MultiFileLogger online at 20151228 05:09:25 in /builds/slave/test 05:09:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:09:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:25 INFO - {'append_to_log': False, 05:09:25 INFO - 'base_work_dir': '/builds/slave/test', 05:09:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:09:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:25 INFO - 'branch': 'Fx-Team-Non-PGO', 05:09:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:25 INFO - 'config_files': ('talos/linux_config.py',), 05:09:25 INFO - 'default_actions': ('clobber', 05:09:25 INFO - 'read-buildbot-config', 05:09:25 INFO - 'download-and-extract', 05:09:25 INFO - 'populate-webroot', 05:09:25 INFO - 'create-virtualenv', 05:09:25 INFO - 'install', 05:09:25 INFO - 'run-tests'), 05:09:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:25 INFO - 'download_minidump_stackwalk': True, 05:09:25 INFO - 'download_symbols': 'ondemand', 05:09:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:25 INFO - 'installer_path': 'installer.exe', 05:09:25 INFO - 'log_level': 'info', 05:09:25 INFO - 'log_name': 'talos', 05:09:25 INFO - 'log_to_console': True, 05:09:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:25 INFO - 'opt_config_files': (), 05:09:25 INFO - 'pip_index': False, 05:09:25 INFO - 'sps_profile': False, 05:09:25 INFO - 'sps_profile_interval': 0, 05:09:25 INFO - 'suite': 'dromaeojs', 05:09:25 INFO - 'system_bits': '64', 05:09:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:25 INFO - 'title': 'talos-linux64-ix-033', 05:09:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:25 INFO - 'use_talos_json': True, 05:09:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:25 INFO - 'work_dir': 'build'} 05:09:25 INFO - ##### 05:09:25 INFO - ##### Running clobber step. 05:09:25 INFO - ##### 05:09:25 INFO - Running pre-action listener: _resource_record_pre_action 05:09:25 INFO - Running main action method: clobber 05:09:25 INFO - rmtree: /builds/slave/test/build 05:09:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:26 INFO - Running post-action listener: _resource_record_post_action 05:09:26 INFO - ##### 05:09:26 INFO - ##### Running read-buildbot-config step. 05:09:26 INFO - ##### 05:09:26 INFO - Running pre-action listener: _resource_record_pre_action 05:09:26 INFO - Running main action method: read_buildbot_config 05:09:26 INFO - Using buildbot properties: 05:09:26 INFO - { 05:09:26 INFO - "project": "", 05:09:26 INFO - "product": "firefox", 05:09:26 INFO - "script_repo_revision": "production", 05:09:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:09:26 INFO - "repository": "", 05:09:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:09:26 INFO - "buildid": "20151228041348", 05:09:26 INFO - "pgo_build": "False", 05:09:26 INFO - "basedir": "/builds/slave/test", 05:09:26 INFO - "buildnumber": 2259, 05:09:26 INFO - "slavename": "talos-linux64-ix-033", 05:09:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:09:26 INFO - "platform": "ubuntu64_hw", 05:09:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:09:26 INFO - "branch": "fx-team", 05:09:26 INFO - "repo_path": "integration/fx-team", 05:09:26 INFO - "revision": "7c83da46ea740bc14028aca9f9a662f062de5586", 05:09:26 INFO - "stage_platform": "linux64", 05:09:26 INFO - "builduid": "c28b3731877e4ad3abf2d136f6bede2c", 05:09:26 INFO - "slavebuilddir": "test" 05:09:26 INFO - } 05:09:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:09:26 INFO - Running post-action listener: _resource_record_post_action 05:09:26 INFO - ##### 05:09:26 INFO - ##### Running download-and-extract step. 05:09:26 INFO - ##### 05:09:26 INFO - Running pre-action listener: _resource_record_pre_action 05:09:26 INFO - Running main action method: download_and_extract 05:09:26 INFO - mkdir: /builds/slave/test/build/tests 05:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:26 INFO - https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/test_packages.json 05:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/test_packages.json 05:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:09:27 INFO - Downloaded 1302 bytes. 05:09:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:09:27 INFO - Using the following test package requirements: 05:09:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'jsshell-linux-x86_64.zip'], 05:09:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09:27 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')]} 05:09:27 INFO - https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:28 INFO - Downloaded 21942261 bytes. 05:09:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:09:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:09:30 INFO - Return code: 0 05:09:30 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 05:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:30 INFO - https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:33 INFO - Downloaded 21942261 bytes. 05:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:09:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:09:34 INFO - Return code: 0 05:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:34 INFO - https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:36 INFO - Downloaded 11132270 bytes. 05:09:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:09:36 INFO - Return code: 0 05:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:36 INFO - https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/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 05:09:40 INFO - Downloaded 53336472 bytes. 05:09:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:40 INFO - mkdir: /builds/slave/test/properties 05:09:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:40 INFO - Contents: 05:09:40 INFO - build_url:https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - Running post-action listener: set_extra_try_arguments 05:09:40 INFO - ##### 05:09:40 INFO - ##### Running populate-webroot step. 05:09:40 INFO - ##### 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: populate_webroot 05:09:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:40 INFO - '--tppagecycles', 05:09:40 INFO - '7'], 05:09:40 INFO - 'tests': ['tsvgm']}}, 05:09:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:09:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['damp', 'tps']}, 05:09:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['damp', 'tps']}, 05:09:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:09:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:40 INFO - 'other': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other_l64': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'other_nol64': {'tests': ['a11yr', 05:09:40 INFO - 'ts_paint', 05:09:40 INFO - 'tpaint', 05:09:40 INFO - 'sessionrestore', 05:09:40 INFO - 'sessionrestore_no_auto_restore']}, 05:09:40 INFO - 'svgr': {'tests': ['tsvgx', 05:09:40 INFO - 'tsvgr_opacity', 05:09:40 INFO - 'tart', 05:09:40 INFO - 'tscrollx', 05:09:40 INFO - 'cart']}, 05:09:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tsvgx', 05:09:40 INFO - 'tsvgr_opacity', 05:09:40 INFO - 'tart', 05:09:40 INFO - 'tscrollx', 05:09:40 INFO - 'cart']}, 05:09:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'tests': ['tp5o']}, 05:09:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s'], 05:09:40 INFO - 'tests': ['tp5o']}, 05:09:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--xperf_path', 05:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:40 INFO - 'tests': ['tp5n']}, 05:09:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:40 INFO - 'talos_options': ['--e10s', 05:09:40 INFO - '--xperf_path', 05:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:40 INFO - 'tests': ['tp5n']}}, 05:09:40 INFO - 'talos.zip': {'path': '', 05:09:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - ##### 05:09:40 INFO - ##### Running create-virtualenv step. 05:09:40 INFO - ##### 05:09:40 INFO - Running pre-action listener: _resource_record_pre_action 05:09:40 INFO - Running main action method: create_virtualenv 05:09:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:40 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 05:09:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:40 INFO - Using real prefix '/usr' 05:09:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:43 INFO - Installing pip.................done. 05:09:43 INFO - Return code: 0 05:09:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:43 INFO - Using env: {'DISPLAY': ':0', 05:09:43 INFO - 'HOME': '/home/cltbld', 05:09:43 INFO - 'LANG': 'en_US.UTF-8', 05:09:43 INFO - 'LANGUAGE': 'en_US:en', 05:09:43 INFO - 'LOGNAME': 'cltbld', 05:09:43 INFO - 'MAIL': '/var/mail/cltbld', 05:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:43 INFO - 'MOZ_NO_REMOTE': '1', 05:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:43 INFO - 'NO_EM_RESTART': '1', 05:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:43 INFO - 'PWD': '/builds/slave/test', 05:09:43 INFO - 'SHELL': '/bin/bash', 05:09:43 INFO - 'SHLVL': '1', 05:09:43 INFO - 'TERM': 'linux', 05:09:43 INFO - 'TMOUT': '86400', 05:09:43 INFO - 'USER': 'cltbld', 05:09:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:43 INFO - '_': '/tools/buildbot/bin/python'} 05:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:43 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 05:09:43 INFO - Cleaning up... 05:09:43 INFO - Return code: 0 05:09:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:43 INFO - Using env: {'DISPLAY': ':0', 05:09:43 INFO - 'HOME': '/home/cltbld', 05:09:43 INFO - 'LANG': 'en_US.UTF-8', 05:09:43 INFO - 'LANGUAGE': 'en_US:en', 05:09:43 INFO - 'LOGNAME': 'cltbld', 05:09:43 INFO - 'MAIL': '/var/mail/cltbld', 05:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:43 INFO - 'MOZ_NO_REMOTE': '1', 05:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:43 INFO - 'NO_EM_RESTART': '1', 05:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:43 INFO - 'PWD': '/builds/slave/test', 05:09:43 INFO - 'SHELL': '/bin/bash', 05:09:43 INFO - 'SHLVL': '1', 05:09:43 INFO - 'TERM': 'linux', 05:09:43 INFO - 'TMOUT': '86400', 05:09:43 INFO - 'USER': 'cltbld', 05:09:43 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:43 INFO - '_': '/tools/buildbot/bin/python'} 05:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:43 INFO - Downloading/unpacking psutil>=0.7.1 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:45 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:09:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:45 INFO - Installing collected packages: psutil 05:09:45 INFO - Running setup.py install for psutil 05:09:45 INFO - building 'psutil._psutil_linux' extension 05:09:45 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 05:09:45 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 05:09:45 INFO - building 'psutil._psutil_posix' extension 05:09:45 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 05:09:45 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 05:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:45 INFO - Successfully installed psutil 05:09:45 INFO - Cleaning up... 05:09:46 INFO - Return code: 0 05:09:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:46 INFO - Using env: {'DISPLAY': ':0', 05:09:46 INFO - 'HOME': '/home/cltbld', 05:09:46 INFO - 'LANG': 'en_US.UTF-8', 05:09:46 INFO - 'LANGUAGE': 'en_US:en', 05:09:46 INFO - 'LOGNAME': 'cltbld', 05:09:46 INFO - 'MAIL': '/var/mail/cltbld', 05:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:46 INFO - 'MOZ_NO_REMOTE': '1', 05:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:46 INFO - 'NO_EM_RESTART': '1', 05:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:46 INFO - 'PWD': '/builds/slave/test', 05:09:46 INFO - 'SHELL': '/bin/bash', 05:09:46 INFO - 'SHLVL': '1', 05:09:46 INFO - 'TERM': 'linux', 05:09:46 INFO - 'TMOUT': '86400', 05:09:46 INFO - 'USER': 'cltbld', 05:09:46 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:46 INFO - '_': '/tools/buildbot/bin/python'} 05:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:47 INFO - Installing collected packages: mozsystemmonitor 05:09:47 INFO - Running setup.py install for mozsystemmonitor 05:09:48 INFO - Successfully installed mozsystemmonitor 05:09:48 INFO - Cleaning up... 05:09:48 INFO - Return code: 0 05:09:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:48 INFO - Using env: {'DISPLAY': ':0', 05:09:48 INFO - 'HOME': '/home/cltbld', 05:09:48 INFO - 'LANG': 'en_US.UTF-8', 05:09:48 INFO - 'LANGUAGE': 'en_US:en', 05:09:48 INFO - 'LOGNAME': 'cltbld', 05:09:48 INFO - 'MAIL': '/var/mail/cltbld', 05:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:48 INFO - 'MOZ_NO_REMOTE': '1', 05:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:48 INFO - 'NO_EM_RESTART': '1', 05:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:48 INFO - 'PWD': '/builds/slave/test', 05:09:48 INFO - 'SHELL': '/bin/bash', 05:09:48 INFO - 'SHLVL': '1', 05:09:48 INFO - 'TERM': 'linux', 05:09:48 INFO - 'TMOUT': '86400', 05:09:48 INFO - 'USER': 'cltbld', 05:09:48 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:48 INFO - '_': '/tools/buildbot/bin/python'} 05:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - Downloading docopt-0.6.1.tar.gz 05:09:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:50 INFO - Running setup.py install for blobuploader 05:09:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:50 INFO - Running setup.py install for requests 05:09:51 INFO - Running setup.py install for docopt 05:09:51 INFO - Successfully installed blobuploader requests docopt 05:09:51 INFO - Cleaning up... 05:09:51 INFO - Return code: 0 05:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 05:09:51 INFO - Using env: {'DISPLAY': ':0', 05:09:51 INFO - 'HOME': '/home/cltbld', 05:09:51 INFO - 'LANG': 'en_US.UTF-8', 05:09:51 INFO - 'LANGUAGE': 'en_US:en', 05:09:51 INFO - 'LOGNAME': 'cltbld', 05:09:51 INFO - 'MAIL': '/var/mail/cltbld', 05:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:51 INFO - 'MOZ_NO_REMOTE': '1', 05:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:51 INFO - 'NO_EM_RESTART': '1', 05:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:51 INFO - 'PWD': '/builds/slave/test', 05:09:51 INFO - 'SHELL': '/bin/bash', 05:09:51 INFO - 'SHLVL': '1', 05:09:51 INFO - 'TERM': 'linux', 05:09:51 INFO - 'TMOUT': '86400', 05:09:51 INFO - 'USER': 'cltbld', 05:09:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:51 INFO - '_': '/tools/buildbot/bin/python'} 05:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:51 INFO - Running setup.py (path:/tmp/pip-XNkbVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:51 INFO - Running setup.py (path:/tmp/pip-H1DbZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:51 INFO - Running setup.py (path:/tmp/pip-q234FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:51 INFO - Running setup.py (path:/tmp/pip-XAmVY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:51 INFO - Running setup.py (path:/tmp/pip-7i7_O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:51 INFO - Running setup.py (path:/tmp/pip-ZMZVnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:51 INFO - Running setup.py (path:/tmp/pip-jHcYXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:52 INFO - Running setup.py (path:/tmp/pip-jGS0ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:52 INFO - Running setup.py (path:/tmp/pip-hjwlvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:52 INFO - Running setup.py (path:/tmp/pip-3oID22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:52 INFO - Running setup.py (path:/tmp/pip-E8IfXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:52 INFO - Running setup.py (path:/tmp/pip-95xSx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:52 INFO - Running setup.py (path:/tmp/pip-RaH4S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:52 INFO - Running setup.py (path:/tmp/pip-WwhEgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:52 INFO - Running setup.py (path:/tmp/pip-IWyeFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:52 INFO - Running setup.py (path:/tmp/pip-3kZ7ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:52 INFO - Running setup.py (path:/tmp/pip-NDtxSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:52 INFO - Running setup.py install for manifestparser 05:09:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:52 INFO - Running setup.py install for mozcrash 05:09:52 INFO - Running setup.py install for mozdebug 05:09:53 INFO - Running setup.py install for mozdevice 05:09:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozfile 05:09:53 INFO - Running setup.py install for mozhttpd 05:09:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozinfo 05:09:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozInstall 05:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozleak 05:09:53 INFO - Running setup.py install for mozlog 05:09:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for moznetwork 05:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:53 INFO - Running setup.py install for mozprocess 05:09:53 INFO - Running setup.py install for mozprofile 05:09:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Running setup.py install for mozrunner 05:09:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Running setup.py install for mozscreenshot 05:09:54 INFO - Running setup.py install for moztest 05:09:54 INFO - Running setup.py install for mozversion 05:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:54 INFO - Cleaning up... 05:09:54 INFO - Return code: 0 05:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:54 INFO - Using env: {'DISPLAY': ':0', 05:09:54 INFO - 'HOME': '/home/cltbld', 05:09:54 INFO - 'LANG': 'en_US.UTF-8', 05:09:54 INFO - 'LANGUAGE': 'en_US:en', 05:09:54 INFO - 'LOGNAME': 'cltbld', 05:09:54 INFO - 'MAIL': '/var/mail/cltbld', 05:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:54 INFO - 'MOZ_NO_REMOTE': '1', 05:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:54 INFO - 'NO_EM_RESTART': '1', 05:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:54 INFO - 'PWD': '/builds/slave/test', 05:09:54 INFO - 'SHELL': '/bin/bash', 05:09:54 INFO - 'SHLVL': '1', 05:09:54 INFO - 'TERM': 'linux', 05:09:54 INFO - 'TMOUT': '86400', 05:09:54 INFO - 'USER': 'cltbld', 05:09:54 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:54 INFO - '_': '/tools/buildbot/bin/python'} 05:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:54 INFO - Running setup.py (path:/tmp/pip-OGTaLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:54 INFO - Running setup.py (path:/tmp/pip-qFXBhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:54 INFO - Running setup.py (path:/tmp/pip-863mTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:54 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)) 05:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:54 INFO - Running setup.py (path:/tmp/pip-RHvQqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:55 INFO - Running setup.py (path:/tmp/pip-tNMfnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:55 INFO - Running setup.py (path:/tmp/pip-Zzd2JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:55 INFO - Running setup.py (path:/tmp/pip-TrjswY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:55 INFO - Running setup.py (path:/tmp/pip-S_VztP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:55 INFO - Running setup.py (path:/tmp/pip-TjZqwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:55 INFO - Running setup.py (path:/tmp/pip-VCFCfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:55 INFO - Running setup.py (path:/tmp/pip-cG2OrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:55 INFO - Running setup.py (path:/tmp/pip-OFOtA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:55 INFO - Running setup.py (path:/tmp/pip-Ps_GrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:55 INFO - Running setup.py (path:/tmp/pip-DsR_D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:55 INFO - Running setup.py (path:/tmp/pip-hz2kUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:55 INFO - Running setup.py (path:/tmp/pip-cGSAw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:55 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)) 05:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:55 INFO - Running setup.py (path:/tmp/pip-r0lCKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 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)) 05:09:55 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:55 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:57 INFO - Downloading blessings-1.5.1.tar.gz 05:09:57 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:57 INFO - Installing collected packages: blessings 05:09:57 INFO - Running setup.py install for blessings 05:09:57 INFO - Successfully installed blessings 05:09:57 INFO - Cleaning up... 05:09:57 INFO - Return code: 0 05:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:58 INFO - Reading from file tmpfile_stdout 05:09:58 INFO - Current package versions: 05:09:58 INFO - argparse == 1.2.1 05:09:58 INFO - blessings == 1.5.1 05:09:58 INFO - blobuploader == 1.2.4 05:09:58 INFO - docopt == 0.6.1 05:09:58 INFO - manifestparser == 1.1 05:09:58 INFO - mozInstall == 1.12 05:09:58 INFO - mozcrash == 0.16 05:09:58 INFO - mozdebug == 0.1 05:09:58 INFO - mozdevice == 0.47 05:09:58 INFO - mozfile == 1.2 05:09:58 INFO - mozhttpd == 0.7 05:09:58 INFO - mozinfo == 0.9 05:09:58 INFO - mozleak == 0.1 05:09:58 INFO - mozlog == 3.1 05:09:58 INFO - moznetwork == 0.27 05:09:58 INFO - mozprocess == 0.22 05:09:58 INFO - mozprofile == 0.28 05:09:58 INFO - mozrunner == 6.11 05:09:58 INFO - mozscreenshot == 0.1 05:09:58 INFO - mozsystemmonitor == 0.0 05:09:58 INFO - moztest == 0.7 05:09:58 INFO - mozversion == 1.4 05:09:58 INFO - psutil == 3.1.1 05:09:58 INFO - requests == 1.2.3 05:09:58 INFO - wsgiref == 0.1.2 05:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:58 INFO - Using env: {'DISPLAY': ':0', 05:09:58 INFO - 'HOME': '/home/cltbld', 05:09:58 INFO - 'LANG': 'en_US.UTF-8', 05:09:58 INFO - 'LANGUAGE': 'en_US:en', 05:09:58 INFO - 'LOGNAME': 'cltbld', 05:09:58 INFO - 'MAIL': '/var/mail/cltbld', 05:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:58 INFO - 'MOZ_NO_REMOTE': '1', 05:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:58 INFO - 'NO_EM_RESTART': '1', 05:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:58 INFO - 'PWD': '/builds/slave/test', 05:09:58 INFO - 'SHELL': '/bin/bash', 05:09:58 INFO - 'SHLVL': '1', 05:09:58 INFO - 'TERM': 'linux', 05:09:58 INFO - 'TMOUT': '86400', 05:09:58 INFO - 'USER': 'cltbld', 05:09:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:58 INFO - '_': '/tools/buildbot/bin/python'} 05:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 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)) 05:09:58 INFO - Cleaning up... 05:09:58 INFO - Return code: 0 05:09:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:09:58 INFO - Using env: {'DISPLAY': ':0', 05:09:58 INFO - 'HOME': '/home/cltbld', 05:09:58 INFO - 'LANG': 'en_US.UTF-8', 05:09:58 INFO - 'LANGUAGE': 'en_US:en', 05:09:58 INFO - 'LOGNAME': 'cltbld', 05:09:58 INFO - 'MAIL': '/var/mail/cltbld', 05:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:58 INFO - 'MOZ_NO_REMOTE': '1', 05:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:58 INFO - 'NO_EM_RESTART': '1', 05:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:58 INFO - 'PWD': '/builds/slave/test', 05:09:58 INFO - 'SHELL': '/bin/bash', 05:09:58 INFO - 'SHLVL': '1', 05:09:58 INFO - 'TERM': 'linux', 05:09:58 INFO - 'TMOUT': '86400', 05:09:58 INFO - 'USER': 'cltbld', 05:09:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:58 INFO - '_': '/tools/buildbot/bin/python'} 05:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:58 INFO - Downloading/unpacking jsonschema 05:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:10:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:00 INFO - warning: no files found matching '*.txt' 05:10:00 INFO - no previously-included directories found matching 'build' 05:10:00 INFO - no previously-included directories found matching 'dist' 05:10:00 INFO - no previously-included directories found matching '.git*' 05:10:00 INFO - Installing collected packages: jsonschema, functools32 05:10:00 INFO - Running setup.py install for functools32 05:10:00 INFO - warning: no files found matching '*.txt' 05:10:00 INFO - no previously-included directories found matching 'build' 05:10:00 INFO - no previously-included directories found matching 'dist' 05:10:00 INFO - no previously-included directories found matching '.git*' 05:10:00 INFO - Successfully installed jsonschema functools32 05:10:00 INFO - Cleaning up... 05:10:00 INFO - Return code: 0 05:10:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f703ce46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2305dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, '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': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', '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 05:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 05:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 05:10:00 INFO - Using env: {'DISPLAY': ':0', 05:10:00 INFO - 'HOME': '/home/cltbld', 05:10:00 INFO - 'LANG': 'en_US.UTF-8', 05:10:00 INFO - 'LANGUAGE': 'en_US:en', 05:10:00 INFO - 'LOGNAME': 'cltbld', 05:10:00 INFO - 'MAIL': '/var/mail/cltbld', 05:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:00 INFO - 'MOZ_NO_REMOTE': '1', 05:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:00 INFO - 'NO_EM_RESTART': '1', 05:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:00 INFO - 'PWD': '/builds/slave/test', 05:10:00 INFO - 'SHELL': '/bin/bash', 05:10:00 INFO - 'SHLVL': '1', 05:10:00 INFO - 'TERM': 'linux', 05:10:00 INFO - 'TMOUT': '86400', 05:10:00 INFO - 'USER': 'cltbld', 05:10:00 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:00 INFO - '_': '/tools/buildbot/bin/python'} 05:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:00 INFO - Downloading/unpacking flake8 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:00 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 05:10:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:10:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:10:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:10:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:02 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 05:10:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:03 INFO - no previously-included directories found matching 'docs/_build' 05:10:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:03 INFO - Running setup.py install for pep8 05:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:03 INFO - no previously-included directories found matching 'docs/_build' 05:10:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:10:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:03 INFO - Cleaning up... 05:10:03 INFO - Return code: 0 05:10:03 INFO - Running post-action listener: _resource_record_post_action 05:10:03 INFO - Running post-action listener: _start_resource_monitoring 05:10:03 INFO - Starting resource monitoring. 05:10:03 INFO - ##### 05:10:03 INFO - ##### Running install step. 05:10:03 INFO - ##### 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: install 05:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:03 INFO - Reading from file tmpfile_stdout 05:10:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:03 INFO - Reading from file tmpfile_stdout 05:10:03 INFO - Output received: 05:10:03 INFO - Usage: mozinstall [options] installer 05:10:03 INFO - Options: 05:10:03 INFO - -h, --help show this help message and exit 05:10:03 INFO - -d DEST, --destination=DEST 05:10:03 INFO - Directory to install application into. [default: 05:10:03 INFO - "/builds/slave/test"] 05:10:03 INFO - --app=APP Application being installed. [default: firefox] 05:10:03 INFO - mkdir: /builds/slave/test/build/application 05:10:03 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'] 05:10:03 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 05:10:19 INFO - Reading from file tmpfile_stdout 05:10:19 INFO - Output received: 05:10:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:19 INFO - Running post-action listener: _resource_record_post_action 05:10:19 INFO - ##### 05:10:19 INFO - ##### Running run-tests step. 05:10:19 INFO - ##### 05:10:19 INFO - Running pre-action listener: _resource_record_pre_action 05:10:19 INFO - Running main action method: run_tests 05:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:19 INFO - Python 2.7.3 05:10:19 INFO - Return code: 0 05:10:19 INFO - grabbing minidump binary from tooltool 05:10: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')]} 05:10:19 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 0x23983d0>, '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 0x2303ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2304360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:19 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 05:10:19 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 05:10:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:19 INFO - Return code: 0 05:10:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:10:20 INFO - Return code: 0 05:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:10:20 INFO - Using env: {'DISPLAY': ':0', 05:10:20 INFO - 'HOME': '/home/cltbld', 05:10:20 INFO - 'LANG': 'en_US.UTF-8', 05:10:20 INFO - 'LANGUAGE': 'en_US:en', 05:10:20 INFO - 'LOGNAME': 'cltbld', 05:10:20 INFO - 'MAIL': '/var/mail/cltbld', 05:10:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:20 INFO - 'MOZ_NO_REMOTE': '1', 05:10:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:20 INFO - 'NO_EM_RESTART': '1', 05:10:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:20 INFO - 'PWD': '/builds/slave/test', 05:10:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:20 INFO - 'SHELL': '/bin/bash', 05:10:20 INFO - 'SHLVL': '1', 05:10:20 INFO - 'TERM': 'linux', 05:10:20 INFO - 'TMOUT': '86400', 05:10:20 INFO - 'USER': 'cltbld', 05:10:20 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352', 05:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:20 INFO - '_': '/tools/buildbot/bin/python'} 05:10:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:10:20 INFO - mozversion application_buildid: 20151228041348 05:10:20 INFO - mozversion application_changeset: 7c83da46ea740bc14028aca9f9a662f062de5586 05:10:20 INFO - mozversion application_display_name: Nightly 05:10:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:20 INFO - mozversion application_name: Firefox 05:10:20 INFO - mozversion application_remotingname: firefox 05:10:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:20 INFO - mozversion application_vendor: Mozilla 05:10:20 INFO - mozversion application_version: 46.0a1 05:10:20 INFO - mozversion platform_buildid: 20151228041348 05:10:20 INFO - mozversion platform_changeset: 7c83da46ea740bc14028aca9f9a662f062de5586 05:10:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:20 INFO - mozversion platform_version: 46.0a1 05:10:20 INFO - using testdate: 1451308220 05:10:20 INFO - actual date: 1451308220 05:10:20 INFO - starting webserver on 'localhost:51265' 05:10:20 INFO - SUITE-START | Running 3 tests 05:10:20 INFO - TEST-START | dromaeo_css 05:10:20 INFO - operating with platform_type : linux_ 05:10:20 INFO - Initialising browser for dromaeo_css test... 05:10:20 INFO - TEST-INFO | started process 21981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zBRdf/profile http://localhost:51265/getInfo.html) 05:10:25 INFO - PROCESS | 21981 | __metrics Screen width/height:1600/1200 05:10:25 INFO - PROCESS | 21981 | colorDepth:24 05:10:25 INFO - PROCESS | 21981 | Browser inner width/height: 1024/697 05:10:25 INFO - PROCESS | 21981 | __metrics 05:10:25 INFO - PROCESS | 21981 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:10:25 INFO - PROCESS | 21981 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:26 INFO - TEST-INFO | 21981: exit 0 05:10:26 INFO - Browser initialized. 05:10:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:26 INFO - TEST-INFO | started process 22077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zBRdf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:38 INFO - PROCESS | 22077 | RSS: Main: 148975616 05:10:38 INFO - PROCESS | 22077 | 05:11:30 INFO - PROCESS | 22077 | 1451308290045 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] 05:13:42 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51265/tests/dromaeo/cssquery-ext.html) 05:13:43 INFO - PROCESS | 22077 | RSS: Main: 230486016 05:13:43 INFO - PROCESS | 22077 | 05:16:45 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-ext.html (next: http://localhost:51265/tests/dromaeo/cssquery-jquery.html) 05:16:46 INFO - PROCESS | 22077 | RSS: Main: 233226240 05:16:46 INFO - PROCESS | 22077 | 05:19:48 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51265/tests/dromaeo/cssquery-mootools.html) 05:19:48 INFO - PROCESS | 22077 | RSS: Main: 239726592 05:19:48 INFO - PROCESS | 22077 | 05:22:50 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51265/tests/dromaeo/cssquery-prototype.html) 05:22:51 INFO - PROCESS | 22077 | RSS: Main: 212705280 05:22:51 INFO - PROCESS | 22077 | 05:25:54 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51265/tests/dromaeo/cssquery-yui.html) 05:25:54 INFO - PROCESS | 22077 | RSS: Main: 212578304 05:25:54 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-yui.html (next: http://localhost:51265/tests/dromaeo/cssquery-dojo.html) 05:28:57 INFO - PROCESS | 22077 | RSS: Main: 225402880 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | __start_tp_report 05:28:57 INFO - PROCESS | 22077 | _x_x_mozilla_page_load 05:28:57 INFO - PROCESS | 22077 | _x_x_mozilla_page_load_details 05:28:57 INFO - PROCESS | 22077 | |i|pagename|runs| 05:28:57 INFO - PROCESS | 22077 | |0;dojo.html;2618.358502166969;2699.4736026474843;2709.1195361507503;2720.591911213318;2745.299948513128;4511.097780443908;4616.307553866917;4628.352030715694;4675.298705194218;4688.460827004896;4620.283856002325;4663.370444989934;4743.359646447729;4769.833055843046;4770.666053376256;4277.914441711164;4315.072259464215;4368.519462859091;4405.6695747818885;4438.5783350581805;4181.268278051329;4337.349397590371;4365.825366985317;4421.9336709949375;4459.041306119184;4236.089240813225;4246.193223287565;4258.74447533149;4337.197618440567;4362.541933097043;4345.174416860787;4350.521442641307;4353.586409291144;4357.3899654048455;4362.582160797753;4320.546342634009;4329.740215587043;4343.109662519176;4354.934675979863;4367.694261401703;4434.711743736647;4543.250363689987;4544.659150563688;4590.793414296365;4716.551927566876;5065.290859279704;5082.720450375228;5086.440491545927;5086.77109530072;5126.71803050832;5087.160618497944;5094.363204599425;5102.030614183331;5103.923441148386;5105.719185444799;4557.179707652621;4656.371389862359;4658.138244424792;4663.160631086369;4778.426588809296;5206.7917283309;5212.061828870839;5219.869503262449;5246.685198888079;5251.186066159751;4985.476524964826;4991.301217829507;4992.350994370709;4992.875178120504;5026.572741317029;4899.461059283476;5007.073691367109;5065.13892638245;5074.391073071181;5077.746112694351;4934.3338649282605;4992.675476094042;5084.567811736044;5100.846974590768;5122.231665250168;4986.80052797884;4988.9750551247735;4990.975045124751;4993.900121997613;4995.837632784482;4215.536291007987;4228.76741779199;4228.957710422918;4233.915321693549;4258.467691538558;3539.7168226541817;3631.364511210528;3689.317476266899;3708.054446116223;3718.442233664972;4404.8458303959205;4410.580994805488;4416.138852923713;4438.467383913887;4451.198784218872;5108.259302401206;5152.3044389007755;5154.7938082476285;5155.097857874857;5197.480251974772;4217.725847819882;4318.481782186158;4319.719218250803;4410.955890441119;4411.867643970686;4445.73325600465;4446.155230506193;4446.399736035659;4491.8203271869415;4496.460424749051;4825.059113472839;4832.806687732522;4877.268409738567;4879.756012199447;4932.580730637793;4813.109574728686;4919.139150648693;4925.335079764186;5014.6991180529285;5019.698818070928;4799.832005879777;4847.103285892122;4914.852554423373;4932.605391568594;4964.280179374043;4988.501149884983;4992.700437973734;4994.750262486788;5002.824901128443;5045.293658887832;4886.071646387317;5083.796648134034;5087.033463641897;5093.796248150181;5098.592112631055;4814.735189564468;4849.175640141255;4874.878128046827;4929.926051109308;4970.900581988412;4898.2652602109965;4902.8774280643265;4903.289023091703;4905.190643543775;4950.158473059517;4658.510856360033;4812.278158276286;4813.181759101031;4856.077345304381;4870.610351171968;4832.758362081811;4847.975760121318;4866.29438731389;4883.633727470383;4949.505049495022;4825.203841366276;4825.9034819304115;4825.9034819304115;4830.29960655696;4866.29438731389 05:28:57 INFO - PROCESS | 22077 | |1;ext.html;549.5650855615986;579.5740131003713;585.701292340906;589.5313225985343;604.8729766748979;25857.48285034298;26344.4731105378;26453.867730661368;33557;34151;37208.44187337192;37668;37786.244275114484;37820;37852.62147378526;7531.849363012737;7667.769966901002;7678.270564296411;7684.615769211545;7697.576633285167;7006.754763583275;7164;9905.801883962316;10104.292699511037;10115.797684046314;9778.608855645765;9796.265280103986;9886.653967111117;9895.950520247388;9905.900940990607;6967.338102880219;7125.2518485558785;9735.075167859042;9826.410415375029;9844.310898237127;9895;10142.645007424779;10156.187504999582;10158.187345012382;10173.237007224488;32847.83576082104;33327.83336083304;33342.16644583905;33342.66657333444;33365.33269334624;2685.368938299498;2747.6565429321336;2828.660560732725;3114.9688503114903;3356.093854659253;26454.86772566144;26720;27053.729462705516;28357.716422835714;28744.568831467546;3397.2825709380004;3445.3798316303055;3453.326601312745;3541.8052007139595;3569;216899;217100;217597;218111;218494;52762.472375275756;53161;53175;53178.46821531813;53270.73364633229;49386;50864;57873.421265786805;59089.11366329509;59181.70409147927;13236.801447978289;13370.799438008438;13391.330433478483;13397.464101436028;13429.932850335686;10128.442935638463;10135.49322533885;10171.389716617026;10179.898201018043;10192.949035254924;17491.212895419736;17614;17686.29254829818;17715.73426398605;17739.758216924693;7234.4084301453595;7366.668499917517;7405.259474052552;7450.925490745023;7453.627318634047;855.3456605696647;885.4908427653996;912.5300470257822;917.3670167584345;928.2342067794096;26267.737322626912;26291.73708262893;26415.867920660272;26489.337766555604;26653.86673066622;959.2853324273461;978.2565250409598;980.1864452504404;988.2143695761887;1049.8792638846478;13528.661783455493;13781.862181378057;13917.02580819333;13933;13967.092139010932;262764;262880;266383;266562;267033;45627;45888;45917.540824592;45942.770286148356;45971;1175.3887978251432;1199.1066655341826;1214.5141943222782;1216.7992281273669;1217.8051511758254;25145;25701.457912525308;26131.477370452863;26379.868100659372;26460;39798.403023955245;39978;40056.3991540133;40078;40113;201282;202654;203091;249259;250611;28905.710942891143;29164.27089322784;29375.706242937296;29492.705072949855;29710.96011639582;33379;33632.66367336393;33709;34500.48249276313;34556.65443345534;28774.856125719238;29296.974605888692;29354.70645293605;29926.102216933527;30205;29434.411311774074;29439.558406623488;29573.408531829675;29702.554461683525;29733;31869.20326991751;32079.35841283208;33798.49302260517;34253;34350;25792.355191119623;27168.72831271741;27227;27232.455350893266;27822.86088569544;22753.431164221027;23588.52822943566;23762.93066811963;23793.52412951766;24033.639495407933 05:28:57 INFO - PROCESS | 22077 | |2;jquery.html;308.0680940156029;333.3882325931916;334.1129301703976;336.21829247000716;336.8736723728602;11132.276402033873;15032.473863414783;15063.472778452757;15497.302621382036;15504.68990620187;9762.853557196648;10078.546465409056;10079;10083.042110999462;16097.114658693767;3468.289000754839;3566.8751593694224;4301.0752688172115;4453.643708503312;5854.560907931901;5869.55978301627;5898.410158984088;5902.911456328158;5904.498117660004;5906.88186236275;4692.178868697982;4822.324874517552;4826.469088400273;5851.8537036574;5856.795012174574;4760.690555113906;4760.761961901909;4781.760911954389;4793.9520604794025;4795.832145874895;4564.406627138484;4618.284165954283;4622.237330840408;4622.445306563234;4623.791929363187;13814.723705525934;17958.281668733234;18231.361902333356;18263.45209643713;18453.446396608124;1802.1349752118924;1835.7888842783118;1855.4804654696707;1865.7854346750025;1910.694288913781;8545;8795.07651696569;8854.513001784964;10546.367217966947;12994.610161695164;1671.6322409069985;1680.1767134104323;1685.7977042754826;1697.8471937525558;1736.9826301736948;53476;56016.43983560153;57317.71341143268;58219;58427.41572584305;8288.83422331562;8621.655133794578;9211.815763684823;9577.473238971785;9813.950930245303;12088.939555302342;12217.69455763613;12233.143679942497;12298.692532686755;12310.261384316791;6811.386975172259;6866.965665171742;6999.8600027999155;7027.543209691354;7079.185893622196;6721.092652491851;6768.56004359715;6794.252632210453;6828.658567071726;6830.897536536956;4086.570910054461;4091;4113.8971525711495;4198.328267477189;4258.787060646955;1685.7977042754949;1724.491275073831;1734.765806616116;1743.320105158989;1752.3341130370632;758.6320634492267;850.7830503221638;894.5259012723267;959.4627008875052;974.9032338619054;14520.273986300643;14824.62938426548;15004.24978751058;15157.545273641808;15673.373065077498;759.6885277036499;794.1343935110757;799.3525244551931;814.9959250203711;847.6948298612494;6858.382745552824;7965.56189409588;8450.323974082059;9139.314551408672;9185.448873067637;461162;471720;475168;480372;480777;44168.895777605176;51932.40337983086;65162.34837651563;68213.65893170502;70135.64932175408;861.4572819123912;982.4792859784326;1038.3510306058865;1054.1672079057612;1060.565168281001;13505.797413038616;13757.10578812374;13766.31168441594;13794;14077.718445630826;29097.563536547394;29342;29353.412931741674;29586.260343491584;30441.391172176875;40092.79953600213;40105.39841902432;40460.59539404568;40976.18047638971;42482;8364.87452688198;8610.182032706884;9085;9089.590968406304;9117.863232051392;10020.298579099393;10109.292349535463;13662.453501859814;15942.442014529435;16032;13633;13741.381637826122;14049.508267210598;14112.223827689575;14132.364043618267;13259.138156019828;13549.796753048515;13572.592822215349;13830.585082447542;14067.085639433404;13798.517051903134;13980.860191397956;14088.36602352917;14329.498467554002;14426.278686065865;8665.956670216608;8703.43427677199;8725.171108744658;8826.558672066243;8943.642254309754;11971.820422693492;13617.863821362056;13910.58268251954;13931.791023134458;13962.4415023402 05:28:57 INFO - PROCESS | 22077 | |3;mootools.html;1161.767646470706;1393.8397084335302;1409.4714482069223;1526.5801904476268;1745.973810392845;5835.912461313078;6772.932270677292;6863.897041544368;6872.140982377196;6884.862302753942;6880.931190688091;7061.329173728487;7068.575885446877;7072.115985501812;7089.149302083744;1671.5737486940875;1705.266735303819;2004.979950200494;2068.917243310266;2102.4743814046487;2013.3054096336814;2017.767956684978;2021.8989050547414;2022.5853699991467;2023.5649335392889;2005.1377907499768;2026.149017412683;2057.5473395852964;2058.0327246194265;2067.431456349501;1942.1842826013108;1945.9318923837598;1985.9106340214726;1988.0755448716343;1989.9900500497404;1975.338261682338;2007.6988451732357;2010.9945027486258;2013.0337438029828;2013.8590298679098;6996.650167491605;7073;7093.645317734145;7100.8934865976535;7102.39629631482;4188.057687020427;4246.129543443587;4272.166927449149;4279;4287.721298115644;2546.59254519276;2641.603759436081;2656.1633085577982;2671.011725661498;2684.7717943974785;774.446270916292;785.3952456608437;787.3032366355759;788.0936922539125;814.539785021461;9531.761705957337;9581.664641737576;9585.712428627152;9608.231341492663;9613.951930240304;3826.330392181357;3903.0437542802197;3961.3265744823448;3966;3971.4042893566198;8256.628451719687;8293.129221431784;8296.211859873303;8301.709440169565;8312.792180195422;4311.288637374798;4315.266404711207;4319.6976211665515;4327.112941846914;4330.631896288788;3849.4225866119746;3874.2832575973534;3876.612338766101;3879.922401551953;3883.941740873889;2951.631046119235;2992.5361568956846;3319.7842140260805;3321.5183798349103;3385.813780242061;1063.3672964586058;1088.2382332367374;1090.8418279349607;1099.8020356335776;1101.8347247912716;902.2421166220406;934.9766255843522;1015.5430056474615;1190.3750530971136;1206.1135065726685;6516.511261655395;6526.086347911296;6568.507361947873;6599.670016499252;6644.66776661165;984.524628062939;990.4948476277151;1012.5949620151998;1025.9230557708202;1030.3663247103127;5278.498542638443;5282.154855223146;5409.648372855751;5419.647722897999;5425.13197888336;8134.3085837703275;8391.202835730595;8397.664093436317;8462.36532260083;8473.279771219391;7971.123176450586;8254.711085111992;8257;8272.8345433091;8284.047334556482;6639.136912201383;6717.361850624183;6783.626900520519;6791.252962174157;6794.660266986631;6806.55757375769;6834.624095674786;6872.931270687229;6897;6904.516683832084;7237;7448.515846470179;7825.4130940178575;7877.487963282369;7890.68437262526;7418.777436676908;7599.506032107895;7611.2769286917655;7623.047119110111;7762.107357653942;6120.051392034242;6177;6200.100985357189;6204.410580994799;6207.565470417208;5634.85912852182;5747.224124743107;5756.107803290497;6311.589746666452;6478.287388387368;6135.8466038347615;6145.8156255312415;6291.622502649856;6302.369763023844;6386.744530218739;6234.750609975732;6260.906086408799;6309.936900630935;6338.683065846597;6362.618242905441;5959.165716799738;6018.007028840192;6052;6202.81391558254;6263.154474145932;5839.270091238595;5957.523398128226;5965.075413310944;5971.701414929323;5979.760809567742;6009.699515024318;6042.607230530001;6056.878862422815;6083.6349819011;6088.36072212429 05:28:57 INFO - PROCESS | 22077 | |4;prototype.html;298.3987265659695;301.077198386944;305.86694787767317;306.61213564840466;311.3337457840221;5400.675959442431;5408.864778380537;5417.51242388185;5439.374471935724;5475.370332411774;5357.491038351351;5359.812406565771;5363.141897296433;5368.248445217672;5371.167469042305;4172.812223449937;4175.331946888491;4176.352665336863;4178.394132850734;4180.58194180581;3959.4258832469272;4099.795010249476;4184.079502509443;4185.434966279544;4187.413762073312;4006.519217693881;4006.5392479864895;4051.3517837146064;4055.513338399396;4059.7158198926086;3986.40203969404;4060.5736397678115;4065.8576949806616;4068.7151899367054;4080.6939479538855;3554.2713743682743;3554.3957527220437;3558.62634423387;3561.857525698969;3582.337267605475;4837.32277481153;4938.08645400602;4974.90050198994;5108.978204359143;5116.258142569344;4721.811127554894;4749.881252968669;4776.4268287805335;4780.139574876521;4780.259059845729;5323.547498462635;5665.603407761459;5672.149177623348;5677.858053548694;5678.4037676044245;3823.0824602095577;3836.5971572984713;3893.240818040483;3893.785841778701;3933.095388060762;5908.320543137508;5933.436323549256;5934.080217566284;5938.287405511323;5947.04847224442;4038.4749982502085;4042.514898212233;4043.211573743151;4050.635442810102;4052.8986775330854;4036.6165214305183;4109.650679692199;4114.7119701620595;4117.773522456234;4118.670506359484;4740.502247264057;4743.193657078305;4746.572808447257;4749.501302363271;4756.167670657621;5638.520725738276;5645.858853528613;5646.124850648156;5649.68926709035;5655.660660360391;1457.3951809998944;1470.5367809140087;1472.263868065967;1473.5800296915327;1474.0345073976562;992.6029588164791;999.6654466287442;1008.969730908074;1016.5019140621042;1026.5893642543042;4902.950970490249;4917;4920.606351491872;4921.3602231710365;4924.581410580069;5831.475167234969;5838.4453476919625;5841.299044114733;5847.26909136358;5851.1223316502865;4910;4918.729469879191;4921.212605983025;4921.26181072842;4927.334809800703;3082.9383412331626;3129.8122112673313;3155.100796273097;3157.7789554731407;3162.4623813951684;5591.580631452657;5597.244372009808;5608.046632072557;5608.186812912105;5620.156976453564;5935.406459354116;5940.990031694622;5969.731362088716;5969.761209551656;5989.9101513477335;5516.282883225155;5566.2207290979295;5579.218909352694;5585.748641311069;5591.580631452576;5673.74468148926;5904.143899134516;5914.083317085859;5931.495822855106;5931.851703707442;5501.944980550304;5658.745356458887;5658.801941932013;5659.547236221175;5661.2923384576925;5492.5331346835965;5578.246936663499;5623.943760562342;5687;5703.572232082527;3962.40563915415;3998.4202290668272;3999.92000160001;3999.940000900047;4000.099977505038;5718.399568045295;5886;5899.436649288028;5909.320428150818;5945.821625351246;5705.087186050212;5706.771729130955;5707.68607726579;5711.571632127524;5712.5429965601825;5702.087665973424;5702.51528620072;5709.7430615623225;5711.314642242791;5715.142728590745;5365.919511207413;5577.024020796425;5581.665100094007;5584.553235741049;5587.497125258747;5691.857703557444;5753.8561535961935;5757.798477053283;5760.740766665594;5761.308642962704;5622.184783206494;5623.409541998031;5627.268455100811;5629.549636029026;5629.54963602919 05:28:57 INFO - PROCESS | 22077 | |5;yui.html;639.4372951802413;683.3405763438282;717.8564287142572;757.8446418484205;789.9012623422076;11130.332180069192;11339.37633430161;11341.036011938995;11342.319460832356;11343.773124537503;11497.080233581315;11586.884131158686;11614.941925290383;11618.128640351986;11627.941860290686;618.5144661440759;775.1512094256808;793.1592511937336;793.3692714292123;794.086800179795;781.9921800781976;794.0669713087128;794.566961006253;794.6860989908982;794.9880751788728;807.2452257139564;811.5942028985507;813.3737022492677;813.4753084260649;814.6700586262573;810.5582457560585;811.7037281392279;811.7077851973285;811.9228673276059;813.6297984417076;602.8794241151787;603.9426254505815;604.1994357476317;604.4106995679222;605.0410099991519;11766.470508827038;11903.107266955012;11916.940415297955;11929.105317101252;11929.28424294545;11269.43652817364;11604.419779011016;11707.824382634268;11734.765304693943;11853.703657408547;8949.418287811337;8979.730608081769;9111.635534578609;9274.07259274074;9316.301277404222;3199.728023118038;3209.1816586770224;3244.772865899388;3258.283177700902;3269.869205231788;32901.83549082239;38300.80849595762;39419.40870886939;39540;43867;9304.195873627421;9512.47681377517;9814.460204688668;9815.656452024288;9890.060444257784;17063.061531615633;17072.829271707124;17080.231389587498;17097.230624621923;17102.48692539226;6180;6251.78118765841;6314.273858506331;6392.904106438407;6672.633005184762;3476.66971637694;3597.0647631615443;3599;3599.640035996432;3613.8915832525067;2707.6073969274344;2722;2729.208529526415;2730.358365784039;2736.4253506763403;480.0447110250576;481.68690351271255;487.4710938631554;488.3114808120604;491.1012846490913;448.5985043386151;450.916580432621;459.481625675638;473.51701264709806;533.8825458399145;7311.086114235721;7320.853582928418;7371.078615173104;7374.188839227681;7561.584112873845;585.5930128560609;594.6253860068216;612.4518555892452;621.5400603553338;625.8372823065945;3539.1682954505673;3562.5012498250267;3601.837917293728;3615.5661320641693;3622.7826330420257;49972.25041624378;50727.239091413656;51563;52032.73983630058;52108.47891521112;36052.27895442076;43151;43256;43486.782566086964;43664.3450348245;35606.46590301148;38027.429588556195;39848.60151398449;41427.58572414237;41739.16521669611;7726;8038.557879316693;8061.596920153852;8178.877316840133;8214.712485062993;31950.36099278048;31967.840160799045;32552.51171232481;33064.66935330616;33244.667553325125;39279;39737.20525589414;39743.60256397399;39886.60113398829;40278.39582406208;8832.29341652679;10261.179105671677;10312.742181445525;10312.845307320245;10469.790604188025;10598.788024239626;10974.286671366335;11423.543058277575;11624.941875290908;11656.941715291709;10471.3193642413;10629.25595208328;10738.677839664822;10838.945805270923;11319.264247823865;10209.285350025428;10467.16262698967;10471.738206544896;10709.892901071202;10843.566257349617;10339.172866170838;10360.326578772356;10406.739831504274;10431;10863.348199108079;9024.458532488072;9108.362414630912;9228.676996305097;9323.393979391318;9324.347295689508;8359.623816928131;8630;8673.91326086731;8704.608292626974;8738.606762695566 05:28:57 INFO - PROCESS | 22077 | __end_tp_report 05:28:57 INFO - PROCESS | 22077 | __start_cc_report 05:28:57 INFO - PROCESS | 22077 | _x_x_mozilla_cycle_collect,982 05:28:57 INFO - PROCESS | 22077 | __end_cc_report 05:28:57 INFO - PROCESS | 22077 | __startTimestamp1451309337662__endTimestamp 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | ------- Summary: start ------- 05:28:57 INFO - PROCESS | 22077 | Number of tests: 6 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#0] dojo.html Cycles:165 Average:4659.90 Median:4825.20 stddev:492.61 (10.2%) stddev-sans-first:467.36 05:28:57 INFO - PROCESS | 22077 | Values: 2618.4 2699.5 2709.1 2720.6 2745.3 4511.1 4616.3 4628.4 4675.3 4688.5 4620.3 4663.4 4743.4 4769.8 4770.7 4277.9 4315.1 4368.5 4405.7 4438.6 4181.3 4337.3 4365.8 4421.9 4459.0 4236.1 4246.2 4258.7 4337.2 4362.5 4345.2 4350.5 4353.6 4357.4 4362.6 4320.5 4329.7 4343.1 4354.9 4367.7 4434.7 4543.3 4544.7 4590.8 4716.6 5065.3 5082.7 5086.4 5086.8 5126.7 5087.2 5094.4 5102.0 5103.9 5105.7 4557.2 4656.4 4658.1 4663.2 4778.4 5206.8 5212.1 5219.9 5246.7 5251.2 4985.5 4991.3 4992.4 4992.9 5026.6 4899.5 5007.1 5065.1 5074.4 5077.7 4934.3 4992.7 5084.6 5100.8 5122.2 4986.8 4989.0 4991.0 4993.9 4995.8 4215.5 4228.8 4229.0 4233.9 4258.5 3539.7 3631.4 3689.3 3708.1 3718.4 4404.8 4410.6 4416.1 4438.5 4451.2 5108.3 5152.3 5154.8 5155.1 5197.5 4217.7 4318.5 4319.7 4411.0 4411.9 4445.7 4446.2 4446.4 4491.8 4496.5 4825.1 4832.8 4877.3 4879.8 4932.6 4813.1 4919.1 4925.3 5014.7 5019.7 4799.8 4847.1 4914.9 4932.6 4964.3 4988.5 4992.7 4994.8 5002.8 5045.3 4886.1 5083.8 5087.0 5093.8 5098.6 4814.7 4849.2 4874.9 4929.9 4970.9 4898.3 4902.9 4903.3 4905.2 4950.2 4658.5 4812.3 4813.2 4856.1 4870.6 4832.8 4848.0 4866.3 4883.6 4949.5 4825.2 4825.9 4825.9 4830.3 4866.3 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#1] ext.html Cycles:180 Average:38955.05 Median:29829.55 stddev:61440.50 (206.0%) stddev-sans-first:61545.19 05:28:57 INFO - PROCESS | 22077 | Values: 549.6 579.6 585.7 589.5 604.9 25857.5 26344.5 26453.9 33557.0 34151.0 37208.4 37668.0 37786.2 37820.0 37852.6 7531.8 7667.8 7678.3 7684.6 7697.6 7006.8 7164.0 9905.8 10104.3 10115.8 9778.6 9796.3 9886.7 9896.0 9905.9 6967.3 7125.3 9735.1 9826.4 9844.3 9895.0 10142.6 10156.2 10158.2 10173.2 32847.8 33327.8 33342.2 33342.7 33365.3 2685.4 2747.7 2828.7 3115.0 3356.1 26454.9 26720.0 27053.7 28357.7 28744.6 3397.3 3445.4 3453.3 3541.8 3569.0 216899.0 217100.0 217597.0 218111.0 218494.0 52762.5 53161.0 53175.0 53178.5 53270.7 49386.0 50864.0 57873.4 59089.1 59181.7 13236.8 13370.8 13391.3 13397.5 13429.9 10128.4 10135.5 10171.4 10179.9 10192.9 17491.2 17614.0 17686.3 17715.7 17739.8 7234.4 7366.7 7405.3 7450.9 7453.6 855.3 885.5 912.5 917.4 928.2 26267.7 26291.7 26415.9 26489.3 26653.9 959.3 978.3 980.2 988.2 1049.9 13528.7 13781.9 13917.0 13933.0 13967.1 262764.0 262880.0 266383.0 266562.0 267033.0 45627.0 45888.0 45917.5 45942.8 45971.0 1175.4 1199.1 1214.5 1216.8 1217.8 25145.0 25701.5 26131.5 26379.9 26460.0 39798.4 39978.0 40056.4 40078.0 40113.0 201282.0 202654.0 203091.0 249259.0 250611.0 28905.7 29164.3 29375.7 29492.7 29711.0 33379.0 33632.7 33709.0 34500.5 34556.7 28774.9 29297.0 29354.7 29926.1 30205.0 29434.4 29439.6 29573.4 29702.6 29733.0 31869.2 32079.4 33798.5 34253.0 34350.0 25792.4 27168.7 27227.0 27232.5 27822.9 22753.4 23588.5 23762.9 23793.5 24033.6 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#2] jquery.html Cycles:180 Average:25257.12 Median:22533.59 stddev:77293.23 (343.0%) stddev-sans-first:77487.36 05:28:57 INFO - PROCESS | 22077 | Values: 308.1 333.4 334.1 336.2 336.9 11132.3 15032.5 15063.5 15497.3 15504.7 9762.9 10078.5 10079.0 10083.0 16097.1 3468.3 3566.9 4301.1 4453.6 5854.6 5869.6 5898.4 5902.9 5904.5 5906.9 4692.2 4822.3 4826.5 5851.9 5856.8 4760.7 4760.8 4781.8 4794.0 4795.8 4564.4 4618.3 4622.2 4622.4 4623.8 13814.7 17958.3 18231.4 18263.5 18453.4 1802.1 1835.8 1855.5 1865.8 1910.7 8545.0 8795.1 8854.5 10546.4 12994.6 1671.6 1680.2 1685.8 1697.8 1737.0 53476.0 56016.4 57317.7 58219.0 58427.4 8288.8 8621.7 9211.8 9577.5 9814.0 12088.9 12217.7 12233.1 12298.7 12310.3 6811.4 6867.0 6999.9 7027.5 7079.2 6721.1 6768.6 6794.3 6828.7 6830.9 4086.6 4091.0 4113.9 4198.3 4258.8 1685.8 1724.5 1734.8 1743.3 1752.3 758.6 850.8 894.5 959.5 974.9 14520.3 14824.6 15004.2 15157.5 15673.4 759.7 794.1 799.4 815.0 847.7 6858.4 7965.6 8450.3 9139.3 9185.4 461162.0 471720.0 475168.0 480372.0 480777.0 44168.9 51932.4 65162.3 68213.7 70135.6 861.5 982.5 1038.4 1054.2 1060.6 13505.8 13757.1 13766.3 13794.0 14077.7 29097.6 29342.0 29353.4 29586.3 30441.4 40092.8 40105.4 40460.6 40976.2 42482.0 8364.9 8610.2 9085.0 9089.6 9117.9 10020.3 10109.3 13662.5 15942.4 16032.0 13633.0 13741.4 14049.5 14112.2 14132.4 13259.1 13549.8 13572.6 13830.6 14067.1 13798.5 13980.9 14088.4 14329.5 14426.3 8666.0 8703.4 8725.2 8826.6 8943.6 11971.8 13617.9 13910.6 13931.8 13962.4 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#3] mootools.html Cycles:180 Average:4899.20 Median:6070.26 stddev:2542.52 (41.9%) stddev-sans-first:2534.13 05:28:57 INFO - PROCESS | 22077 | Values: 1161.8 1393.8 1409.5 1526.6 1746.0 5835.9 6772.9 6863.9 6872.1 6884.9 6880.9 7061.3 7068.6 7072.1 7089.1 1671.6 1705.3 2005.0 2068.9 2102.5 2013.3 2017.8 2021.9 2022.6 2023.6 2005.1 2026.1 2057.5 2058.0 2067.4 1942.2 1945.9 1985.9 1988.1 1990.0 1975.3 2007.7 2011.0 2013.0 2013.9 6996.7 7073.0 7093.6 7100.9 7102.4 4188.1 4246.1 4272.2 4279.0 4287.7 2546.6 2641.6 2656.2 2671.0 2684.8 774.4 785.4 787.3 788.1 814.5 9531.8 9581.7 9585.7 9608.2 9614.0 3826.3 3903.0 3961.3 3966.0 3971.4 8256.6 8293.1 8296.2 8301.7 8312.8 4311.3 4315.3 4319.7 4327.1 4330.6 3849.4 3874.3 3876.6 3879.9 3883.9 2951.6 2992.5 3319.8 3321.5 3385.8 1063.4 1088.2 1090.8 1099.8 1101.8 902.2 935.0 1015.5 1190.4 1206.1 6516.5 6526.1 6568.5 6599.7 6644.7 984.5 990.5 1012.6 1025.9 1030.4 5278.5 5282.2 5409.6 5419.6 5425.1 8134.3 8391.2 8397.7 8462.4 8473.3 7971.1 8254.7 8257.0 8272.8 8284.0 6639.1 6717.4 6783.6 6791.3 6794.7 6806.6 6834.6 6872.9 6897.0 6904.5 7237.0 7448.5 7825.4 7877.5 7890.7 7418.8 7599.5 7611.3 7623.0 7762.1 6120.1 6177.0 6200.1 6204.4 6207.6 5634.9 5747.2 5756.1 6311.6 6478.3 6135.8 6145.8 6291.6 6302.4 6386.7 6234.8 6260.9 6309.9 6338.7 6362.6 5959.2 6018.0 6052.0 6202.8 6263.2 5839.3 5957.5 5965.1 5971.7 5979.8 6009.7 6042.6 6056.9 6083.6 6088.4 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#4] prototype.html Cycles:180 Average:4680.34 Median:5361.48 stddev:1384.39 (25.8%) stddev-sans-first:1348.64 05:28:57 INFO - PROCESS | 22077 | Values: 298.4 301.1 305.9 306.6 311.3 5400.7 5408.9 5417.5 5439.4 5475.4 5357.5 5359.8 5363.1 5368.2 5371.2 4172.8 4175.3 4176.4 4178.4 4180.6 3959.4 4099.8 4184.1 4185.4 4187.4 4006.5 4006.5 4051.4 4055.5 4059.7 3986.4 4060.6 4065.9 4068.7 4080.7 3554.3 3554.4 3558.6 3561.9 3582.3 4837.3 4938.1 4974.9 5109.0 5116.3 4721.8 4749.9 4776.4 4780.1 4780.3 5323.5 5665.6 5672.1 5677.9 5678.4 3823.1 3836.6 3893.2 3893.8 3933.1 5908.3 5933.4 5934.1 5938.3 5947.0 4038.5 4042.5 4043.2 4050.6 4052.9 4036.6 4109.7 4114.7 4117.8 4118.7 4740.5 4743.2 4746.6 4749.5 4756.2 5638.5 5645.9 5646.1 5649.7 5655.7 1457.4 1470.5 1472.3 1473.6 1474.0 992.6 999.7 1009.0 1016.5 1026.6 4903.0 4917.0 4920.6 4921.4 4924.6 5831.5 5838.4 5841.3 5847.3 5851.1 4910.0 4918.7 4921.2 4921.3 4927.3 3082.9 3129.8 3155.1 3157.8 3162.5 5591.6 5597.2 5608.0 5608.2 5620.2 5935.4 5941.0 5969.7 5969.8 5989.9 5516.3 5566.2 5579.2 5585.7 5591.6 5673.7 5904.1 5914.1 5931.5 5931.9 5501.9 5658.7 5658.8 5659.5 5661.3 5492.5 5578.2 5623.9 5687.0 5703.6 3962.4 3998.4 3999.9 3999.9 4000.1 5718.4 5886.0 5899.4 5909.3 5945.8 5705.1 5706.8 5707.7 5711.6 5712.5 5702.1 5702.5 5709.7 5711.3 5715.1 5365.9 5577.0 5581.7 5584.6 5587.5 5691.9 5753.9 5757.8 5760.7 5761.3 5622.2 5623.4 5627.3 5629.5 5629.5 05:28:57 INFO - PROCESS | 22077 | 05:28:57 INFO - PROCESS | 22077 | [#5] yui.html Cycles:180 Average:12163.47 Median:43371.39 stddev:13704.23 (31.6%) stddev-sans-first:13715.35 05:28:57 INFO - PROCESS | 22077 | Values: 639.4 683.3 717.9 757.8 789.9 11130.3 11339.4 11341.0 11342.3 11343.8 11497.1 11586.9 11614.9 11618.1 11627.9 618.5 775.2 793.2 793.4 794.1 782.0 794.1 794.6 794.7 795.0 807.2 811.6 813.4 813.5 814.7 810.6 811.7 811.7 811.9 813.6 602.9 603.9 604.2 604.4 605.0 11766.5 11903.1 11916.9 11929.1 11929.3 11269.4 11604.4 11707.8 11734.8 11853.7 8949.4 8979.7 9111.6 9274.1 9316.3 3199.7 3209.2 3244.8 3258.3 3269.9 32901.8 38300.8 39419.4 39540.0 43867.0 9304.2 9512.5 9814.5 9815.7 9890.1 17063.1 17072.8 17080.2 17097.2 17102.5 6180.0 6251.8 6314.3 6392.9 6672.6 3476.7 3597.1 3599.0 3599.6 3613.9 2707.6 2722.0 2729.2 2730.4 2736.4 480.0 481.7 487.5 488.3 491.1 448.6 450.9 459.5 473.5 533.9 7311.1 7320.9 7371.1 7374.2 7561.6 585.6 594.6 612.5 621.5 625.8 3539.2 3562.5 3601.8 3615.6 3622.8 49972.3 50727.2 51563.0 52032.7 52108.5 36052.3 43151.0 43256.0 43486.8 43664.3 35606.5 38027.4 39848.6 41427.6 41739.2 7726.0 8038.6 8061.6 8178.9 8214.7 31950.4 31967.8 32552.5 33064.7 33244.7 39279.0 39737.2 39743.6 39886.6 40278.4 8832.3 10261.2 10312.7 10312.8 10469.8 10598.8 10974.3 11423.5 11624.9 11656.9 10471.3 10629.3 10738.7 10838.9 11319.3 10209.3 10467.2 10471.7 10709.9 10843.6 10339.2 10360.3 10406.7 10431.0 10863.3 9024.5 9108.4 9228.7 9323.4 9324.3 8359.6 8630.0 8673.9 8704.6 8738.6 05:28:57 INFO - PROCESS | 22077 | -------- Summary: end -------- 05:28:57 INFO - PROCESS | 22077 | 05:28:58 INFO - TEST-INFO | 22077: exit 0 05:28:58 INFO - TEST-OK | dromaeo_css | took 1118036ms 05:28:58 INFO - TEST-START | kraken 05:28:58 INFO - operating with platform_type : linux_ 05:28:58 INFO - Initialising browser for kraken test... 05:28:58 INFO - TEST-INFO | started process 22267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5BG0uj/profile http://localhost:51265/getInfo.html) 05:29:03 INFO - PROCESS | 22267 | __metrics Screen width/height:1600/1200 05:29:03 INFO - PROCESS | 22267 | colorDepth:24 05:29:03 INFO - PROCESS | 22267 | Browser inner width/height: 1024/697 05:29:03 INFO - PROCESS | 22267 | __metrics 05:29:03 INFO - PROCESS | 22267 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:29:03 INFO - PROCESS | 22267 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:04 INFO - TEST-INFO | 22267: exit 0 05:29:04 INFO - Browser initialized. 05:29:04 INFO - Running cycle 1/1 for kraken test... 05:29:04 INFO - TEST-INFO | started process 22347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5BG0uj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:16 INFO - PROCESS | 22347 | RSS: Main: 148631552 05:29:16 INFO - PROCESS | 22347 | 05:29:19 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:19 INFO - PROCESS | 22347 | RSS: Main: 184905728 05:29:19 INFO - PROCESS | 22347 | 05:29:22 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-dft) 05:29:23 INFO - PROCESS | 22347 | RSS: Main: 175194112 05:29:23 INFO - PROCESS | 22347 | 05:29:26 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-fft) 05:29:26 INFO - PROCESS | 22347 | RSS: Main: 160460800 05:29:26 INFO - PROCESS | 22347 | 05:29:28 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-oscillator) 05:29:29 INFO - PROCESS | 22347 | RSS: Main: 162549760 05:29:29 INFO - PROCESS | 22347 | 05:29:31 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:32 INFO - PROCESS | 22347 | RSS: Main: 164765696 05:29:32 INFO - PROCESS | 22347 | 05:29:35 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:35 INFO - PROCESS | 22347 | RSS: Main: 164306944 05:29:35 INFO - PROCESS | 22347 | 05:29:39 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:39 INFO - PROCESS | 22347 | RSS: Main: 165658624 05:29:39 INFO - PROCESS | 22347 | 05:29:42 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51265/tests/kraken/driver.html?testName=json-parse-financial) 05:29:43 INFO - PROCESS | 22347 | RSS: Main: 164577280 05:29:43 INFO - PROCESS | 22347 | 05:29:44 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:45 INFO - PROCESS | 22347 | RSS: Main: 178917376 05:29:45 INFO - PROCESS | 22347 | 05:29:47 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:47 INFO - PROCESS | 22347 | RSS: Main: 175083520 05:29:47 INFO - PROCESS | 22347 | 05:29:49 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:50 INFO - PROCESS | 22347 | RSS: Main: 186093568 05:29:50 INFO - PROCESS | 22347 | 05:29:53 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:53 INFO - PROCESS | 22347 | RSS: Main: 190689280 05:29:53 INFO - PROCESS | 22347 | 05:29:56 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:56 INFO - PROCESS | 22347 | RSS: Main: 189538304 05:29:56 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51265/tests/kraken/driver.html?testName=ai-astar) 05:29:58 INFO - PROCESS | 22347 | RSS: Main: 247406592 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | __start_tp_report 05:29:58 INFO - PROCESS | 22347 | _x_x_mozilla_page_load 05:29:58 INFO - PROCESS | 22347 | _x_x_mozilla_page_load_details 05:29:58 INFO - PROCESS | 22347 | |i|pagename|runs| 05:29:58 INFO - PROCESS | 22347 | |0;ai-astar;110;115;105;112;112;114;102;112;111;104 05:29:58 INFO - PROCESS | 22347 | |1;audio-beat-detection;158;130;150;171;129;157;157;128;174;132 05:29:58 INFO - PROCESS | 22347 | |2;audio-dft;159;160;161;164;158;160;160;162;161;161 05:29:58 INFO - PROCESS | 22347 | |3;audio-fft;73;72;82;92;72;72;75;116;92;72 05:29:58 INFO - PROCESS | 22347 | |4;audio-oscillator;98;98;131;97;99;96;134;98;98;133 05:29:58 INFO - PROCESS | 22347 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;108;109;109 05:29:58 INFO - PROCESS | 22347 | |6;imaging-darkroom;147;147;146;149;147;146;148;148;148;147 05:29:58 INFO - PROCESS | 22347 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;95 05:29:58 INFO - PROCESS | 22347 | |8;json-parse-financial;71;71;71;70;70;71;70;80;68;69 05:29:58 INFO - PROCESS | 22347 | |9;json-stringify-tinderbox;68;69;67;68;68;69;68;68;68;68 05:29:58 INFO - PROCESS | 22347 | |10;stanford-crypto-aes;85;83;84;85;86;85;93;85;88;84 05:29:58 INFO - PROCESS | 22347 | |11;stanford-crypto-ccm;127;134;118;119;119;117;136;124;125;126 05:29:58 INFO - PROCESS | 22347 | |12;stanford-crypto-pbkdf2;136;146;145;151;147;142;159;149;146;149 05:29:58 INFO - PROCESS | 22347 | |13;stanford-crypto-sha256-iterative;69;71;71;70;69;67;69;71;67;68 05:29:58 INFO - PROCESS | 22347 | __end_tp_report 05:29:58 INFO - PROCESS | 22347 | __start_cc_report 05:29:58 INFO - PROCESS | 22347 | _x_x_mozilla_cycle_collect,967 05:29:58 INFO - PROCESS | 22347 | __end_cc_report 05:29:58 INFO - PROCESS | 22347 | __startTimestamp1451309398823__endTimestamp 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | ------- Summary: start ------- 05:29:58 INFO - PROCESS | 22347 | Number of tests: 14 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#0] ai-astar Cycles:10 Average:109.70 Median:112.00 stddev:4.45 (4.0%) stddev-sans-first:4.72 05:29:58 INFO - PROCESS | 22347 | Values: 110.0 115.0 105.0 112.0 112.0 114.0 102.0 112.0 111.0 104.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:157.00 stddev:17.66 (11.3%) stddev-sans-first:18.41 05:29:58 INFO - PROCESS | 22347 | Values: 158.0 130.0 150.0 171.0 129.0 157.0 157.0 128.0 174.0 132.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.65 (1.0%) stddev-sans-first:1.64 05:29:58 INFO - PROCESS | 22347 | Values: 159.0 160.0 161.0 164.0 158.0 160.0 160.0 162.0 161.0 161.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:14.47 (19.6%) stddev-sans-first:15.00 05:29:58 INFO - PROCESS | 22347 | Values: 73.0 72.0 82.0 92.0 72.0 72.0 75.0 116.0 92.0 72.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:98.00 stddev:16.92 (17.3%) stddev-sans-first:17.54 05:29:58 INFO - PROCESS | 22347 | Values: 98.0 98.0 131.0 97.0 99.0 96.0 134.0 98.0 98.0 133.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:29:58 INFO - PROCESS | 22347 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:29:58 INFO - PROCESS | 22347 | Values: 147.0 147.0 146.0 149.0 147.0 146.0 148.0 148.0 148.0 147.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:29:58 INFO - PROCESS | 22347 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:3.28 (4.6%) stddev-sans-first:3.48 05:29:58 INFO - PROCESS | 22347 | Values: 71.0 71.0 71.0 70.0 70.0 71.0 70.0 80.0 68.0 69.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 05:29:58 INFO - PROCESS | 22347 | Values: 68.0 69.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:2.86 (3.4%) stddev-sans-first:3.02 05:29:58 INFO - PROCESS | 22347 | Values: 85.0 83.0 84.0 85.0 86.0 85.0 93.0 85.0 88.0 84.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:125.50 stddev:6.59 (5.2%) stddev-sans-first:6.92 05:29:58 INFO - PROCESS | 22347 | Values: 127.0 134.0 118.0 119.0 119.0 117.0 136.0 124.0 125.0 126.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:148.00 stddev:5.96 (4.0%) stddev-sans-first:4.82 05:29:58 INFO - PROCESS | 22347 | Values: 136.0 146.0 145.0 151.0 147.0 142.0 159.0 149.0 146.0 149.0 05:29:58 INFO - PROCESS | 22347 | 05:29:58 INFO - PROCESS | 22347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.55 (2.2%) stddev-sans-first:1.64 05:29:58 INFO - PROCESS | 22347 | Values: 69.0 71.0 71.0 70.0 69.0 67.0 69.0 71.0 67.0 68.0 05:29:58 INFO - PROCESS | 22347 | -------- Summary: end -------- 05:29:58 INFO - PROCESS | 22347 | 05:29:59 INFO - TEST-INFO | 22347: exit 0 05:29:59 INFO - TEST-OK | kraken | took 61260ms 05:29:59 INFO - TEST-START | v8_7 05:29:59 INFO - operating with platform_type : linux_ 05:29:59 INFO - Initialising browser for v8_7 test... 05:29:59 INFO - TEST-INFO | started process 22595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8dzLw/profile http://localhost:51265/getInfo.html) 05:30:04 INFO - PROCESS | 22595 | __metrics Screen width/height:1600/1200 05:30:04 INFO - PROCESS | 22595 | colorDepth:24 05:30:04 INFO - PROCESS | 22595 | Browser inner width/height: 1024/697 05:30:04 INFO - PROCESS | 22595 | __metrics 05:30:04 INFO - PROCESS | 22595 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:30:05 INFO - PROCESS | 22595 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:06 INFO - TEST-INFO | 22595: exit 0 05:30:06 INFO - Browser initialized. 05:30:06 INFO - Running cycle 1/1 for v8_7 test... 05:30:06 INFO - TEST-INFO | started process 22675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8dzLw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:18 INFO - PROCESS | 22675 | RSS: Main: 148676608 05:30:18 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | Cycle 1(1): loaded http://localhost:51265/tests/v8_7/run.html (next: http://localhost:51265/tests/v8_7/run.html) 05:30:39 INFO - PROCESS | 22675 | RSS: Main: 449921024 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | __start_tp_report 05:30:39 INFO - PROCESS | 22675 | _x_x_mozilla_page_load 05:30:39 INFO - PROCESS | 22675 | _x_x_mozilla_page_load_details 05:30:39 INFO - PROCESS | 22675 | |i|pagename|runs| 05:30:39 INFO - PROCESS | 22675 | |0;Richards;169.4628029147602 05:30:39 INFO - PROCESS | 22675 | |1;DeltaBlue;193.98642095053347 05:30:39 INFO - PROCESS | 22675 | |2;Encrypt;285.46959748786753 05:30:39 INFO - PROCESS | 22675 | |3;Decrypt;5263.1578947368425 05:30:39 INFO - PROCESS | 22675 | |4;RayTrace;2006.0120240480962 05:30:39 INFO - PROCESS | 22675 | |5;Earley;815.6606851549756 05:30:39 INFO - PROCESS | 22675 | |6;Boyer;12658.227848101265 05:30:39 INFO - PROCESS | 22675 | |7;RegExp;26684.21052631579 05:30:39 INFO - PROCESS | 22675 | |8;Splay;606.060606060606 05:30:39 INFO - PROCESS | 22675 | |9;NavierStokes;4822.115384615385 05:30:39 INFO - PROCESS | 22675 | __end_tp_report 05:30:39 INFO - PROCESS | 22675 | __startTimestamp1451309439862__endTimestamp 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | ------- Summary: start ------- 05:30:39 INFO - PROCESS | 22675 | Number of tests: 10 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#0] Richards Cycles:1 Average:169.46 Median:169.46 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 169.5 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 194.0 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#2] Encrypt Cycles:1 Average:285.47 Median:285.47 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 285.5 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 5263.2 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 2006.0 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#5] Earley Cycles:1 Average:815.66 Median:815.66 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 815.7 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#6] Boyer Cycles:1 Average:12658.23 Median:12658.23 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 12658.2 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 26684.2 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 606.1 05:30:39 INFO - PROCESS | 22675 | 05:30:39 INFO - PROCESS | 22675 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:30:39 INFO - PROCESS | 22675 | Values: 4822.1 05:30:39 INFO - PROCESS | 22675 | -------- Summary: end -------- 05:30:39 INFO - PROCESS | 22675 | 05:30:40 INFO - TEST-INFO | 22675: exit 0 05:30:40 INFO - TEST-OK | v8_7 | took 40979ms 05:30:40 INFO - SUITE-END | took 1220s 05:30:40 INFO - Completed test suite (00:20:20) 05:30:40 INFO - Working with test: dromaeo_css 05:30:40 INFO - Generating results file: dromaeo_css 05:30:40 INFO - Working with test: kraken 05:30:40 INFO - Generating results file: kraken 05:30:40 INFO - javascript benchmark 05:30:40 INFO - Working with test: v8_7 05:30:40 INFO - Generating results file: v8_7 05:30:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:30:40 INFO - process_Request line: dromaeo_css 6238.25 graph.html#tests=[[72,132,35]] 05:30:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:40 INFO - process_Request line: kraken 1526.40 graph.html#tests=[[232,132,35]] 05:30:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:41 INFO - process_Request line: v8_7 19464.98 graph.html#tests=[[230,132,35]] 05:30:41 INFO - RETURN: dromaeo_css: 6238.25 05:30:41 INFO - RETURN: kraken: 1526.40 05:30:41 INFO - RETURN: v8_7: 19464.98 05:30:41 INFO - javascript benchmark 05:30:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.358502166969, 2699.4736026474843, 2709.1195361507503, 2720.591911213318, 2745.299948513128, 4511.097780443908, 4616.307553866917, 4628.352030715694, 4675.298705194218, 4688.460827004896, 4620.283856002325, 4663.370444989934, 4743.359646447729, 4769.833055843046, 4770.666053376256, 4277.914441711164, 4315.072259464215, 4368.519462859091, 4405.6695747818885, 4438.5783350581805, 4181.268278051329, 4337.349397590371, 4365.825366985317, 4421.9336709949375, 4459.041306119184, 4236.089240813225, 4246.193223287565, 4258.74447533149, 4337.197618440567, 4362.541933097043, 4345.174416860787, 4350.521442641307, 4353.586409291144, 4357.3899654048455, 4362.582160797753, 4320.546342634009, 4329.740215587043, 4343.109662519176, 4354.934675979863, 4367.694261401703, 4434.711743736647, 4543.250363689987, 4544.659150563688, 4590.793414296365, 4716.551927566876, 5065.290859279704, 5082.720450375228, 5086.440491545927, 5086.77109530072, 5126.71803050832, 5087.160618497944, 5094.363204599425, 5102.030614183331, 5103.923441148386, 5105.719185444799, 4557.179707652621, 4656.371389862359, 4658.138244424792, 4663.160631086369, 4778.426588809296, 5206.7917283309, 5212.061828870839, 5219.869503262449, 5246.685198888079, 5251.186066159751, 4985.476524964826, 4991.301217829507, 4992.350994370709, 4992.875178120504, 5026.572741317029, 4899.461059283476, 5007.073691367109, 5065.13892638245, 5074.391073071181, 5077.746112694351, 4934.3338649282605, 4992.675476094042, 5084.567811736044, 5100.846974590768, 5122.231665250168, 4986.80052797884, 4988.9750551247735, 4990.975045124751, 4993.900121997613, 4995.837632784482, 4215.536291007987, 4228.76741779199, 4228.957710422918, 4233.915321693549, 4258.467691538558, 3539.7168226541817, 3631.364511210528, 3689.317476266899, 3708.054446116223, 3718.442233664972, 4404.8458303959205, 4410.580994805488, 4416.138852923713, 4438.467383913887, 4451.198784218872, 5108.259302401206, 5152.3044389007755, 5154.7938082476285, 5155.097857874857, 5197.480251974772, 4217.725847819882, 4318.481782186158, 4319.719218250803, 4410.955890441119, 4411.867643970686, 4445.73325600465, 4446.155230506193, 4446.399736035659, 4491.8203271869415, 4496.460424749051, 4825.059113472839, 4832.806687732522, 4877.268409738567, 4879.756012199447, 4932.580730637793, 4813.109574728686, 4919.139150648693, 4925.335079764186, 5014.6991180529285, 5019.698818070928, 4799.832005879777, 4847.103285892122, 4914.852554423373, 4932.605391568594, 4964.280179374043, 4988.501149884983, 4992.700437973734, 4994.750262486788, 5002.824901128443, 5045.293658887832, 4886.071646387317, 5083.796648134034, 5087.033463641897, 5093.796248150181, 5098.592112631055, 4814.735189564468, 4849.175640141255, 4874.878128046827, 4929.926051109308, 4970.900581988412, 4898.2652602109965, 4902.8774280643265, 4903.289023091703, 4905.190643543775, 4950.158473059517, 4658.510856360033, 4812.278158276286, 4813.181759101031, 4856.077345304381, 4870.610351171968, 4832.758362081811, 4847.975760121318, 4866.29438731389, 4883.633727470383, 4949.505049495022, 4825.203841366276, 4825.9034819304115, 4825.9034819304115, 4830.29960655696, 4866.29438731389], "unit": "score", "name": "dojo.html", "value": 4628.886009414443}, {"lowerIsBetter": false, "replicates": [549.5650855615986, 579.5740131003713, 585.701292340906, 589.5313225985343, 604.8729766748979, 25857.48285034298, 26344.4731105378, 26453.867730661368, 33557.0, 34151.0, 37208.44187337192, 37668.0, 37786.244275114484, 37820.0, 37852.62147378526, 7531.849363012737, 7667.769966901002, 7678.270564296411, 7684.615769211545, 7697.576633285167, 7006.754763583275, 7164.0, 9905.801883962316, 10104.292699511037, 10115.797684046314, 9778.608855645765, 9796.265280103986, 9886.653967111117, 9895.950520247388, 9905.900940990607, 6967.338102880219, 7125.2518485558785, 9735.075167859042, 9826.410415375029, 9844.310898237127, 9895.0, 10142.645007424779, 10156.187504999582, 10158.187345012382, 10173.237007224488, 32847.83576082104, 33327.83336083304, 33342.16644583905, 33342.66657333444, 33365.33269334624, 2685.368938299498, 2747.6565429321336, 2828.660560732725, 3114.9688503114903, 3356.093854659253, 26454.86772566144, 26720.0, 27053.729462705516, 28357.716422835714, 28744.568831467546, 3397.2825709380004, 3445.3798316303055, 3453.326601312745, 3541.8052007139595, 3569.0, 216899.0, 217100.0, 217597.0, 218111.0, 218494.0, 52762.472375275756, 53161.0, 53175.0, 53178.46821531813, 53270.73364633229, 49386.0, 50864.0, 57873.421265786805, 59089.11366329509, 59181.70409147927, 13236.801447978289, 13370.799438008438, 13391.330433478483, 13397.464101436028, 13429.932850335686, 10128.442935638463, 10135.49322533885, 10171.389716617026, 10179.898201018043, 10192.949035254924, 17491.212895419736, 17614.0, 17686.29254829818, 17715.73426398605, 17739.758216924693, 7234.4084301453595, 7366.668499917517, 7405.259474052552, 7450.925490745023, 7453.627318634047, 855.3456605696647, 885.4908427653996, 912.5300470257822, 917.3670167584345, 928.2342067794096, 26267.737322626912, 26291.73708262893, 26415.867920660272, 26489.337766555604, 26653.86673066622, 959.2853324273461, 978.2565250409598, 980.1864452504404, 988.2143695761887, 1049.8792638846478, 13528.661783455493, 13781.862181378057, 13917.02580819333, 13933.0, 13967.092139010932, 262764.0, 262880.0, 266383.0, 266562.0, 267033.0, 45627.0, 45888.0, 45917.540824592, 45942.770286148356, 45971.0, 1175.3887978251432, 1199.1066655341826, 1214.5141943222782, 1216.7992281273669, 1217.8051511758254, 25145.0, 25701.457912525308, 26131.477370452863, 26379.868100659372, 26460.0, 39798.403023955245, 39978.0, 40056.3991540133, 40078.0, 40113.0, 201282.0, 202654.0, 203091.0, 249259.0, 250611.0, 28905.710942891143, 29164.27089322784, 29375.706242937296, 29492.705072949855, 29710.96011639582, 33379.0, 33632.66367336393, 33709.0, 34500.48249276313, 34556.65443345534, 28774.856125719238, 29296.974605888692, 29354.70645293605, 29926.102216933527, 30205.0, 29434.411311774074, 29439.558406623488, 29573.408531829675, 29702.554461683525, 29733.0, 31869.20326991751, 32079.35841283208, 33798.49302260517, 34253.0, 34350.0, 25792.355191119623, 27168.72831271741, 27227.0, 27232.455350893266, 27822.86088569544, 22753.431164221027, 23588.52822943566, 23762.93066811963, 23793.52412951766, 24033.639495407933], "unit": "score", "name": "ext.html", "value": 16584.626314641795}, {"lowerIsBetter": false, "replicates": [308.0680940156029, 333.3882325931916, 334.1129301703976, 336.21829247000716, 336.8736723728602, 11132.276402033873, 15032.473863414783, 15063.472778452757, 15497.302621382036, 15504.68990620187, 9762.853557196648, 10078.546465409056, 10079.0, 10083.042110999462, 16097.114658693767, 3468.289000754839, 3566.8751593694224, 4301.0752688172115, 4453.643708503312, 5854.560907931901, 5869.55978301627, 5898.410158984088, 5902.911456328158, 5904.498117660004, 5906.88186236275, 4692.178868697982, 4822.324874517552, 4826.469088400273, 5851.8537036574, 5856.795012174574, 4760.690555113906, 4760.761961901909, 4781.760911954389, 4793.9520604794025, 4795.832145874895, 4564.406627138484, 4618.284165954283, 4622.237330840408, 4622.445306563234, 4623.791929363187, 13814.723705525934, 17958.281668733234, 18231.361902333356, 18263.45209643713, 18453.446396608124, 1802.1349752118924, 1835.7888842783118, 1855.4804654696707, 1865.7854346750025, 1910.694288913781, 8545.0, 8795.07651696569, 8854.513001784964, 10546.367217966947, 12994.610161695164, 1671.6322409069985, 1680.1767134104323, 1685.7977042754826, 1697.8471937525558, 1736.9826301736948, 53476.0, 56016.43983560153, 57317.71341143268, 58219.0, 58427.41572584305, 8288.83422331562, 8621.655133794578, 9211.815763684823, 9577.473238971785, 9813.950930245303, 12088.939555302342, 12217.69455763613, 12233.143679942497, 12298.692532686755, 12310.261384316791, 6811.386975172259, 6866.965665171742, 6999.8600027999155, 7027.543209691354, 7079.185893622196, 6721.092652491851, 6768.56004359715, 6794.252632210453, 6828.658567071726, 6830.897536536956, 4086.570910054461, 4091.0, 4113.8971525711495, 4198.328267477189, 4258.787060646955, 1685.7977042754949, 1724.491275073831, 1734.765806616116, 1743.320105158989, 1752.3341130370632, 758.6320634492267, 850.7830503221638, 894.5259012723267, 959.4627008875052, 974.9032338619054, 14520.273986300643, 14824.62938426548, 15004.24978751058, 15157.545273641808, 15673.373065077498, 759.6885277036499, 794.1343935110757, 799.3525244551931, 814.9959250203711, 847.6948298612494, 6858.382745552824, 7965.56189409588, 8450.323974082059, 9139.314551408672, 9185.448873067637, 461162.0, 471720.0, 475168.0, 480372.0, 480777.0, 44168.895777605176, 51932.40337983086, 65162.34837651563, 68213.65893170502, 70135.64932175408, 861.4572819123912, 982.4792859784326, 1038.3510306058865, 1054.1672079057612, 1060.565168281001, 13505.797413038616, 13757.10578812374, 13766.31168441594, 13794.0, 14077.718445630826, 29097.563536547394, 29342.0, 29353.412931741674, 29586.260343491584, 30441.391172176875, 40092.79953600213, 40105.39841902432, 40460.59539404568, 40976.18047638971, 42482.0, 8364.87452688198, 8610.182032706884, 9085.0, 9089.590968406304, 9117.863232051392, 10020.298579099393, 10109.292349535463, 13662.453501859814, 15942.442014529435, 16032.0, 13633.0, 13741.381637826122, 14049.508267210598, 14112.223827689575, 14132.364043618267, 13259.138156019828, 13549.796753048515, 13572.592822215349, 13830.585082447542, 14067.085639433404, 13798.517051903134, 13980.860191397956, 14088.36602352917, 14329.498467554002, 14426.278686065865, 8665.956670216608, 8703.43427677199, 8725.171108744658, 8826.558672066243, 8943.642254309754, 11971.820422693492, 13617.863821362056, 13910.58268251954, 13931.791023134458, 13962.4415023402], "unit": "score", "name": "jquery.html", "value": 7970.77000371915}, {"lowerIsBetter": false, "replicates": [1161.767646470706, 1393.8397084335302, 1409.4714482069223, 1526.5801904476268, 1745.973810392845, 5835.912461313078, 6772.932270677292, 6863.897041544368, 6872.140982377196, 6884.862302753942, 6880.931190688091, 7061.329173728487, 7068.575885446877, 7072.115985501812, 7089.149302083744, 1671.5737486940875, 1705.266735303819, 2004.979950200494, 2068.917243310266, 2102.4743814046487, 2013.3054096336814, 2017.767956684978, 2021.8989050547414, 2022.5853699991467, 2023.5649335392889, 2005.1377907499768, 2026.149017412683, 2057.5473395852964, 2058.0327246194265, 2067.431456349501, 1942.1842826013108, 1945.9318923837598, 1985.9106340214726, 1988.0755448716343, 1989.9900500497404, 1975.338261682338, 2007.6988451732357, 2010.9945027486258, 2013.0337438029828, 2013.8590298679098, 6996.650167491605, 7073.0, 7093.645317734145, 7100.8934865976535, 7102.39629631482, 4188.057687020427, 4246.129543443587, 4272.166927449149, 4279.0, 4287.721298115644, 2546.59254519276, 2641.603759436081, 2656.1633085577982, 2671.011725661498, 2684.7717943974785, 774.446270916292, 785.3952456608437, 787.3032366355759, 788.0936922539125, 814.539785021461, 9531.761705957337, 9581.664641737576, 9585.712428627152, 9608.231341492663, 9613.951930240304, 3826.330392181357, 3903.0437542802197, 3961.3265744823448, 3966.0, 3971.4042893566198, 8256.628451719687, 8293.129221431784, 8296.211859873303, 8301.709440169565, 8312.792180195422, 4311.288637374798, 4315.266404711207, 4319.6976211665515, 4327.112941846914, 4330.631896288788, 3849.4225866119746, 3874.2832575973534, 3876.612338766101, 3879.922401551953, 3883.941740873889, 2951.631046119235, 2992.5361568956846, 3319.7842140260805, 3321.5183798349103, 3385.813780242061, 1063.3672964586058, 1088.2382332367374, 1090.8418279349607, 1099.8020356335776, 1101.8347247912716, 902.2421166220406, 934.9766255843522, 1015.5430056474615, 1190.3750530971136, 1206.1135065726685, 6516.511261655395, 6526.086347911296, 6568.507361947873, 6599.670016499252, 6644.66776661165, 984.524628062939, 990.4948476277151, 1012.5949620151998, 1025.9230557708202, 1030.3663247103127, 5278.498542638443, 5282.154855223146, 5409.648372855751, 5419.647722897999, 5425.13197888336, 8134.3085837703275, 8391.202835730595, 8397.664093436317, 8462.36532260083, 8473.279771219391, 7971.123176450586, 8254.711085111992, 8257.0, 8272.8345433091, 8284.047334556482, 6639.136912201383, 6717.361850624183, 6783.626900520519, 6791.252962174157, 6794.660266986631, 6806.55757375769, 6834.624095674786, 6872.931270687229, 6897.0, 6904.516683832084, 7237.0, 7448.515846470179, 7825.4130940178575, 7877.487963282369, 7890.68437262526, 7418.777436676908, 7599.506032107895, 7611.2769286917655, 7623.047119110111, 7762.107357653942, 6120.051392034242, 6177.0, 6200.100985357189, 6204.410580994799, 6207.565470417208, 5634.85912852182, 5747.224124743107, 5756.107803290497, 6311.589746666452, 6478.287388387368, 6135.8466038347615, 6145.8156255312415, 6291.622502649856, 6302.369763023844, 6386.744530218739, 6234.750609975732, 6260.906086408799, 6309.936900630935, 6338.683065846597, 6362.618242905441, 5959.165716799738, 6018.007028840192, 6052.0, 6202.81391558254, 6263.154474145932, 5839.270091238595, 5957.523398128226, 5965.075413310944, 5971.701414929323, 5979.760809567742, 6009.699515024318, 6042.607230530001, 6056.878862422815, 6083.6349819011, 6088.36072212429], "unit": "score", "name": "mootools.html", "value": 4013.373598591301}, {"lowerIsBetter": false, "replicates": [298.3987265659695, 301.077198386944, 305.86694787767317, 306.61213564840466, 311.3337457840221, 5400.675959442431, 5408.864778380537, 5417.51242388185, 5439.374471935724, 5475.370332411774, 5357.491038351351, 5359.812406565771, 5363.141897296433, 5368.248445217672, 5371.167469042305, 4172.812223449937, 4175.331946888491, 4176.352665336863, 4178.394132850734, 4180.58194180581, 3959.4258832469272, 4099.795010249476, 4184.079502509443, 4185.434966279544, 4187.413762073312, 4006.519217693881, 4006.5392479864895, 4051.3517837146064, 4055.513338399396, 4059.7158198926086, 3986.40203969404, 4060.5736397678115, 4065.8576949806616, 4068.7151899367054, 4080.6939479538855, 3554.2713743682743, 3554.3957527220437, 3558.62634423387, 3561.857525698969, 3582.337267605475, 4837.32277481153, 4938.08645400602, 4974.90050198994, 5108.978204359143, 5116.258142569344, 4721.811127554894, 4749.881252968669, 4776.4268287805335, 4780.139574876521, 4780.259059845729, 5323.547498462635, 5665.603407761459, 5672.149177623348, 5677.858053548694, 5678.4037676044245, 3823.0824602095577, 3836.5971572984713, 3893.240818040483, 3893.785841778701, 3933.095388060762, 5908.320543137508, 5933.436323549256, 5934.080217566284, 5938.287405511323, 5947.04847224442, 4038.4749982502085, 4042.514898212233, 4043.211573743151, 4050.635442810102, 4052.8986775330854, 4036.6165214305183, 4109.650679692199, 4114.7119701620595, 4117.773522456234, 4118.670506359484, 4740.502247264057, 4743.193657078305, 4746.572808447257, 4749.501302363271, 4756.167670657621, 5638.520725738276, 5645.858853528613, 5646.124850648156, 5649.68926709035, 5655.660660360391, 1457.3951809998944, 1470.5367809140087, 1472.263868065967, 1473.5800296915327, 1474.0345073976562, 992.6029588164791, 999.6654466287442, 1008.969730908074, 1016.5019140621042, 1026.5893642543042, 4902.950970490249, 4917.0, 4920.606351491872, 4921.3602231710365, 4924.581410580069, 5831.475167234969, 5838.4453476919625, 5841.299044114733, 5847.26909136358, 5851.1223316502865, 4910.0, 4918.729469879191, 4921.212605983025, 4921.26181072842, 4927.334809800703, 3082.9383412331626, 3129.8122112673313, 3155.100796273097, 3157.7789554731407, 3162.4623813951684, 5591.580631452657, 5597.244372009808, 5608.046632072557, 5608.186812912105, 5620.156976453564, 5935.406459354116, 5940.990031694622, 5969.731362088716, 5969.761209551656, 5989.9101513477335, 5516.282883225155, 5566.2207290979295, 5579.218909352694, 5585.748641311069, 5591.580631452576, 5673.74468148926, 5904.143899134516, 5914.083317085859, 5931.495822855106, 5931.851703707442, 5501.944980550304, 5658.745356458887, 5658.801941932013, 5659.547236221175, 5661.2923384576925, 5492.5331346835965, 5578.246936663499, 5623.943760562342, 5687.0, 5703.572232082527, 3962.40563915415, 3998.4202290668272, 3999.92000160001, 3999.940000900047, 4000.099977505038, 5718.399568045295, 5886.0, 5899.436649288028, 5909.320428150818, 5945.821625351246, 5705.087186050212, 5706.771729130955, 5707.68607726579, 5711.571632127524, 5712.5429965601825, 5702.087665973424, 5702.51528620072, 5709.7430615623225, 5711.314642242791, 5715.142728590745, 5365.919511207413, 5577.024020796425, 5581.665100094007, 5584.553235741049, 5587.497125258747, 5691.857703557444, 5753.8561535961935, 5757.798477053283, 5760.740766665594, 5761.308642962704, 5622.184783206494, 5623.409541998031, 5627.268455100811, 5629.549636029026, 5629.54963602919], "unit": "score", "name": "prototype.html", "value": 4237.836791934983}, {"lowerIsBetter": false, "replicates": [639.4372951802413, 683.3405763438282, 717.8564287142572, 757.8446418484205, 789.9012623422076, 11130.332180069192, 11339.37633430161, 11341.036011938995, 11342.319460832356, 11343.773124537503, 11497.080233581315, 11586.884131158686, 11614.941925290383, 11618.128640351986, 11627.941860290686, 618.5144661440759, 775.1512094256808, 793.1592511937336, 793.3692714292123, 794.086800179795, 781.9921800781976, 794.0669713087128, 794.566961006253, 794.6860989908982, 794.9880751788728, 807.2452257139564, 811.5942028985507, 813.3737022492677, 813.4753084260649, 814.6700586262573, 810.5582457560585, 811.7037281392279, 811.7077851973285, 811.9228673276059, 813.6297984417076, 602.8794241151787, 603.9426254505815, 604.1994357476317, 604.4106995679222, 605.0410099991519, 11766.470508827038, 11903.107266955012, 11916.940415297955, 11929.105317101252, 11929.28424294545, 11269.43652817364, 11604.419779011016, 11707.824382634268, 11734.765304693943, 11853.703657408547, 8949.418287811337, 8979.730608081769, 9111.635534578609, 9274.07259274074, 9316.301277404222, 3199.728023118038, 3209.1816586770224, 3244.772865899388, 3258.283177700902, 3269.869205231788, 32901.83549082239, 38300.80849595762, 39419.40870886939, 39540.0, 43867.0, 9304.195873627421, 9512.47681377517, 9814.460204688668, 9815.656452024288, 9890.060444257784, 17063.061531615633, 17072.829271707124, 17080.231389587498, 17097.230624621923, 17102.48692539226, 6180.0, 6251.78118765841, 6314.273858506331, 6392.904106438407, 6672.633005184762, 3476.66971637694, 3597.0647631615443, 3599.0, 3599.640035996432, 3613.8915832525067, 2707.6073969274344, 2722.0, 2729.208529526415, 2730.358365784039, 2736.4253506763403, 480.0447110250576, 481.68690351271255, 487.4710938631554, 488.3114808120604, 491.1012846490913, 448.5985043386151, 450.916580432621, 459.481625675638, 473.51701264709806, 533.8825458399145, 7311.086114235721, 7320.853582928418, 7371.078615173104, 7374.188839227681, 7561.584112873845, 585.5930128560609, 594.6253860068216, 612.4518555892452, 621.5400603553338, 625.8372823065945, 3539.1682954505673, 3562.5012498250267, 3601.837917293728, 3615.5661320641693, 3622.7826330420257, 49972.25041624378, 50727.239091413656, 51563.0, 52032.73983630058, 52108.47891521112, 36052.27895442076, 43151.0, 43256.0, 43486.782566086964, 43664.3450348245, 35606.46590301148, 38027.429588556195, 39848.60151398449, 41427.58572414237, 41739.16521669611, 7726.0, 8038.557879316693, 8061.596920153852, 8178.877316840133, 8214.712485062993, 31950.36099278048, 31967.840160799045, 32552.51171232481, 33064.66935330616, 33244.667553325125, 39279.0, 39737.20525589414, 39743.60256397399, 39886.60113398829, 40278.39582406208, 8832.29341652679, 10261.179105671677, 10312.742181445525, 10312.845307320245, 10469.790604188025, 10598.788024239626, 10974.286671366335, 11423.543058277575, 11624.941875290908, 11656.941715291709, 10471.3193642413, 10629.25595208328, 10738.677839664822, 10838.945805270923, 11319.264247823865, 10209.285350025428, 10467.16262698967, 10471.738206544896, 10709.892901071202, 10843.566257349617, 10339.172866170838, 10360.326578772356, 10406.739831504274, 10431.0, 10863.348199108079, 9024.458532488072, 9108.362414630912, 9228.676996305097, 9323.393979391318, 9324.347295689508, 8359.623816928131, 8630.0, 8673.91326086731, 8704.608292626974, 8738.606762695566], "unit": "score", "name": "yui.html", "value": 5662.3503088500265}], "name": "dromaeo_css", "value": 6238.251239734128}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 115.0, 105.0, 112.0, 112.0, 114.0, 102.0, 112.0, 111.0, 104.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 150.0, 171.0, 129.0, 157.0, 157.0, 128.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 161.0, 164.0, 158.0, 160.0, 160.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 82.0, 92.0, 72.0, 72.0, 75.0, 116.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 131.0, 97.0, 99.0, 96.0, 134.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 149.0, 147.0, 146.0, 148.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 70.0, 70.0, 71.0, 70.0, 80.0, 68.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 85.0, 86.0, 85.0, 93.0, 85.0, 88.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [127.0, 134.0, 118.0, 119.0, 119.0, 117.0, 136.0, 124.0, 125.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [136.0, 146.0, 145.0, 151.0, 147.0, 142.0, 159.0, 149.0, 146.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 70.0, 69.0, 67.0, 69.0, 71.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1526.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.4628029147602], "unit": "score", "name": "Richards", "value": 208.31710200000003}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [285.46959748786753], "unit": "score", "name": "Encrypt", "value": 932.4320429999997}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [815.6606851549756], "unit": "score", "name": "Earley", "value": 817.0836380000003}, {"lowerIsBetter": false, "replicates": [12658.227848101265], "unit": "score", "name": "Boyer", "value": 52.65057700000003}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19464.978934623352}]} 05:30:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19464.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1526.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6238.25"}}} 05:30:41 INFO - Return code: 0 05:30:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:30:41 INFO - # TBPL SUCCESS # 05:30:41 INFO - Running post-action listener: _resource_record_post_action 05:30:41 INFO - Running post-run listener: _resource_record_post_run 05:30:42 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 16384; Write bytes: 554082304; Read time: 440; Write time: 904432 05:30:42 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 245563392; Read time: 0; Write time: 583712 05:30:42 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 16384; Write bytes: 308518912; Read time: 440; Write time: 320720 05:30:42 INFO - Running post-run listener: _upload_blobber_files 05:30:42 INFO - Blob upload gear active. 05:30:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:42 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 05:30:42 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'] 05:30:42 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 05:30:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:43 INFO - (blobuploader) - INFO - Done attempting. 05:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:44 INFO - (blobuploader) - INFO - Done attempting. 05:30:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:44 INFO - Return code: 0 05:30:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a88d7c8612ded476a9e513cede0cf175b9409466e31154b9b93e833df44eaf7430d6ed3913d5d2eac4ffce3825a677786b2619a96f1c5003087907069d003467", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277a239c9e923ca4b839f6d64f8ad86ca95c7309461b9891e7f870743c84c1f55d0b8ce77d37f8e542dcc24c2f3140dda982fca0c82e0c0b4c8999ff63a85c26"} 05:30:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:44 INFO - Contents: 05:30:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a88d7c8612ded476a9e513cede0cf175b9409466e31154b9b93e833df44eaf7430d6ed3913d5d2eac4ffce3825a677786b2619a96f1c5003087907069d003467", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277a239c9e923ca4b839f6d64f8ad86ca95c7309461b9891e7f870743c84c1f55d0b8ce77d37f8e542dcc24c2f3140dda982fca0c82e0c0b4c8999ff63a85c26"} 05:30:44 INFO - Copying logs to upload dir... 05:30:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.581758 ========= master_lag: 6.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-28 05:30:50.345069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 05:30:50.352599) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a88d7c8612ded476a9e513cede0cf175b9409466e31154b9b93e833df44eaf7430d6ed3913d5d2eac4ffce3825a677786b2619a96f1c5003087907069d003467", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277a239c9e923ca4b839f6d64f8ad86ca95c7309461b9891e7f870743c84c1f55d0b8ce77d37f8e542dcc24c2f3140dda982fca0c82e0c0b4c8999ff63a85c26"} build_url:https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/PsL9VCMxSzGSP2rIjJ1F-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a88d7c8612ded476a9e513cede0cf175b9409466e31154b9b93e833df44eaf7430d6ed3913d5d2eac4ffce3825a677786b2619a96f1c5003087907069d003467", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/277a239c9e923ca4b839f6d64f8ad86ca95c7309461b9891e7f870743c84c1f55d0b8ce77d37f8e542dcc24c2f3140dda982fca0c82e0c0b4c8999ff63a85c26"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 05:30:50.627979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:30:50.628366) ========= 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=a194aa7faa1be204aaca7d660000020b-1451308058.269904-600630352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 05:30:50.679273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 05:30:50.679623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 05:30:50.679943) ========= ========= Total master_lag: 6.62 =========