builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1451431824.74 results: success (0) buildid: 20151229144335 builduid: 9a139e8575a14d5496caaa0449265b40 revision: 0c12d4229be0068eb1b9beb5064b800f12143f20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.735513) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.735900) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.736424) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.787266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.787549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.842601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.842882) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.899031) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.899291) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.899618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:24.899903) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 15:30:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.7M=0s 2015-12-29 15:30:25 (77.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.037472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.037780) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.087545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.087855) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c12d4229be0068eb1b9beb5064b800f12143f20 --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 0c12d4229be0068eb1b9beb5064b800f12143f20 --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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 15:30:25,655 truncating revision to first 12 chars 2015-12-29 15:30:25,655 Setting DEBUG logging. 2015-12-29 15:30:25,655 attempt 1/10 2015-12-29 15:30:25,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c12d4229be0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 15:30:25,901 unpacking tar archive at: fx-team-0c12d4229be0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.618678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.618981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.631438) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.631796) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 15:30:25.632273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-29 15:30:25.632554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:26 INFO - MultiFileLogger online at 20151229 15:30:26 in /builds/slave/test 15:30:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:30:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:26 INFO - {'append_to_log': False, 15:30:26 INFO - 'base_work_dir': '/builds/slave/test', 15:30:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:30:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:26 INFO - 'branch': 'Fx-Team-Non-PGO', 15:30:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:26 INFO - 'config_files': ('talos/linux_config.py',), 15:30:26 INFO - 'default_actions': ('clobber', 15:30:26 INFO - 'read-buildbot-config', 15:30:26 INFO - 'download-and-extract', 15:30:26 INFO - 'populate-webroot', 15:30:26 INFO - 'create-virtualenv', 15:30:26 INFO - 'install', 15:30:26 INFO - 'run-tests'), 15:30:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:26 INFO - 'download_minidump_stackwalk': True, 15:30:26 INFO - 'download_symbols': 'ondemand', 15:30:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:26 INFO - 'installer_path': 'installer.exe', 15:30:26 INFO - 'log_level': 'info', 15:30:26 INFO - 'log_name': 'talos', 15:30:26 INFO - 'log_to_console': True, 15:30:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:26 INFO - 'opt_config_files': (), 15:30:26 INFO - 'pip_index': False, 15:30:26 INFO - 'sps_profile': False, 15:30:26 INFO - 'sps_profile_interval': 0, 15:30:26 INFO - 'suite': 'dromaeojs', 15:30:26 INFO - 'system_bits': '32', 15:30:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:26 INFO - 'title': 'talos-linux64-ix-023', 15:30:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:26 INFO - 'use_talos_json': True, 15:30:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:26 INFO - 'work_dir': 'build'} 15:30:26 INFO - ##### 15:30:26 INFO - ##### Running clobber step. 15:30:26 INFO - ##### 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: clobber 15:30:26 INFO - rmtree: /builds/slave/test/build 15:30:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - ##### 15:30:26 INFO - ##### Running read-buildbot-config step. 15:30:26 INFO - ##### 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: read_buildbot_config 15:30:26 INFO - Using buildbot properties: 15:30:26 INFO - { 15:30:26 INFO - "project": "", 15:30:26 INFO - "product": "firefox", 15:30:26 INFO - "script_repo_revision": "production", 15:30:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:30:26 INFO - "repository": "", 15:30:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:30:26 INFO - "buildid": "20151229144335", 15:30:26 INFO - "pgo_build": "False", 15:30:26 INFO - "basedir": "/builds/slave/test", 15:30:26 INFO - "buildnumber": 2265, 15:30:26 INFO - "slavename": "talos-linux64-ix-023", 15:30:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:30:26 INFO - "platform": "ubuntu64_hw", 15:30:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:30:26 INFO - "branch": "fx-team", 15:30:26 INFO - "repo_path": "integration/fx-team", 15:30:26 INFO - "revision": "0c12d4229be0068eb1b9beb5064b800f12143f20", 15:30:26 INFO - "stage_platform": "linux64", 15:30:26 INFO - "builduid": "9a139e8575a14d5496caaa0449265b40", 15:30:26 INFO - "slavebuilddir": "test" 15:30:26 INFO - } 15:30:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:30:26 INFO - Running post-action listener: _resource_record_post_action 15:30:26 INFO - ##### 15:30:26 INFO - ##### Running download-and-extract step. 15:30:26 INFO - ##### 15:30:26 INFO - Running pre-action listener: _resource_record_pre_action 15:30:26 INFO - Running main action method: download_and_extract 15:30:26 INFO - mkdir: /builds/slave/test/build/tests 15:30: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')]} 15:30:26 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:30:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json 15:30:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json 15:30:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:30:29 INFO - Downloaded 1302 bytes. 15:30:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:30:29 INFO - Using the following test package requirements: 15:30:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'jsshell-linux-x86_64.zip'], 15:30:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:29 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')]} 15:30:29 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:30 INFO - Downloaded 21943082 bytes. 15:30:30 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 15:30:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:30 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 15:30:31 INFO - Return code: 0 15:30:31 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 15:30:31 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')]} 15:30:31 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:42 INFO - Downloaded 21943082 bytes. 15:30:42 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 15:30:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:30:42 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 15:30:43 INFO - Return code: 0 15:30: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')]} 15:30:43 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:44 INFO - Downloaded 11132270 bytes. 15:30:44 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 15:30:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:44 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 15:30:44 INFO - Return code: 0 15:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:44 INFO - https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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 15:30:46 INFO - Downloaded 53334623 bytes. 15:30:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:46 INFO - mkdir: /builds/slave/test/properties 15:30:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:46 INFO - Contents: 15:30:46 INFO - build_url:https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:30:46 INFO - Running post-action listener: _resource_record_post_action 15:30:46 INFO - Running post-action listener: set_extra_try_arguments 15:30:46 INFO - ##### 15:30:46 INFO - ##### Running populate-webroot step. 15:30:46 INFO - ##### 15:30:46 INFO - Running pre-action listener: _resource_record_pre_action 15:30:46 INFO - Running main action method: populate_webroot 15:30:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:46 INFO - '--tppagecycles', 15:30:46 INFO - '7'], 15:30:46 INFO - 'tests': ['tsvgm']}}, 15:30:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:30:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:30:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:30:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'tests': ['damp', 'tps']}, 15:30:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['damp', 'tps']}, 15:30:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:30:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:46 INFO - 'other': {'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'other_l64': {'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'other_nol64': {'tests': ['a11yr', 15:30:46 INFO - 'ts_paint', 15:30:46 INFO - 'tpaint', 15:30:46 INFO - 'sessionrestore', 15:30:46 INFO - 'sessionrestore_no_auto_restore']}, 15:30:46 INFO - 'svgr': {'tests': ['tsvgx', 15:30:46 INFO - 'tsvgr_opacity', 15:30:46 INFO - 'tart', 15:30:46 INFO - 'tscrollx', 15:30:46 INFO - 'cart']}, 15:30:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['tsvgx', 15:30:46 INFO - 'tsvgr_opacity', 15:30:46 INFO - 'tart', 15:30:46 INFO - 'tscrollx', 15:30:46 INFO - 'cart']}, 15:30:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'tests': ['tp5o']}, 15:30:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'talos_options': ['--e10s'], 15:30:46 INFO - 'tests': ['tp5o']}, 15:30:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'talos_options': ['--xperf_path', 15:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:46 INFO - 'tests': ['tp5n']}, 15:30:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:46 INFO - 'talos_options': ['--e10s', 15:30:46 INFO - '--xperf_path', 15:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:46 INFO - 'tests': ['tp5n']}}, 15:30:46 INFO - 'talos.zip': {'path': '', 15:30:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:46 INFO - Running post-action listener: _resource_record_post_action 15:30:46 INFO - ##### 15:30:46 INFO - ##### Running create-virtualenv step. 15:30:46 INFO - ##### 15:30:46 INFO - Running pre-action listener: _resource_record_pre_action 15:30:46 INFO - Running main action method: create_virtualenv 15:30:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:46 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 15:30:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:46 INFO - Using real prefix '/usr' 15:30:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:48 INFO - Installing pip.................done. 15:30:48 INFO - Return code: 0 15:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:30: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', 'pip>=1.5'] in /builds/slave/test/build 15:30: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 pip>=1.5 15:30:48 INFO - Using env: {'DISPLAY': ':0', 15:30:48 INFO - 'HOME': '/home/cltbld', 15:30:48 INFO - 'LANG': 'en_US.UTF-8', 15:30:48 INFO - 'LANGUAGE': 'en_US:en', 15:30:48 INFO - 'LOGNAME': 'cltbld', 15:30:48 INFO - 'MAIL': '/var/mail/cltbld', 15:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:48 INFO - 'MOZ_NO_REMOTE': '1', 15:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:48 INFO - 'NO_EM_RESTART': '1', 15:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:48 INFO - 'PWD': '/builds/slave/test', 15:30:48 INFO - 'SHELL': '/bin/bash', 15:30:48 INFO - 'SHLVL': '1', 15:30:48 INFO - 'TERM': 'linux', 15:30:48 INFO - 'TMOUT': '86400', 15:30:48 INFO - 'USER': 'cltbld', 15:30:48 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:48 INFO - '_': '/tools/buildbot/bin/python'} 15:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:49 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 15:30:49 INFO - Cleaning up... 15:30:49 INFO - Return code: 0 15:30:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:30:49 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')]} 15:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:49 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')]} 15:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:49 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:30:49 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 15:30:49 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 15:30:49 INFO - Using env: {'DISPLAY': ':0', 15:30:49 INFO - 'HOME': '/home/cltbld', 15:30:49 INFO - 'LANG': 'en_US.UTF-8', 15:30:49 INFO - 'LANGUAGE': 'en_US:en', 15:30:49 INFO - 'LOGNAME': 'cltbld', 15:30:49 INFO - 'MAIL': '/var/mail/cltbld', 15:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:49 INFO - 'MOZ_NO_REMOTE': '1', 15:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:49 INFO - 'NO_EM_RESTART': '1', 15:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:49 INFO - 'PWD': '/builds/slave/test', 15:30:49 INFO - 'SHELL': '/bin/bash', 15:30:49 INFO - 'SHLVL': '1', 15:30:49 INFO - 'TERM': 'linux', 15:30:49 INFO - 'TMOUT': '86400', 15:30:49 INFO - 'USER': 'cltbld', 15:30:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:49 INFO - '_': '/tools/buildbot/bin/python'} 15:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:49 INFO - Downloading/unpacking psutil>=0.7.1 15:30:49 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 15:30:49 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 15:30:49 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 15:30:49 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 15:30:49 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 15:30:49 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 15:30:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:30:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:51 INFO - Installing collected packages: psutil 15:30:51 INFO - Running setup.py install for psutil 15:30:51 INFO - building 'psutil._psutil_linux' extension 15:30:51 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 15:30:51 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 15:30:51 INFO - building 'psutil._psutil_posix' extension 15:30:51 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 15:30:51 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 15:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:30:51 INFO - Successfully installed psutil 15:30:51 INFO - Cleaning up... 15:30:51 INFO - Return code: 0 15:30:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:30: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')]} 15:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:51 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:30:51 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 15:30:51 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 15:30:51 INFO - Using env: {'DISPLAY': ':0', 15:30:51 INFO - 'HOME': '/home/cltbld', 15:30:51 INFO - 'LANG': 'en_US.UTF-8', 15:30:51 INFO - 'LANGUAGE': 'en_US:en', 15:30:51 INFO - 'LOGNAME': 'cltbld', 15:30:51 INFO - 'MAIL': '/var/mail/cltbld', 15:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:51 INFO - 'MOZ_NO_REMOTE': '1', 15:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:51 INFO - 'NO_EM_RESTART': '1', 15:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:51 INFO - 'PWD': '/builds/slave/test', 15:30:51 INFO - 'SHELL': '/bin/bash', 15:30:51 INFO - 'SHLVL': '1', 15:30:51 INFO - 'TERM': 'linux', 15:30:51 INFO - 'TMOUT': '86400', 15:30:51 INFO - 'USER': 'cltbld', 15:30:51 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:51 INFO - '_': '/tools/buildbot/bin/python'} 15:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:51 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 15:30:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:30:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:30:53 INFO - Installing collected packages: mozsystemmonitor 15:30:53 INFO - Running setup.py install for mozsystemmonitor 15:30:53 INFO - Successfully installed mozsystemmonitor 15:30:53 INFO - Cleaning up... 15:30:53 INFO - Return code: 0 15:30:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:53 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:30:53 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 15:30:53 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 15:30:53 INFO - Using env: {'DISPLAY': ':0', 15:30:53 INFO - 'HOME': '/home/cltbld', 15:30:53 INFO - 'LANG': 'en_US.UTF-8', 15:30:53 INFO - 'LANGUAGE': 'en_US:en', 15:30:53 INFO - 'LOGNAME': 'cltbld', 15:30:53 INFO - 'MAIL': '/var/mail/cltbld', 15:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:53 INFO - 'MOZ_NO_REMOTE': '1', 15:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:53 INFO - 'NO_EM_RESTART': '1', 15:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:53 INFO - 'PWD': '/builds/slave/test', 15:30:53 INFO - 'SHELL': '/bin/bash', 15:30:53 INFO - 'SHLVL': '1', 15:30:53 INFO - 'TERM': 'linux', 15:30:53 INFO - 'TMOUT': '86400', 15:30:53 INFO - 'USER': 'cltbld', 15:30:53 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:53 INFO - '_': '/tools/buildbot/bin/python'} 15:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:30:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:30:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:30:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:30:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:30:56 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 15:30:56 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 15:30:56 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 15:30:56 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 15:30:56 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 15:30:56 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 15:30:56 INFO - Downloading docopt-0.6.1.tar.gz 15:30:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:30:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:30:56 INFO - Running setup.py install for blobuploader 15:30:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:30:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:30:56 INFO - Running setup.py install for requests 15:30:56 INFO - Running setup.py install for docopt 15:30:57 INFO - Successfully installed blobuploader requests docopt 15:30:57 INFO - Cleaning up... 15:30:57 INFO - Return code: 0 15:30:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:57 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:30:57 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 15:30:57 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 15:30:57 INFO - Using env: {'DISPLAY': ':0', 15:30:57 INFO - 'HOME': '/home/cltbld', 15:30:57 INFO - 'LANG': 'en_US.UTF-8', 15:30:57 INFO - 'LANGUAGE': 'en_US:en', 15:30:57 INFO - 'LOGNAME': 'cltbld', 15:30:57 INFO - 'MAIL': '/var/mail/cltbld', 15:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:57 INFO - 'MOZ_NO_REMOTE': '1', 15:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:30:57 INFO - 'NO_EM_RESTART': '1', 15:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:57 INFO - 'PWD': '/builds/slave/test', 15:30:57 INFO - 'SHELL': '/bin/bash', 15:30:57 INFO - 'SHLVL': '1', 15:30:57 INFO - 'TERM': 'linux', 15:30:57 INFO - 'TMOUT': '86400', 15:30:57 INFO - 'USER': 'cltbld', 15:30:57 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:57 INFO - '_': '/tools/buildbot/bin/python'} 15:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:30:57 INFO - Running setup.py (path:/tmp/pip-PC_Kfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:30:57 INFO - Running setup.py (path:/tmp/pip-HGJgxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:30:57 INFO - Running setup.py (path:/tmp/pip-pnVtJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:30:57 INFO - Running setup.py (path:/tmp/pip-Q9s8vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:30:57 INFO - Running setup.py (path:/tmp/pip-r5wbI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:30:57 INFO - Running setup.py (path:/tmp/pip-1RkUAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:30:57 INFO - Running setup.py (path:/tmp/pip-eV1n5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:30:57 INFO - Running setup.py (path:/tmp/pip-8pLqR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:30:57 INFO - Running setup.py (path:/tmp/pip-W3ayFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:30:57 INFO - Running setup.py (path:/tmp/pip-hikpif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:30:58 INFO - Running setup.py (path:/tmp/pip-TFUcbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:30:58 INFO - Running setup.py (path:/tmp/pip-_DXNLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:30:58 INFO - Running setup.py (path:/tmp/pip-yG5ZNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:30:58 INFO - Running setup.py (path:/tmp/pip-bfGEZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:58 INFO - Running setup.py (path:/tmp/pip-z_0H6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:30:58 INFO - Running setup.py (path:/tmp/pip-v8kdQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:30:58 INFO - Running setup.py (path:/tmp/pip-RxVngF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:30:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:30:58 INFO - Running setup.py install for manifestparser 15:30:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:30:58 INFO - Running setup.py install for mozcrash 15:30:58 INFO - Running setup.py install for mozdebug 15:30:58 INFO - Running setup.py install for mozdevice 15:30:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:30:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:30:58 INFO - Running setup.py install for mozfile 15:30:59 INFO - Running setup.py install for mozhttpd 15:30:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for mozinfo 15:30:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for mozInstall 15:30:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for mozleak 15:30:59 INFO - Running setup.py install for mozlog 15:30:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for moznetwork 15:30:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for mozprocess 15:30:59 INFO - Running setup.py install for mozprofile 15:30:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:30:59 INFO - Running setup.py install for mozrunner 15:31:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:00 INFO - Running setup.py install for mozscreenshot 15:31:00 INFO - Running setup.py install for moztest 15:31:00 INFO - Running setup.py install for mozversion 15:31:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:00 INFO - Cleaning up... 15:31:00 INFO - Return code: 0 15:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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', '-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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:31:00 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 15:31:00 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 15:31:00 INFO - Using env: {'DISPLAY': ':0', 15:31:00 INFO - 'HOME': '/home/cltbld', 15:31:00 INFO - 'LANG': 'en_US.UTF-8', 15:31:00 INFO - 'LANGUAGE': 'en_US:en', 15:31:00 INFO - 'LOGNAME': 'cltbld', 15:31:00 INFO - 'MAIL': '/var/mail/cltbld', 15:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:00 INFO - 'MOZ_NO_REMOTE': '1', 15:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:00 INFO - 'NO_EM_RESTART': '1', 15:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:00 INFO - 'PWD': '/builds/slave/test', 15:31:00 INFO - 'SHELL': '/bin/bash', 15:31:00 INFO - 'SHLVL': '1', 15:31:00 INFO - 'TERM': 'linux', 15:31:00 INFO - 'TMOUT': '86400', 15:31:00 INFO - 'USER': 'cltbld', 15:31:00 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:00 INFO - '_': '/tools/buildbot/bin/python'} 15:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:00 INFO - Running setup.py (path:/tmp/pip-UIHYYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:00 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)) 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:00 INFO - Running setup.py (path:/tmp/pip-e2kG95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:00 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)) 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:00 INFO - Running setup.py (path:/tmp/pip-UqVO0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:00 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)) 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:00 INFO - Running setup.py (path:/tmp/pip-_aaCEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:00 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)) 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:00 INFO - Running setup.py (path:/tmp/pip-Eh8BwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:00 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)) 15:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:00 INFO - Running setup.py (path:/tmp/pip-lwmLYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:01 INFO - Running setup.py (path:/tmp/pip-6bPoBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:01 INFO - Running setup.py (path:/tmp/pip-iEhBU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:01 INFO - Running setup.py (path:/tmp/pip-tBEtcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:01 INFO - Running setup.py (path:/tmp/pip-_EpS7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:01 INFO - Running setup.py (path:/tmp/pip-XiBScb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:01 INFO - Running setup.py (path:/tmp/pip-cE2VHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:01 INFO - Running setup.py (path:/tmp/pip-mLGvRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:01 INFO - Running setup.py (path:/tmp/pip-c7xqcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:01 INFO - Running setup.py (path:/tmp/pip-PQo3VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:01 INFO - Running setup.py (path:/tmp/pip-8EvSDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:01 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)) 15:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:01 INFO - Running setup.py (path:/tmp/pip-COn9sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:01 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)) 15:31:01 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)) 15:31:01 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)) 15:31:01 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)) 15:31:01 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)) 15:31:01 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)) 15:31:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:03 INFO - Downloading blessings-1.5.1.tar.gz 15:31:03 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 15:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:03 INFO - Installing collected packages: blessings 15:31:03 INFO - Running setup.py install for blessings 15:31:03 INFO - Successfully installed blessings 15:31:03 INFO - Cleaning up... 15:31:03 INFO - Return code: 0 15:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:04 INFO - Reading from file tmpfile_stdout 15:31:04 INFO - Current package versions: 15:31:04 INFO - argparse == 1.2.1 15:31:04 INFO - blessings == 1.5.1 15:31:04 INFO - blobuploader == 1.2.4 15:31:04 INFO - docopt == 0.6.1 15:31:04 INFO - manifestparser == 1.1 15:31:04 INFO - mozInstall == 1.12 15:31:04 INFO - mozcrash == 0.16 15:31:04 INFO - mozdebug == 0.1 15:31:04 INFO - mozdevice == 0.47 15:31:04 INFO - mozfile == 1.2 15:31:04 INFO - mozhttpd == 0.7 15:31:04 INFO - mozinfo == 0.9 15:31:04 INFO - mozleak == 0.1 15:31:04 INFO - mozlog == 3.1 15:31:04 INFO - moznetwork == 0.27 15:31:04 INFO - mozprocess == 0.22 15:31:04 INFO - mozprofile == 0.28 15:31:04 INFO - mozrunner == 6.11 15:31:04 INFO - mozscreenshot == 0.1 15:31:04 INFO - mozsystemmonitor == 0.0 15:31:04 INFO - moztest == 0.7 15:31:04 INFO - mozversion == 1.4 15:31:04 INFO - psutil == 3.1.1 15:31:04 INFO - requests == 1.2.3 15:31:04 INFO - wsgiref == 0.1.2 15:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:04 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:31:04 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 15:31:04 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 15:31:04 INFO - Using env: {'DISPLAY': ':0', 15:31:04 INFO - 'HOME': '/home/cltbld', 15:31:04 INFO - 'LANG': 'en_US.UTF-8', 15:31:04 INFO - 'LANGUAGE': 'en_US:en', 15:31:04 INFO - 'LOGNAME': 'cltbld', 15:31:04 INFO - 'MAIL': '/var/mail/cltbld', 15:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:04 INFO - 'MOZ_NO_REMOTE': '1', 15:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:04 INFO - 'NO_EM_RESTART': '1', 15:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:04 INFO - 'PWD': '/builds/slave/test', 15:31:04 INFO - 'SHELL': '/bin/bash', 15:31:04 INFO - 'SHLVL': '1', 15:31:04 INFO - 'TERM': 'linux', 15:31:04 INFO - 'TMOUT': '86400', 15:31:04 INFO - 'USER': 'cltbld', 15:31:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:04 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 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)) 15:31:04 INFO - Cleaning up... 15:31:04 INFO - Return code: 0 15:31:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:04 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:31:04 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 15:31:04 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 15:31:04 INFO - Using env: {'DISPLAY': ':0', 15:31:04 INFO - 'HOME': '/home/cltbld', 15:31:04 INFO - 'LANG': 'en_US.UTF-8', 15:31:04 INFO - 'LANGUAGE': 'en_US:en', 15:31:04 INFO - 'LOGNAME': 'cltbld', 15:31:04 INFO - 'MAIL': '/var/mail/cltbld', 15:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:04 INFO - 'MOZ_NO_REMOTE': '1', 15:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:04 INFO - 'NO_EM_RESTART': '1', 15:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:04 INFO - 'PWD': '/builds/slave/test', 15:31:04 INFO - 'SHELL': '/bin/bash', 15:31:04 INFO - 'SHLVL': '1', 15:31:04 INFO - 'TERM': 'linux', 15:31:04 INFO - 'TMOUT': '86400', 15:31:04 INFO - 'USER': 'cltbld', 15:31:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:04 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 INFO - Downloading/unpacking jsonschema 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:06 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 15:31:06 INFO - Downloading/unpacking functools32 (from jsonschema) 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:06 INFO - warning: no files found matching '*.txt' 15:31:06 INFO - no previously-included directories found matching 'build' 15:31:06 INFO - no previously-included directories found matching 'dist' 15:31:06 INFO - no previously-included directories found matching '.git*' 15:31:06 INFO - Installing collected packages: jsonschema, functools32 15:31:06 INFO - Running setup.py install for functools32 15:31:06 INFO - warning: no files found matching '*.txt' 15:31:06 INFO - no previously-included directories found matching 'build' 15:31:06 INFO - no previously-included directories found matching 'dist' 15:31:06 INFO - no previously-included directories found matching '.git*' 15:31:06 INFO - Successfully installed jsonschema functools32 15:31:06 INFO - Cleaning up... 15:31:06 INFO - Return code: 0 15:31:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:31:06 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')]} 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:06 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')]} 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:06 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 0x7fbb17062f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, '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': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', '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 15:31:06 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 15:31:06 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 15:31:06 INFO - Using env: {'DISPLAY': ':0', 15:31:06 INFO - 'HOME': '/home/cltbld', 15:31:06 INFO - 'LANG': 'en_US.UTF-8', 15:31:06 INFO - 'LANGUAGE': 'en_US:en', 15:31:06 INFO - 'LOGNAME': 'cltbld', 15:31:06 INFO - 'MAIL': '/var/mail/cltbld', 15:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:06 INFO - 'MOZ_NO_REMOTE': '1', 15:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:06 INFO - 'NO_EM_RESTART': '1', 15:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:06 INFO - 'PWD': '/builds/slave/test', 15:31:06 INFO - 'SHELL': '/bin/bash', 15:31:06 INFO - 'SHLVL': '1', 15:31:06 INFO - 'TERM': 'linux', 15:31:06 INFO - 'TMOUT': '86400', 15:31:06 INFO - 'USER': 'cltbld', 15:31:06 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:06 INFO - '_': '/tools/buildbot/bin/python'} 15:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:06 INFO - Downloading/unpacking flake8 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:31:08 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 15:31:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:31:08 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 15:31:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:09 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 15:31:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:31:09 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 15:31:09 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 15:31:09 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 15:31:09 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 15:31:09 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 15:31:09 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 15:31:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:09 INFO - no previously-included directories found matching 'docs/_build' 15:31:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:31:09 INFO - Running setup.py install for pep8 15:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:09 INFO - no previously-included directories found matching 'docs/_build' 15:31:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:31:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:31:09 INFO - Cleaning up... 15:31:09 INFO - Return code: 0 15:31:09 INFO - Running post-action listener: _resource_record_post_action 15:31:09 INFO - Running post-action listener: _start_resource_monitoring 15:31:09 INFO - Starting resource monitoring. 15:31:09 INFO - ##### 15:31:09 INFO - ##### Running install step. 15:31:09 INFO - ##### 15:31:09 INFO - Running pre-action listener: _resource_record_pre_action 15:31:09 INFO - Running main action method: install 15:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:09 INFO - Reading from file tmpfile_stdout 15:31:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:09 INFO - Reading from file tmpfile_stdout 15:31:09 INFO - Output received: 15:31:09 INFO - Usage: mozinstall [options] installer 15:31:09 INFO - Options: 15:31:09 INFO - -h, --help show this help message and exit 15:31:09 INFO - -d DEST, --destination=DEST 15:31:09 INFO - Directory to install application into. [default: 15:31:09 INFO - "/builds/slave/test"] 15:31:09 INFO - --app=APP Application being installed. [default: firefox] 15:31:09 INFO - mkdir: /builds/slave/test/build/application 15:31:09 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'] 15:31:09 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 15:31:25 INFO - Reading from file tmpfile_stdout 15:31:25 INFO - Output received: 15:31:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:25 INFO - Running post-action listener: _resource_record_post_action 15:31:25 INFO - ##### 15:31:25 INFO - ##### Running run-tests step. 15:31:25 INFO - ##### 15:31:25 INFO - Running pre-action listener: _resource_record_pre_action 15:31:25 INFO - Running main action method: run_tests 15:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:25 INFO - Python 2.7.3 15:31:25 INFO - Return code: 0 15:31:25 INFO - grabbing minidump binary from tooltool 15:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:25 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 0x2c673d0>, '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 0x2bd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd3360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:25 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 15:31:25 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 15:31:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:25 INFO - Return code: 0 15:31:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:31:26 INFO - Return code: 0 15:31:26 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:31:26 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 15:31:26 INFO - Using env: {'DISPLAY': ':0', 15:31:26 INFO - 'HOME': '/home/cltbld', 15:31:26 INFO - 'LANG': 'en_US.UTF-8', 15:31:26 INFO - 'LANGUAGE': 'en_US:en', 15:31:26 INFO - 'LOGNAME': 'cltbld', 15:31:26 INFO - 'MAIL': '/var/mail/cltbld', 15:31:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:26 INFO - 'MOZ_NO_REMOTE': '1', 15:31:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:26 INFO - 'NO_EM_RESTART': '1', 15:31:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:26 INFO - 'PWD': '/builds/slave/test', 15:31:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:26 INFO - 'SHELL': '/bin/bash', 15:31:26 INFO - 'SHLVL': '1', 15:31:26 INFO - 'TERM': 'linux', 15:31:26 INFO - 'TMOUT': '86400', 15:31:26 INFO - 'USER': 'cltbld', 15:31:26 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776', 15:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:26 INFO - '_': '/tools/buildbot/bin/python'} 15:31:26 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/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 15:31:26 INFO - mozversion application_buildid: 20151229144335 15:31:26 INFO - mozversion application_changeset: 0c12d4229be0068eb1b9beb5064b800f12143f20 15:31:26 INFO - mozversion application_display_name: Nightly 15:31:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:26 INFO - mozversion application_name: Firefox 15:31:26 INFO - mozversion application_remotingname: firefox 15:31:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:31:26 INFO - mozversion application_vendor: Mozilla 15:31:26 INFO - mozversion application_version: 46.0a1 15:31:26 INFO - mozversion platform_buildid: 20151229144335 15:31:26 INFO - mozversion platform_changeset: 0c12d4229be0068eb1b9beb5064b800f12143f20 15:31:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:31:26 INFO - mozversion platform_version: 46.0a1 15:31:26 INFO - using testdate: 1451431886 15:31:26 INFO - actual date: 1451431886 15:31:26 INFO - starting webserver on 'localhost:43932' 15:31:26 INFO - SUITE-START | Running 3 tests 15:31:26 INFO - TEST-START | dromaeo_css 15:31:26 INFO - operating with platform_type : linux_ 15:31:26 INFO - Initialising browser for dromaeo_css test... 15:31:26 INFO - TEST-INFO | started process 11967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEf8hnJ/profile http://localhost:43932/getInfo.html) 15:31:31 INFO - PROCESS | 11967 | __metrics Screen width/height:1600/1200 15:31:31 INFO - PROCESS | 11967 | colorDepth:24 15:31:31 INFO - PROCESS | 11967 | Browser inner width/height: 1024/697 15:31:31 INFO - PROCESS | 11967 | __metrics 15:31:31 INFO - PROCESS | 11967 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:31:31 INFO - PROCESS | 11967 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:31:32 INFO - TEST-INFO | 11967: exit 0 15:31:32 INFO - Browser initialized. 15:31:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:32 INFO - TEST-INFO | started process 12061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEf8hnJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:44 INFO - PROCESS | 12061 | RSS: Main: 148459520 15:31:44 INFO - PROCESS | 12061 | 15:32:35 INFO - PROCESS | 12061 | 1451431955939 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] 15:34:47 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43932/tests/dromaeo/cssquery-ext.html) 15:34:49 INFO - PROCESS | 12061 | RSS: Main: 253374464 15:34:49 INFO - PROCESS | 12061 | 15:37:51 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-ext.html (next: http://localhost:43932/tests/dromaeo/cssquery-jquery.html) 15:37:52 INFO - PROCESS | 12061 | RSS: Main: 231784448 15:37:52 INFO - PROCESS | 12061 | 15:40:54 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43932/tests/dromaeo/cssquery-mootools.html) 15:40:54 INFO - PROCESS | 12061 | RSS: Main: 229191680 15:40:54 INFO - PROCESS | 12061 | 15:43:56 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43932/tests/dromaeo/cssquery-prototype.html) 15:43:57 INFO - PROCESS | 12061 | RSS: Main: 218759168 15:43:57 INFO - PROCESS | 12061 | 15:47:00 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43932/tests/dromaeo/cssquery-yui.html) 15:47:00 INFO - PROCESS | 12061 | RSS: Main: 215539712 15:47:00 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | Cycle 1(1): loaded http://localhost:43932/tests/dromaeo/cssquery-yui.html (next: http://localhost:43932/tests/dromaeo/cssquery-dojo.html) 15:50:03 INFO - PROCESS | 12061 | RSS: Main: 265641984 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | __start_tp_report 15:50:03 INFO - PROCESS | 12061 | _x_x_mozilla_page_load 15:50:03 INFO - PROCESS | 12061 | _x_x_mozilla_page_load_details 15:50:03 INFO - PROCESS | 12061 | |i|pagename|runs| 15:50:03 INFO - PROCESS | 12061 | |0;dojo.html;2618.6072089186623;2728.9317767055823;2730;2741.136541989272;2757.972420275798;4531.750753708553;4619.584237418631;4678.391809064821;4687.859364219079;4691.108689349026;4574.473935497419;4614.584687378144;4623.676342656016;4625.259958406656;4657.4876763555985;4213.389058586503;4290.656747460196;4307.375430562574;4380.970471939092;4389.23188442023;4136.855210067648;4348.3912252284545;4369.104333611602;4411.250087485135;4441.333799930004;4260.02019535507;4266.5946735060115;4276.786160691953;4341.479022517318;4370;4239.936400953989;4249.1714115747445;4253.957460425387;4282.807273672693;4288.785560721952;4169.854055108087;4233.364995250707;4247.447831781848;4248.638865696419;4284.05750734841;4490.955090449086;4503.504614492404;4543.31850222466;4613.284940834176;4627.930581041287;5050.595952323805;5053.444121146671;5054.292399064134;5062.493750624945;5087.465816089294;5069.797208111671;5078.4159821620615;5078.5937125029905;5082.644214904958;5110.948890511122;4478.328250762379;4590.357349971006;4601.056783359403;4643;4684.156851766681;5135.486451354909;5138.07514647367;5138.871528211825;5141.5886729061585;5169.638125331266;4923.359963204761;4924.359833221658;4931.5315045070665;4954.9009019819405;4966.1061009018;4795.640326975421;4919.950800492021;4924.581410580141;4933.309336692866;5017.724025178577;4918.114739346952;4993.550580447777;5000.524950129732;5002.649814513022;5015.297858299841;4961;4974.452810190876;4981.701097934136;4985.077760614298;5030.396352437658;4119.567445418188;4215.536291007987;4225.450691410097;4253.298205796071;4305.677074219446;3685.94471082934;3695.611960744137;3742.083189618561;3775.8489660413275;3777.320082385197;4360.585744354281;4372.060007098489;4380.3210502372185;4414.381986521889;4417.514073451917;4803.279508073817;4921.901561968741;5054.82308119214;5059.51934566223;5110.540051395318;4306.181825453154;4311.48262208537;4366.825326986948;4368.890777730582;4408.735475871458;4504.121696269196;4508.368828364031;4512.81948722054;4523.638108951276;4568.543145685471;4616.838410655611;4757.14371413149;4836.202026665702;4837.395325584302;4839.491853355417;4853;5049.899002020013;5121.487851214849;5141.357330333708;5184;4785.449673287617;4798.7840547174765;4798.976005119952;4805.975970120127;4847.709137451764;4763;4882.877928051827;4976.154053810788;4986.077575648516;5028.994201159856;4926.113299606105;5002.224655178453;5094.796208151781;5096.388433388017;5119.385673719177;4886.877828054327;4902.117618828503;4913.70517768935;4913.852584422473;4958.25626156065;4711.646626502958;4784.425868895615;4888.437829649493;4903.877403064952;4957.330760347451;4684.508126646653;4714.528547145258;4739.123262196505;4836.153673107122;4863.975680121577;4949.505049495022;4971.453140154508;4983.3023376728015;4983.451820299837;4991.101601711727;4848.733319667452;4866.416030076413;4870.902581948412;4871.610271178368;4908.165611846066 15:50:03 INFO - PROCESS | 12061 | |1;ext.html;515.1654320001596;516.6667499462847;526.4893053737873;540.2409614491639;554.3209568278857;24762.999999999978;25150.245492635204;25168.24495265145;25168.37079073024;25225.2432427027;25571.232863014095;26014.08950686726;32067.51898721521;32394;32417.83791081047;7166.355028047487;7283.162436319812;7298.051253337086;7356.080489938758;7361.374283185935;6959.234484206733;7453.664585093657;7562.697492100309;7578.128515220737;7592.20281870404;6815.897761533581;9758.756031099208;10048.09567138961;10048.44733539655;10059.547320370564;9612;9716.368436051705;9735.17251033663;9735.318527703064;9736.707898763014;6988.580685158907;7151.7854464366155;7155.856882862366;9416.670416535388;9589.18491928187;25427.745722542724;35823;36392.636073639456;36843.631563684285;36923;2675.3445405875686;2734.4257705881787;2755.4023125167173;3190.2343437575046;3463.9134021649406;25944.74055259461;26231.868840655865;26306;26388;26940.326491837666;3000.504916688744;3016.366563021746;3093.3658599986948;3258.6089669239605;3406.3357645259184;228511;230746;231489;232785;232817.9999999983;46257.53742462532;47815;47818.760906195246;47842.52157478381;47858;58795;59780.70109649424;59787.40212597905;60345;60360;12725;12887.935560322327;12977.675558110934;12980.091393602357;12984.675383115498;9144.81710365789;9187.77030574241;9209.493477858781;9315.673951411804;9324.8601270981;18135.274589016557;18257.087145642665;18314;19121.139548720064;19123.90438047801;7159.463040272;7473.290037446434;7492.700291988368;7549.547027178387;7634.770956871303;824.6289169873581;829.8257365953217;853.6926706385697;855.9315254779602;870.6125774030496;25356.366090847878;25648.61527077095;25875;25880.741192588208;25937.481250374887;898.4384759525296;928.3176865004217;931.2736065868634;953.1564565359567;965.3194497878978;13411.530596429078;13480.797788033187;13602.387892544859;13609.455621775018;13675.658108547366;269432;273209;273937;274295;276221;44666;44913.326300105524;45342.77328613336;45365.09269814651;45407.091858162654;1132.7338075552238;1148.121686909515;1153.7058050197313;1157.1494951210852;1166.0380186346129;24882.751172488042;25191.87404062968;26077.217683468767;26091.217263482125;26151.607725884507;38274.2345153101;38946.80526597349;38982.22035559216;38982.6101738979;38989.415158773205;297517;308294;332306;343325;345466;29263.268418289714;29371.7062829369;29478.11565653034;29524.276115821365;29530.261743456587;36972.26055478821;37772;38129.809350953066;38434.80782596069;38891.6110838888;31574.526382103828;32360.676393236707;32777.34445311033;33265.33469330648;33293.50059749057;32640.183995400304;32934.505982409806;32941.50587741138;33078.33843323072;33195.336093278485;33169.668303316656;33372.16569585683;34946.30107397787;35539.82230088833;35683.643163568035;27272.318461853694;30222.244443889078;31218.843905781236;32051.67948320487;32263.193420164684;21140;21322.36032919015;21452.141914323252;21482.46293842604;21507.247246346302 15:50:03 INFO - PROCESS | 12061 | |2;jquery.html;337.2243839169909;338.4770529531873;338.63934909321586;339.0202315308758;339.10476342455934;12337.629871103858;12728.109032367714;14374.496892608748;14600.56198314051;15336.233188340595;9096.772580685487;9335.906640933588;9637.710868673934;13423.798643020338;15139.62150946227;4398;4466.62033727132;4506.639468842484;4513.661475389343;4532.456105267373;3308.5368048473115;3455.1534873955916;4452.1763473757455;4790.113828941639;5039.823606173784;4981.053599816041;4996.775145118479;4998.125328067592;5022.648414610979;5023.221400682882;4994.076095922248;4996.850094497153;5240.109181439165;5609.691466969315;5638.548916086703;5018;5019.498050194988;5020;5026.2711906773675;5029.647924645276;11047.83428248577;15481.767773483407;18481.445556633324;18884;18915.527111822175;1691.2389424758785;1695.1100672147097;1702.3871406293724;1703.778508793849;1730.2819329978045;8308.29379502743;8458.069612342637;8728.956355218183;9083.909930808346;12322.568710095104;1586;1596.6407558299406;1699.2523289752469;1733.298014304209;1738.8521975632086;53012.46987530114;54680.45319546793;54905.176422353696;55223.723881380734;56096.43903560953;9792.510374481248;9805.950970245103;9826.606935722491;9837.754056148653;9858.457784821903;12405.379731013594;12447.377631118408;12470.251784892935;12481.313527756061;12489.50041998328;6765.797026089225;6769.187697476236;6942.583444993316;6949.722011119599;7088.681009354591;6680.19837619479;6734.8989765153565;6736.124303840469;6770.830729231809;6779.15260592426;3905.1018265798457;3923.5684074751753;4196.265653510623;4201.579842015835;4270;1568.8823338249676;1599.7520384340446;1630.470097218385;1636.304570557532;1708.8889222200517;810.9026916770025;836.9707060252983;883.7834730490943;947.8957314695378;952.4285428742699;14942.551723448314;15277.159756213516;15581.532554023172;15805.68388632221;15868.841311586968;709.8828693265657;807.6284908941835;810.0562844286458;886.8004698942686;918.1415376622879;8686.39195256326;9011.188992990663;9070.682526111554;9104.089591040844;9169.862452063224;481745;485320;487235;497920;526420;64717.35282647207;65661.67169164124;66774.66612667002;67741.66129169421;68535;971.9562619682131;983.5918093991056;989.5596459575564;991.3506653142059;1010.5503051142318;13471.3937872794;13774.586762397144;13938.651533711332;14193.503227386991;14219.075760075562;32174.517382239752;32573.34853302968;32660.673393265763;32955.505667415484;33023.174420639676;38698;39037.804810975766;40354.39468408035;40826.59173408228;42629.786851065546;8484.40609157353;8595.05454400028;8622.439541429787;8719.912800872164;8739.475631462132;10046.196304295492;10347.586096556355;16331.183440828148;16502.092384918946;16631.584210394838;13476.326183690971;13711.314434278047;13842.515511957034;13899.930500347433;14086.295685215493;13323.333833308103;13332.600021999355;13513.63511385484;13916;14106.858931410554;9873.791017919348;13479.056466047283;13574.25341606221;13702.52041178554;14279.500217492754;8233.547154906537;8286.171382861665;8370.079291278076;8370.497770133812;8524.531150786766;8674.913250867663;12606;13028.804567931298;13414.396352164371;13543.25512096844 15:50:03 INFO - PROCESS | 12061 | |3;mootools.html;1197.4910662968236;1384.916904985701;1386.2722070912773;1472.3889585821885;1665.7917760279965;6013.308469526006;6196.163517925079;6728.15898012749;6814.046033555306;6834.624095674748;6677.399034086943;6689.832754181148;6741.460683145348;6770.22142453618;6772.187337519492;1721.4061148903609;1760.4982579964712;2015.4961259685078;2054.3734161080865;2054.8458865585067;2061.6701327787555;2100.936971890838;2103.82117520011;2104.379208133604;2105.3683894831565;2031.6038372517364;2046.0792643310494;2061.680439531875;2082.531430428149;2082.9062692178813;2043.0806137238153;2081.1779347157863;2103.5056761661;2113.6829475578634;2117.3224568138203;2069.4412508622736;2105.947351316214;2106.8314534837177;2124.66005439129;2125.128697234127;6868.519203655746;6933;6936.93063069373;6949.235584085746;6960.373566378999;4069.2471892699946;4161.604647558477;4185.769782661952;4186.748795072275;4190.8533201337805;2666.8533230672306;2763.5163846326814;2767.0315389613675;2812.325041989928;2814.8592570371397;844.1010324004915;872.4154816273112;882.4661080046544;920.8388532006938;922.5341202692597;9177.632894684204;9198.080191980749;9224.861627075532;9227.93878703951;9246.35275530713;3726.6087060858763;3815.294170578452;3890.4942357493346;3895.0651843557907;3898.161895192547;8100;8109.918900811034;8133.14601966785;8134.389920755967;8147.9185208147155;4246.087091275391;4247.915041699211;4250.341197114452;4250.404943307939;4250.978745106255;3858.710596705202;3872.6708229800784;3879.18537107205;3879.2241551689776;3882.9611703883165;2977.3003344214094;3026.6519350275;3029.3486900316097;3397.2016576104597;3491.266833964845;945.8013817098349;1070.7109080548364;1089.2429761315968;1093.10365500289;1093.7648405592836;855.2858363266618;863.8229163021565;864.6714248585497;868.9913100868911;929.665320484625;6476.773312934025;6532.771353002622;6546.541742078009;6556.836079097965;6560.245571759213;997.7356000659831;1002.0630710285906;1010.6664800615779;1016.903394177552;1020.9183265338903;4811.927821082687;4858.902821943541;4865.294532292868;4867.050925069578;4870.6103511718975;7848;8012.919870801217;8033.19668033192;8115.229053239933;8151.755447336589;7972.521648701097;8023.358131349478;8053.15441878606;8084.959575202086;8091.0695270043525;6661.9000714989315;6737.461003119739;6801.421879140328;6813.250542440328;6821.010953411826;6082.878342433215;6216.937830621817;6223.688815559113;6228.968855155877;6243.8126856194385;7579.583122928071;7747.535147891144;7800.258975397555;7815.53106813593;7817.5309481431295;7457.664405101892;7613.428992825671;7794.649240784065;7834.921650783419;7960.601969901598;6245.843853903689;6351.396617321347;6352.174217351715;6358.491320694426;6360.045993101072;5719.342275638189;6553.148090748172;6759.763408280686;6826.488013399115;6872.381485666314;5393.191021346829;6020.39796020412;6132;6160.907586386297;6179.412955769195;5689.54483641316;5823.70881455934;5840;5844.824655260349;5935.198748168942;5580.1629755537;5609.691466969192;5625.493705566519;5626.212330273846;5626.915596266142;5476.288082549243;5485.424030476743;5486.972565137149;5498.147787092847;5498.945010550004;5574.331080270394;5618.129189975561;5619.100943848965;5627.746751396279;5724.198612194379 15:50:03 INFO - PROCESS | 12061 | |4;prototype.html;308.8486641545642;311.2809410262294;321.1745813259922;324.04568545633106;326.2447434189852;5225.843224703261;5384.138537833937;5416.106342453495;5417.972910135453;5430.076886929227;5277.102892508273;5373.462653734634;5378.408375078739;5384.300040994675;5399.406065332811;3923.6664883484796;4016.9397459038137;4021.919561608766;4173.666106711464;4175.290200665879;4083.7549747015273;4109.589041095896;4113.218488487178;4114.053767633446;4114.897127571805;4086.509618845743;4103.753774773509;4104.610062044101;4109.137081212949;4113.56807535209;3893.8831835044853;3980.8208630611693;3991.9002024949173;4082.448869402622;4094.4063110849056;3590.676839084495;3590.838412271454;3602.35157671619;3607.2965771674535;3615.5842078161086;5022.924656130161;5080;5081.618878584084;5095.108356037716;5096.210087436416;4698.919248572847;4701.882452938669;4708.916949101726;4736.52634736527;4753.191957367256;5449.455054494559;5609.934112518649;5610.13042978339;5612.607117501777;5622.100463925753;3932.6067393260732;3934.8426062957446;3935.370340745467;3941.724079314449;3943.507061617298;5866.384029676865;5915.290165180163;5924.674142922137;5956.22569066023;5962.672053037038;4050.02799328165;4051.858184963571;4056.411820286042;4057.472528571267;4058.9594104058583;3978.104926391539;4104.774237416971;4116.4648595682365;4122.525909520384;4122.587741225853;4679.672422930362;4683.859484215479;4687.109449204709;4713.599344055725;4734.887301484148;5634.014047541664;5644.6330988485615;5644.85887852807;5645.858853528694;5652.293463317085;1437.1377173695698;1448.2251995182526;1459.2047334202884;1459.7810328450605;1462.612407711957;969.9078587534173;978.618983839593;985.4333758088984;986.9851952220722;1004.1213937804421;4968.080905032581;4968.22992436173;4971.825986090469;4974.403071631355;4980.153373926441;5839.9124013139835;5849.093390524476;5851.912221316684;5853.502452291517;5860.033094539353;4959.404871415453;4964.652474326763;4970.130227210224;4972.453030166679;4974.502549745069;2922.839243841609;2981.5240662913193;3064.8007879487764;3127.0931429885077;3136.8745250189736;5518.696471694096;5640.238567793295;5643.5767317451355;5646.463585959409;5649.71751412436;6043.7884674036195;6076.605020673731;6086.452219300284;6099.207103076572;6100.786472473442;5636.97181514098;5639.069553523623;5640.1257805041105;5642.633228840113;5651;5729.1119876419225;5854.824355269348;5893.057110862242;5894.911576326273;5900;5744.885102297847;5752.223449834386;5754.136879468113;5755.65466072037;5761.164631128547;5611.38274789781;5614.803481878114;5616.241807355955;5619.044762390486;5622.578306626938;3991.4411982321917;4085.2442298174933;4086.366613174963;4089.2026054919006;4090.8159132839687;5850.561207909339;5902.675352855634;5903.350631430453;5903.881922361443;5912.822615321547;5667.801626943037;5687.118496633028;5688.715564221855;5691;5695.1457281406465;5636.746346414339;5646.491815736604;5647.858803529944;5648.85877853057;5658.349289831722;5337.146056630921;5537.086380747131;5556.444355564411;5564.360098588714;5573.7770489179975;5710.486056254957;5721.942780572307;5727.484526392478;5727.627704199213;5728.513076388554;5307.41618421981;5387.784488620411;5511.393746687781;5564.248826408545;5579.832605021856 15:50:03 INFO - PROCESS | 12061 | |5;yui.html;640.4044238857863;676.4757313082364;719.9388052015579;754.6000619671576;755;11395.943020284898;11565.826512602318;11579.131565132617;11581.53673853046;11593.536258549648;11272.436378181099;11352.659420217407;11361.091112710985;11382.146339024564;11383.260088094268;605.2283338743093;616.352829528995;749.3630414147985;753.0850017229066;765.5062484697366;755.2447552447552;756.3646536908996;763.7403282883819;763.8090477380655;764.4114032195206;782.6478084861807;787.6337503061076;788.0582703669118;789.917058708833;796.1361922314296;639.3734140542272;649.2598437780933;790.2216316927821;803.2810634482106;804.1676864445271;598.308953159102;598.374698440131;598.7156100852104;599.080411568245;599.1163034524086;10923.508442120125;10941.79640239573;11012.50443730026;11030.448477576168;11068.557257709683;10022.298439109265;10870.402127883042;11023.118150547936;11030.50362733671;11248.043916267126;8978.775530611721;9121.042290559528;9132.771680708036;9143.817123657556;9331.813363732688;3169.112648458435;3192.696693814084;3219.259570298821;3221.178599457147;3297.1757060734817;37754.244915101546;37866.8106659465;38087.23825523502;39169.41245881314;39193.60806391928;8863.778405539913;8864.157904999014;8901.821963560693;9015.233705135006;9018.774530636787;15038.473653422077;15042;15064.849351506564;15067.623309417133;15076.773848392282;6245.406686364788;6278.121063051177;6319.431251187415;6352.205974253218;6514.5114116441455;3305.983470082634;3437.5874895012757;3449.189440481485;3454.29187016661;3496.5804103507744;2600.752928471792;2650.310919161032;2654.0047482194177;2654.82743621664;2661.0420248710448;475.07834800486944;479.2547588499916;480.7788417328068;484.62925861715814;496.9801207951714;409.57608874814423;415.8690012646007;435.31437985173477;479.3648415849014;549.409384911222;6536.444402225769;6771.356721111487;7112.28877112295;7215;7397;434.2682579852958;452.42767898608287;500.91074681238445;514.5292057767101;560.9214709940611;3152.290734584746;3324.7173990210617;3377.273886114497;3386.1365351835125;3433.124553238958;41342.37986430206;41469.79265103655;41478.792606036775;41549.376759348634;41560.37659435111;38379.424308635396;44410;44550;44585;44665.77667111644;39078.218435631126;39707.60292397097;39765;39822.2035559293;39930.40104398436;6737.969502447457;6867.931320686729;6945.548539344926;7002.404795592432;7258.20159782413;28316.85841570779;28653.14040578786;28862.855685721435;29283.85358073196;29354.559681604365;39648.40527392149;39699.206015880096;40061.599384005785;40260;40430.595694042684;9519;9669.371490853073;9737.17234035115;9746.75633109178;9853;10524.473776311306;10575.788484230427;10625.787484250426;10662.89337106619;10923.453827308762;9546.809063818824;10034.448105354275;10075.294729369167;10092.394456332644;10703.090237329914;10503.10723588473;10536.894631053592;10588.364698118137;10868;10986.230963832455;9432.811343773223;9447.858282125637;9502.002289759752;9604.711858644252;9608.471534065415;7775.727849525466;7902.881456778038;8269.09040005587;8430.030546486987;8452.36607254446;8246.886670299433;8284.627191776264;8371.916280837113;8576.399652024298;8638.308935285037 15:50:03 INFO - PROCESS | 12061 | __end_tp_report 15:50:03 INFO - PROCESS | 12061 | __start_cc_report 15:50:03 INFO - PROCESS | 12061 | _x_x_mozilla_cycle_collect,919 15:50:03 INFO - PROCESS | 12061 | __end_cc_report 15:50:03 INFO - PROCESS | 12061 | __startTimestamp1451433003572__endTimestamp 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | ------- Summary: start ------- 15:50:03 INFO - PROCESS | 12061 | Number of tests: 6 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#0] dojo.html Cycles:165 Average:4634.48 Median:4784.43 stddev:479.16 (10.0%) stddev-sans-first:453.78 15:50:03 INFO - PROCESS | 12061 | Values: 2618.6 2728.9 2730.0 2741.1 2758.0 4531.8 4619.6 4678.4 4687.9 4691.1 4574.5 4614.6 4623.7 4625.3 4657.5 4213.4 4290.7 4307.4 4381.0 4389.2 4136.9 4348.4 4369.1 4411.3 4441.3 4260.0 4266.6 4276.8 4341.5 4370.0 4239.9 4249.2 4254.0 4282.8 4288.8 4169.9 4233.4 4247.4 4248.6 4284.1 4491.0 4503.5 4543.3 4613.3 4627.9 5050.6 5053.4 5054.3 5062.5 5087.5 5069.8 5078.4 5078.6 5082.6 5110.9 4478.3 4590.4 4601.1 4643.0 4684.2 5135.5 5138.1 5138.9 5141.6 5169.6 4923.4 4924.4 4931.5 4954.9 4966.1 4795.6 4920.0 4924.6 4933.3 5017.7 4918.1 4993.6 5000.5 5002.6 5015.3 4961.0 4974.5 4981.7 4985.1 5030.4 4119.6 4215.5 4225.5 4253.3 4305.7 3685.9 3695.6 3742.1 3775.8 3777.3 4360.6 4372.1 4380.3 4414.4 4417.5 4803.3 4921.9 5054.8 5059.5 5110.5 4306.2 4311.5 4366.8 4368.9 4408.7 4504.1 4508.4 4512.8 4523.6 4568.5 4616.8 4757.1 4836.2 4837.4 4839.5 4853.0 5049.9 5121.5 5141.4 5184.0 4785.4 4798.8 4799.0 4806.0 4847.7 4763.0 4882.9 4976.2 4986.1 5029.0 4926.1 5002.2 5094.8 5096.4 5119.4 4886.9 4902.1 4913.7 4913.9 4958.3 4711.6 4784.4 4888.4 4903.9 4957.3 4684.5 4714.5 4739.1 4836.2 4864.0 4949.5 4971.5 4983.3 4983.5 4991.1 4848.7 4866.4 4870.9 4871.6 4908.2 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#1] ext.html Cycles:180 Average:42250.46 Median:33124.00 stddev:73351.68 (221.4%) stddev-sans-first:73490.51 15:50:03 INFO - PROCESS | 12061 | Values: 515.2 516.7 526.5 540.2 554.3 24763.0 25150.2 25168.2 25168.4 25225.2 25571.2 26014.1 32067.5 32394.0 32417.8 7166.4 7283.2 7298.1 7356.1 7361.4 6959.2 7453.7 7562.7 7578.1 7592.2 6815.9 9758.8 10048.1 10048.4 10059.5 9612.0 9716.4 9735.2 9735.3 9736.7 6988.6 7151.8 7155.9 9416.7 9589.2 25427.7 35823.0 36392.6 36843.6 36923.0 2675.3 2734.4 2755.4 3190.2 3463.9 25944.7 26231.9 26306.0 26388.0 26940.3 3000.5 3016.4 3093.4 3258.6 3406.3 228511.0 230746.0 231489.0 232785.0 232818.0 46257.5 47815.0 47818.8 47842.5 47858.0 58795.0 59780.7 59787.4 60345.0 60360.0 12725.0 12887.9 12977.7 12980.1 12984.7 9144.8 9187.8 9209.5 9315.7 9324.9 18135.3 18257.1 18314.0 19121.1 19123.9 7159.5 7473.3 7492.7 7549.5 7634.8 824.6 829.8 853.7 855.9 870.6 25356.4 25648.6 25875.0 25880.7 25937.5 898.4 928.3 931.3 953.2 965.3 13411.5 13480.8 13602.4 13609.5 13675.7 269432.0 273209.0 273937.0 274295.0 276221.0 44666.0 44913.3 45342.8 45365.1 45407.1 1132.7 1148.1 1153.7 1157.1 1166.0 24882.8 25191.9 26077.2 26091.2 26151.6 38274.2 38946.8 38982.2 38982.6 38989.4 297517.0 308294.0 332306.0 343325.0 345466.0 29263.3 29371.7 29478.1 29524.3 29530.3 36972.3 37772.0 38129.8 38434.8 38891.6 31574.5 32360.7 32777.3 33265.3 33293.5 32640.2 32934.5 32941.5 33078.3 33195.3 33169.7 33372.2 34946.3 35539.8 35683.6 27272.3 30222.2 31218.8 32051.7 32263.2 21140.0 21322.4 21452.1 21482.5 21507.2 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#2] jquery.html Cycles:180 Average:25985.46 Median:4459.40 stddev:80951.87 (1815.3%) stddev-sans-first:81156.06 15:50:03 INFO - PROCESS | 12061 | Values: 337.2 338.5 338.6 339.0 339.1 12337.6 12728.1 14374.5 14600.6 15336.2 9096.8 9335.9 9637.7 13423.8 15139.6 4398.0 4466.6 4506.6 4513.7 4532.5 3308.5 3455.2 4452.2 4790.1 5039.8 4981.1 4996.8 4998.1 5022.6 5023.2 4994.1 4996.9 5240.1 5609.7 5638.5 5018.0 5019.5 5020.0 5026.3 5029.6 11047.8 15481.8 18481.4 18884.0 18915.5 1691.2 1695.1 1702.4 1703.8 1730.3 8308.3 8458.1 8729.0 9083.9 12322.6 1586.0 1596.6 1699.3 1733.3 1738.9 53012.5 54680.5 54905.2 55223.7 56096.4 9792.5 9806.0 9826.6 9837.8 9858.5 12405.4 12447.4 12470.3 12481.3 12489.5 6765.8 6769.2 6942.6 6949.7 7088.7 6680.2 6734.9 6736.1 6770.8 6779.2 3905.1 3923.6 4196.3 4201.6 4270.0 1568.9 1599.8 1630.5 1636.3 1708.9 810.9 837.0 883.8 947.9 952.4 14942.6 15277.2 15581.5 15805.7 15868.8 709.9 807.6 810.1 886.8 918.1 8686.4 9011.2 9070.7 9104.1 9169.9 481745.0 485320.0 487235.0 497920.0 526420.0 64717.4 65661.7 66774.7 67741.7 68535.0 972.0 983.6 989.6 991.4 1010.6 13471.4 13774.6 13938.7 14193.5 14219.1 32174.5 32573.3 32660.7 32955.5 33023.2 38698.0 39037.8 40354.4 40826.6 42629.8 8484.4 8595.1 8622.4 8719.9 8739.5 10046.2 10347.6 16331.2 16502.1 16631.6 13476.3 13711.3 13842.5 13899.9 14086.3 13323.3 13332.6 13513.6 13916.0 14106.9 9873.8 13479.1 13574.3 13702.5 14279.5 8233.5 8286.2 8370.1 8370.5 8524.5 8674.9 12606.0 13028.8 13414.4 13543.3 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#3] mootools.html Cycles:180 Average:4790.57 Median:5773.95 stddev:2459.34 (42.6%) stddev-sans-first:2451.41 15:50:03 INFO - PROCESS | 12061 | Values: 1197.5 1384.9 1386.3 1472.4 1665.8 6013.3 6196.2 6728.2 6814.0 6834.6 6677.4 6689.8 6741.5 6770.2 6772.2 1721.4 1760.5 2015.5 2054.4 2054.8 2061.7 2100.9 2103.8 2104.4 2105.4 2031.6 2046.1 2061.7 2082.5 2082.9 2043.1 2081.2 2103.5 2113.7 2117.3 2069.4 2105.9 2106.8 2124.7 2125.1 6868.5 6933.0 6936.9 6949.2 6960.4 4069.2 4161.6 4185.8 4186.7 4190.9 2666.9 2763.5 2767.0 2812.3 2814.9 844.1 872.4 882.5 920.8 922.5 9177.6 9198.1 9224.9 9227.9 9246.4 3726.6 3815.3 3890.5 3895.1 3898.2 8100.0 8109.9 8133.1 8134.4 8147.9 4246.1 4247.9 4250.3 4250.4 4251.0 3858.7 3872.7 3879.2 3879.2 3883.0 2977.3 3026.7 3029.3 3397.2 3491.3 945.8 1070.7 1089.2 1093.1 1093.8 855.3 863.8 864.7 869.0 929.7 6476.8 6532.8 6546.5 6556.8 6560.2 997.7 1002.1 1010.7 1016.9 1020.9 4811.9 4858.9 4865.3 4867.1 4870.6 7848.0 8012.9 8033.2 8115.2 8151.8 7972.5 8023.4 8053.2 8085.0 8091.1 6661.9 6737.5 6801.4 6813.3 6821.0 6082.9 6216.9 6223.7 6229.0 6243.8 7579.6 7747.5 7800.3 7815.5 7817.5 7457.7 7613.4 7794.6 7834.9 7960.6 6245.8 6351.4 6352.2 6358.5 6360.0 5719.3 6553.1 6759.8 6826.5 6872.4 5393.2 6020.4 6132.0 6160.9 6179.4 5689.5 5823.7 5840.0 5844.8 5935.2 5580.2 5609.7 5625.5 5626.2 5626.9 5476.3 5485.4 5487.0 5498.1 5498.9 5574.3 5618.1 5619.1 5627.7 5724.2 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#4] prototype.html Cycles:180 Average:4680.94 Median:5375.94 stddev:1389.28 (25.8%) stddev-sans-first:1353.87 15:50:03 INFO - PROCESS | 12061 | Values: 308.8 311.3 321.2 324.0 326.2 5225.8 5384.1 5416.1 5418.0 5430.1 5277.1 5373.5 5378.4 5384.3 5399.4 3923.7 4016.9 4021.9 4173.7 4175.3 4083.8 4109.6 4113.2 4114.1 4114.9 4086.5 4103.8 4104.6 4109.1 4113.6 3893.9 3980.8 3991.9 4082.4 4094.4 3590.7 3590.8 3602.4 3607.3 3615.6 5022.9 5080.0 5081.6 5095.1 5096.2 4698.9 4701.9 4708.9 4736.5 4753.2 5449.5 5609.9 5610.1 5612.6 5622.1 3932.6 3934.8 3935.4 3941.7 3943.5 5866.4 5915.3 5924.7 5956.2 5962.7 4050.0 4051.9 4056.4 4057.5 4059.0 3978.1 4104.8 4116.5 4122.5 4122.6 4679.7 4683.9 4687.1 4713.6 4734.9 5634.0 5644.6 5644.9 5645.9 5652.3 1437.1 1448.2 1459.2 1459.8 1462.6 969.9 978.6 985.4 987.0 1004.1 4968.1 4968.2 4971.8 4974.4 4980.2 5839.9 5849.1 5851.9 5853.5 5860.0 4959.4 4964.7 4970.1 4972.5 4974.5 2922.8 2981.5 3064.8 3127.1 3136.9 5518.7 5640.2 5643.6 5646.5 5649.7 6043.8 6076.6 6086.5 6099.2 6100.8 5637.0 5639.1 5640.1 5642.6 5651.0 5729.1 5854.8 5893.1 5894.9 5900.0 5744.9 5752.2 5754.1 5755.7 5761.2 5611.4 5614.8 5616.2 5619.0 5622.6 3991.4 4085.2 4086.4 4089.2 4090.8 5850.6 5902.7 5903.4 5903.9 5912.8 5667.8 5687.1 5688.7 5691.0 5695.1 5636.7 5646.5 5647.9 5648.9 5658.3 5337.1 5537.1 5556.4 5564.4 5573.8 5710.5 5721.9 5727.5 5727.6 5728.5 5307.4 5387.8 5511.4 5564.2 5579.8 15:50:03 INFO - PROCESS | 12061 | 15:50:03 INFO - PROCESS | 12061 | [#5] yui.html Cycles:180 Average:11543.77 Median:44567.50 stddev:12964.40 (29.1%) stddev-sans-first:12974.91 15:50:03 INFO - PROCESS | 12061 | Values: 640.4 676.5 719.9 754.6 755.0 11395.9 11565.8 11579.1 11581.5 11593.5 11272.4 11352.7 11361.1 11382.1 11383.3 605.2 616.4 749.4 753.1 765.5 755.2 756.4 763.7 763.8 764.4 782.6 787.6 788.1 789.9 796.1 639.4 649.3 790.2 803.3 804.2 598.3 598.4 598.7 599.1 599.1 10923.5 10941.8 11012.5 11030.4 11068.6 10022.3 10870.4 11023.1 11030.5 11248.0 8978.8 9121.0 9132.8 9143.8 9331.8 3169.1 3192.7 3219.3 3221.2 3297.2 37754.2 37866.8 38087.2 39169.4 39193.6 8863.8 8864.2 8901.8 9015.2 9018.8 15038.5 15042.0 15064.8 15067.6 15076.8 6245.4 6278.1 6319.4 6352.2 6514.5 3306.0 3437.6 3449.2 3454.3 3496.6 2600.8 2650.3 2654.0 2654.8 2661.0 475.1 479.3 480.8 484.6 497.0 409.6 415.9 435.3 479.4 549.4 6536.4 6771.4 7112.3 7215.0 7397.0 434.3 452.4 500.9 514.5 560.9 3152.3 3324.7 3377.3 3386.1 3433.1 41342.4 41469.8 41478.8 41549.4 41560.4 38379.4 44410.0 44550.0 44585.0 44665.8 39078.2 39707.6 39765.0 39822.2 39930.4 6738.0 6867.9 6945.5 7002.4 7258.2 28316.9 28653.1 28862.9 29283.9 29354.6 39648.4 39699.2 40061.6 40260.0 40430.6 9519.0 9669.4 9737.2 9746.8 9853.0 10524.5 10575.8 10625.8 10662.9 10923.5 9546.8 10034.4 10075.3 10092.4 10703.1 10503.1 10536.9 10588.4 10868.0 10986.2 9432.8 9447.9 9502.0 9604.7 9608.5 7775.7 7902.9 8269.1 8430.0 8452.4 8246.9 8284.6 8371.9 8576.4 8638.3 15:50:03 INFO - PROCESS | 12061 | -------- Summary: end -------- 15:50:03 INFO - PROCESS | 12061 | 15:50:04 INFO - TEST-INFO | 12061: exit 0 15:50:04 INFO - TEST-OK | dromaeo_css | took 1117647ms 15:50:04 INFO - TEST-START | kraken 15:50:04 INFO - operating with platform_type : linux_ 15:50:04 INFO - Initialising browser for kraken test... 15:50:04 INFO - TEST-INFO | started process 12248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1O9_p/profile http://localhost:43932/getInfo.html) 15:50:09 INFO - PROCESS | 12248 | __metrics Screen width/height:1600/1200 15:50:09 INFO - PROCESS | 12248 | colorDepth:24 15:50:09 INFO - PROCESS | 12248 | Browser inner width/height: 1024/697 15:50:09 INFO - PROCESS | 12248 | __metrics 15:50:09 INFO - PROCESS | 12248 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:50:09 INFO - PROCESS | 12248 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:10 INFO - TEST-INFO | 12248: exit 0 15:50:10 INFO - Browser initialized. 15:50:10 INFO - Running cycle 1/1 for kraken test... 15:50:10 INFO - TEST-INFO | started process 12329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1O9_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:22 INFO - PROCESS | 12329 | RSS: Main: 148987904 15:50:22 INFO - PROCESS | 12329 | 15:50:24 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:25 INFO - PROCESS | 12329 | RSS: Main: 185851904 15:50:25 INFO - PROCESS | 12329 | 15:50:28 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-dft) 15:50:28 INFO - PROCESS | 12329 | RSS: Main: 175554560 15:50:28 INFO - PROCESS | 12329 | 15:50:31 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-fft) 15:50:32 INFO - PROCESS | 12329 | RSS: Main: 162177024 15:50:32 INFO - PROCESS | 12329 | 15:50:34 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43932/tests/kraken/driver.html?testName=audio-oscillator) 15:50:34 INFO - PROCESS | 12329 | RSS: Main: 163942400 15:50:34 INFO - PROCESS | 12329 | 15:50:37 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:37 INFO - PROCESS | 12329 | RSS: Main: 163635200 15:50:37 INFO - PROCESS | 12329 | 15:50:40 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:41 INFO - PROCESS | 12329 | RSS: Main: 165478400 15:50:41 INFO - PROCESS | 12329 | 15:50:44 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43932/tests/kraken/driver.html?testName=imaging-desaturate) 15:50:45 INFO - PROCESS | 12329 | RSS: Main: 165711872 15:50:45 INFO - PROCESS | 12329 | 15:50:47 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43932/tests/kraken/driver.html?testName=json-parse-financial) 15:50:48 INFO - PROCESS | 12329 | RSS: Main: 164913152 15:50:48 INFO - PROCESS | 12329 | 15:50:50 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:50:50 INFO - PROCESS | 12329 | RSS: Main: 175235072 15:50:50 INFO - PROCESS | 12329 | 15:50:52 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:50:53 INFO - PROCESS | 12329 | RSS: Main: 174211072 15:50:53 INFO - PROCESS | 12329 | 15:50:55 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:50:56 INFO - PROCESS | 12329 | RSS: Main: 184930304 15:50:56 INFO - PROCESS | 12329 | 15:50:58 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:50:59 INFO - PROCESS | 12329 | RSS: Main: 191365120 15:50:59 INFO - PROCESS | 12329 | 15:51:01 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:02 INFO - PROCESS | 12329 | RSS: Main: 188157952 15:51:02 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:43932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43932/tests/kraken/driver.html?testName=ai-astar) 15:51:04 INFO - PROCESS | 12329 | RSS: Main: 247476224 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | __start_tp_report 15:51:04 INFO - PROCESS | 12329 | _x_x_mozilla_page_load 15:51:04 INFO - PROCESS | 12329 | _x_x_mozilla_page_load_details 15:51:04 INFO - PROCESS | 12329 | |i|pagename|runs| 15:51:04 INFO - PROCESS | 12329 | |0;ai-astar;112;112;107;113;112;114;103;112;112;103 15:51:04 INFO - PROCESS | 12329 | |1;audio-beat-detection;155;132;154;171;137;151;161;133;183;132 15:51:04 INFO - PROCESS | 12329 | |2;audio-dft;161;161;159;160;159;162;162;163;160;161 15:51:04 INFO - PROCESS | 12329 | |3;audio-fft;72;72;88;107;74;75;73;121;92;75 15:51:04 INFO - PROCESS | 12329 | |4;audio-oscillator;98;97;134;98;97;98;143;98;98;133 15:51:04 INFO - PROCESS | 12329 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;109 15:51:04 INFO - PROCESS | 12329 | |6;imaging-darkroom;146;146;148;147;147;147;147;148;146;147 15:51:04 INFO - PROCESS | 12329 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;96;95 15:51:04 INFO - PROCESS | 12329 | |8;json-parse-financial;70;69;68;71;69;70;69;78;67;67 15:51:04 INFO - PROCESS | 12329 | |9;json-stringify-tinderbox;69;69;68;68;68;69;69;69;69;69 15:51:04 INFO - PROCESS | 12329 | |10;stanford-crypto-aes;83;86;90;84;92;84;84;85;86;83 15:51:04 INFO - PROCESS | 12329 | |11;stanford-crypto-ccm;124;124;127;121;121;122;129;130;125;121 15:51:04 INFO - PROCESS | 12329 | |12;stanford-crypto-pbkdf2;141;154;149;148;147;137;147;147;148;145 15:51:04 INFO - PROCESS | 12329 | |13;stanford-crypto-sha256-iterative;70;71;74;69;70;72;70;74;70;69 15:51:04 INFO - PROCESS | 12329 | __end_tp_report 15:51:04 INFO - PROCESS | 12329 | __start_cc_report 15:51:04 INFO - PROCESS | 12329 | _x_x_mozilla_cycle_collect,1000 15:51:04 INFO - PROCESS | 12329 | __end_cc_report 15:51:04 INFO - PROCESS | 12329 | __startTimestamp1451433064394__endTimestamp 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | ------- Summary: start ------- 15:51:04 INFO - PROCESS | 12329 | Number of tests: 14 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.11 (3.7%) stddev-sans-first:4.29 15:51:04 INFO - PROCESS | 12329 | Values: 112.0 112.0 107.0 113.0 112.0 114.0 103.0 112.0 112.0 103.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.50 stddev:17.61 (11.4%) stddev-sans-first:18.62 15:51:04 INFO - PROCESS | 12329 | Values: 155.0 132.0 154.0 171.0 137.0 151.0 161.0 133.0 183.0 132.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 15:51:04 INFO - PROCESS | 12329 | Values: 161.0 161.0 159.0 160.0 159.0 162.0 162.0 163.0 160.0 161.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#3] audio-fft Cycles:10 Average:84.90 Median:74.50 stddev:17.13 (23.0%) stddev-sans-first:17.52 15:51:04 INFO - PROCESS | 12329 | Values: 72.0 72.0 88.0 107.0 74.0 75.0 73.0 121.0 92.0 75.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:98.00 stddev:19.00 (19.4%) stddev-sans-first:19.70 15:51:04 INFO - PROCESS | 12329 | Values: 98.0 97.0 134.0 98.0 97.0 98.0 143.0 98.0 98.0 133.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:51:04 INFO - PROCESS | 12329 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 15:51:04 INFO - PROCESS | 12329 | Values: 146.0 146.0 148.0 147.0 147.0 147.0 147.0 148.0 146.0 147.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:51:04 INFO - PROCESS | 12329 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:69.50 stddev:3.16 (4.5%) stddev-sans-first:3.35 15:51:04 INFO - PROCESS | 12329 | Values: 70.0 69.0 68.0 71.0 69.0 70.0 69.0 78.0 67.0 67.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:51:04 INFO - PROCESS | 12329 | Values: 69.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.02 (3.5%) stddev-sans-first:3.04 15:51:04 INFO - PROCESS | 12329 | Values: 83.0 86.0 90.0 84.0 92.0 84.0 84.0 85.0 86.0 83.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.50 stddev:3.34 (2.7%) stddev-sans-first:3.54 15:51:04 INFO - PROCESS | 12329 | Values: 124.0 124.0 127.0 121.0 121.0 122.0 129.0 130.0 125.0 121.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:147.50 stddev:4.60 (3.1%) stddev-sans-first:4.46 15:51:04 INFO - PROCESS | 12329 | Values: 141.0 154.0 149.0 148.0 147.0 137.0 147.0 147.0 148.0 145.0 15:51:04 INFO - PROCESS | 12329 | 15:51:04 INFO - PROCESS | 12329 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:1.85 (2.6%) stddev-sans-first:1.94 15:51:04 INFO - PROCESS | 12329 | Values: 70.0 71.0 74.0 69.0 70.0 72.0 70.0 74.0 70.0 69.0 15:51:04 INFO - PROCESS | 12329 | -------- Summary: end -------- 15:51:04 INFO - PROCESS | 12329 | 15:51:05 INFO - TEST-INFO | 12329: exit 0 15:51:05 INFO - TEST-OK | kraken | took 61003ms 15:51:05 INFO - TEST-START | v8_7 15:51:05 INFO - operating with platform_type : linux_ 15:51:05 INFO - Initialising browser for v8_7 test... 15:51:05 INFO - TEST-INFO | started process 12578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdpH73l/profile http://localhost:43932/getInfo.html) 15:51:10 INFO - PROCESS | 12578 | __metrics Screen width/height:1600/1200 15:51:10 INFO - PROCESS | 12578 | colorDepth:24 15:51:10 INFO - PROCESS | 12578 | Browser inner width/height: 1024/697 15:51:10 INFO - PROCESS | 12578 | __metrics 15:51:10 INFO - PROCESS | 12578 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:51:10 INFO - PROCESS | 12578 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:11 INFO - TEST-INFO | 12578: exit 0 15:51:11 INFO - Browser initialized. 15:51:11 INFO - Running cycle 1/1 for v8_7 test... 15:51:11 INFO - TEST-INFO | started process 12659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdpH73l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:23 INFO - PROCESS | 12659 | RSS: Main: 148533248 15:51:23 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:43932/tests/v8_7/run.html (next: http://localhost:43932/tests/v8_7/run.html) 15:51:44 INFO - PROCESS | 12659 | RSS: Main: 446873600 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | __start_tp_report 15:51:44 INFO - PROCESS | 12659 | _x_x_mozilla_page_load 15:51:44 INFO - PROCESS | 12659 | _x_x_mozilla_page_load_details 15:51:44 INFO - PROCESS | 12659 | |i|pagename|runs| 15:51:44 INFO - PROCESS | 12659 | |0;Richards;167.64459346186086 15:51:44 INFO - PROCESS | 12659 | |1;DeltaBlue;188.96447467876038 15:51:44 INFO - PROCESS | 12659 | |2;Encrypt;278.70680044593087 15:51:44 INFO - PROCESS | 12659 | |3;Decrypt;5246.073298429319 15:51:44 INFO - PROCESS | 12659 | |4;RayTrace;1988.0715705765408 15:51:44 INFO - PROCESS | 12659 | |5;Earley;804.5052292839904 15:51:44 INFO - PROCESS | 12659 | |6;Boyer;12512.5 15:51:44 INFO - PROCESS | 12659 | |7;RegExp;26868.42105263158 15:51:44 INFO - PROCESS | 12659 | |8;Splay;598.6959098992294 15:51:44 INFO - PROCESS | 12659 | |9;NavierStokes;4854.368932038835 15:51:44 INFO - PROCESS | 12659 | __end_tp_report 15:51:44 INFO - PROCESS | 12659 | __startTimestamp1451433104873__endTimestamp 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | ------- Summary: start ------- 15:51:44 INFO - PROCESS | 12659 | Number of tests: 10 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 167.6 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 189.0 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 278.7 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 5246.1 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 1988.1 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 804.5 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 12512.5 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 26868.4 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#8] Splay Cycles:1 Average:598.70 Median:598.70 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 598.7 15:51:44 INFO - PROCESS | 12659 | 15:51:44 INFO - PROCESS | 12659 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 15:51:44 INFO - PROCESS | 12659 | Values: 4854.4 15:51:44 INFO - PROCESS | 12659 | -------- Summary: end -------- 15:51:44 INFO - PROCESS | 12659 | 15:51:45 INFO - TEST-INFO | 12659: exit 0 15:51:45 INFO - TEST-OK | v8_7 | took 40450ms 15:51:45 INFO - SUITE-END | took 1219s 15:51:45 INFO - Completed test suite (00:20:19) 15:51:45 INFO - Working with test: dromaeo_css 15:51:45 INFO - Generating results file: dromaeo_css 15:51:45 INFO - Working with test: kraken 15:51:45 INFO - Generating results file: kraken 15:51:45 INFO - javascript benchmark 15:51:45 INFO - Working with test: v8_7 15:51:45 INFO - Generating results file: v8_7 15:51:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 15:51:45 INFO - process_Request line: dromaeo_css 6142.30 graph.html#tests=[[72,132,35]] 15:51:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:45 INFO - process_Request line: kraken 1533.00 graph.html#tests=[[232,132,35]] 15:51:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:51:46 INFO - process_Request line: v8_7 19655.51 graph.html#tests=[[230,132,35]] 15:51:46 INFO - RETURN: dromaeo_css: 6142.30 15:51:46 INFO - RETURN: kraken: 1533.00 15:51:46 INFO - RETURN: v8_7: 19655.51 15:51:46 INFO - javascript benchmark 15:51:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.6072089186623, 2728.9317767055823, 2730.0, 2741.136541989272, 2757.972420275798, 4531.750753708553, 4619.584237418631, 4678.391809064821, 4687.859364219079, 4691.108689349026, 4574.473935497419, 4614.584687378144, 4623.676342656016, 4625.259958406656, 4657.4876763555985, 4213.389058586503, 4290.656747460196, 4307.375430562574, 4380.970471939092, 4389.23188442023, 4136.855210067648, 4348.3912252284545, 4369.104333611602, 4411.250087485135, 4441.333799930004, 4260.02019535507, 4266.5946735060115, 4276.786160691953, 4341.479022517318, 4370.0, 4239.936400953989, 4249.1714115747445, 4253.957460425387, 4282.807273672693, 4288.785560721952, 4169.854055108087, 4233.364995250707, 4247.447831781848, 4248.638865696419, 4284.05750734841, 4490.955090449086, 4503.504614492404, 4543.31850222466, 4613.284940834176, 4627.930581041287, 5050.595952323805, 5053.444121146671, 5054.292399064134, 5062.493750624945, 5087.465816089294, 5069.797208111671, 5078.4159821620615, 5078.5937125029905, 5082.644214904958, 5110.948890511122, 4478.328250762379, 4590.357349971006, 4601.056783359403, 4643.0, 4684.156851766681, 5135.486451354909, 5138.07514647367, 5138.871528211825, 5141.5886729061585, 5169.638125331266, 4923.359963204761, 4924.359833221658, 4931.5315045070665, 4954.9009019819405, 4966.1061009018, 4795.640326975421, 4919.950800492021, 4924.581410580141, 4933.309336692866, 5017.724025178577, 4918.114739346952, 4993.550580447777, 5000.524950129732, 5002.649814513022, 5015.297858299841, 4961.0, 4974.452810190876, 4981.701097934136, 4985.077760614298, 5030.396352437658, 4119.567445418188, 4215.536291007987, 4225.450691410097, 4253.298205796071, 4305.677074219446, 3685.94471082934, 3695.611960744137, 3742.083189618561, 3775.8489660413275, 3777.320082385197, 4360.585744354281, 4372.060007098489, 4380.3210502372185, 4414.381986521889, 4417.514073451917, 4803.279508073817, 4921.901561968741, 5054.82308119214, 5059.51934566223, 5110.540051395318, 4306.181825453154, 4311.48262208537, 4366.825326986948, 4368.890777730582, 4408.735475871458, 4504.121696269196, 4508.368828364031, 4512.81948722054, 4523.638108951276, 4568.543145685471, 4616.838410655611, 4757.14371413149, 4836.202026665702, 4837.395325584302, 4839.491853355417, 4853.0, 5049.899002020013, 5121.487851214849, 5141.357330333708, 5184.0, 4785.449673287617, 4798.7840547174765, 4798.976005119952, 4805.975970120127, 4847.709137451764, 4763.0, 4882.877928051827, 4976.154053810788, 4986.077575648516, 5028.994201159856, 4926.113299606105, 5002.224655178453, 5094.796208151781, 5096.388433388017, 5119.385673719177, 4886.877828054327, 4902.117618828503, 4913.70517768935, 4913.852584422473, 4958.25626156065, 4711.646626502958, 4784.425868895615, 4888.437829649493, 4903.877403064952, 4957.330760347451, 4684.508126646653, 4714.528547145258, 4739.123262196505, 4836.153673107122, 4863.975680121577, 4949.505049495022, 4971.453140154508, 4983.3023376728015, 4983.451820299837, 4991.101601711727, 4848.733319667452, 4866.416030076413, 4870.902581948412, 4871.610271178368, 4908.165611846066], "unit": "score", "name": "dojo.html", "value": 4605.21872685004}, {"lowerIsBetter": false, "replicates": [515.1654320001596, 516.6667499462847, 526.4893053737873, 540.2409614491639, 554.3209568278857, 24762.999999999978, 25150.245492635204, 25168.24495265145, 25168.37079073024, 25225.2432427027, 25571.232863014095, 26014.08950686726, 32067.51898721521, 32394.0, 32417.83791081047, 7166.355028047487, 7283.162436319812, 7298.051253337086, 7356.080489938758, 7361.374283185935, 6959.234484206733, 7453.664585093657, 7562.697492100309, 7578.128515220737, 7592.20281870404, 6815.897761533581, 9758.756031099208, 10048.09567138961, 10048.44733539655, 10059.547320370564, 9612.0, 9716.368436051705, 9735.17251033663, 9735.318527703064, 9736.707898763014, 6988.580685158907, 7151.7854464366155, 7155.856882862366, 9416.670416535388, 9589.18491928187, 25427.745722542724, 35823.0, 36392.636073639456, 36843.631563684285, 36923.0, 2675.3445405875686, 2734.4257705881787, 2755.4023125167173, 3190.2343437575046, 3463.9134021649406, 25944.74055259461, 26231.868840655865, 26306.0, 26388.0, 26940.326491837666, 3000.504916688744, 3016.366563021746, 3093.3658599986948, 3258.6089669239605, 3406.3357645259184, 228511.0, 230746.0, 231489.0, 232785.0, 232817.9999999983, 46257.53742462532, 47815.0, 47818.760906195246, 47842.52157478381, 47858.0, 58795.0, 59780.70109649424, 59787.40212597905, 60345.0, 60360.0, 12725.0, 12887.935560322327, 12977.675558110934, 12980.091393602357, 12984.675383115498, 9144.81710365789, 9187.77030574241, 9209.493477858781, 9315.673951411804, 9324.8601270981, 18135.274589016557, 18257.087145642665, 18314.0, 19121.139548720064, 19123.90438047801, 7159.463040272, 7473.290037446434, 7492.700291988368, 7549.547027178387, 7634.770956871303, 824.6289169873581, 829.8257365953217, 853.6926706385697, 855.9315254779602, 870.6125774030496, 25356.366090847878, 25648.61527077095, 25875.0, 25880.741192588208, 25937.481250374887, 898.4384759525296, 928.3176865004217, 931.2736065868634, 953.1564565359567, 965.3194497878978, 13411.530596429078, 13480.797788033187, 13602.387892544859, 13609.455621775018, 13675.658108547366, 269432.0, 273209.0, 273937.0, 274295.0, 276221.0, 44666.0, 44913.326300105524, 45342.77328613336, 45365.09269814651, 45407.091858162654, 1132.7338075552238, 1148.121686909515, 1153.7058050197313, 1157.1494951210852, 1166.0380186346129, 24882.751172488042, 25191.87404062968, 26077.217683468767, 26091.217263482125, 26151.607725884507, 38274.2345153101, 38946.80526597349, 38982.22035559216, 38982.6101738979, 38989.415158773205, 297517.0, 308294.0, 332306.0, 343325.0, 345466.0, 29263.268418289714, 29371.7062829369, 29478.11565653034, 29524.276115821365, 29530.261743456587, 36972.26055478821, 37772.0, 38129.809350953066, 38434.80782596069, 38891.6110838888, 31574.526382103828, 32360.676393236707, 32777.34445311033, 33265.33469330648, 33293.50059749057, 32640.183995400304, 32934.505982409806, 32941.50587741138, 33078.33843323072, 33195.336093278485, 33169.668303316656, 33372.16569585683, 34946.30107397787, 35539.82230088833, 35683.643163568035, 27272.318461853694, 30222.244443889078, 31218.843905781236, 32051.67948320487, 32263.193420164684, 21140.0, 21322.36032919015, 21452.141914323252, 21482.46293842604, 21507.247246346302], "unit": "score", "name": "ext.html", "value": 16364.988440559202}, {"lowerIsBetter": false, "replicates": [337.2243839169909, 338.4770529531873, 338.63934909321586, 339.0202315308758, 339.10476342455934, 12337.629871103858, 12728.109032367714, 14374.496892608748, 14600.56198314051, 15336.233188340595, 9096.772580685487, 9335.906640933588, 9637.710868673934, 13423.798643020338, 15139.62150946227, 4398.0, 4466.62033727132, 4506.639468842484, 4513.661475389343, 4532.456105267373, 3308.5368048473115, 3455.1534873955916, 4452.1763473757455, 4790.113828941639, 5039.823606173784, 4981.053599816041, 4996.775145118479, 4998.125328067592, 5022.648414610979, 5023.221400682882, 4994.076095922248, 4996.850094497153, 5240.109181439165, 5609.691466969315, 5638.548916086703, 5018.0, 5019.498050194988, 5020.0, 5026.2711906773675, 5029.647924645276, 11047.83428248577, 15481.767773483407, 18481.445556633324, 18884.0, 18915.527111822175, 1691.2389424758785, 1695.1100672147097, 1702.3871406293724, 1703.778508793849, 1730.2819329978045, 8308.29379502743, 8458.069612342637, 8728.956355218183, 9083.909930808346, 12322.568710095104, 1586.0, 1596.6407558299406, 1699.2523289752469, 1733.298014304209, 1738.8521975632086, 53012.46987530114, 54680.45319546793, 54905.176422353696, 55223.723881380734, 56096.43903560953, 9792.510374481248, 9805.950970245103, 9826.606935722491, 9837.754056148653, 9858.457784821903, 12405.379731013594, 12447.377631118408, 12470.251784892935, 12481.313527756061, 12489.50041998328, 6765.797026089225, 6769.187697476236, 6942.583444993316, 6949.722011119599, 7088.681009354591, 6680.19837619479, 6734.8989765153565, 6736.124303840469, 6770.830729231809, 6779.15260592426, 3905.1018265798457, 3923.5684074751753, 4196.265653510623, 4201.579842015835, 4270.0, 1568.8823338249676, 1599.7520384340446, 1630.470097218385, 1636.304570557532, 1708.8889222200517, 810.9026916770025, 836.9707060252983, 883.7834730490943, 947.8957314695378, 952.4285428742699, 14942.551723448314, 15277.159756213516, 15581.532554023172, 15805.68388632221, 15868.841311586968, 709.8828693265657, 807.6284908941835, 810.0562844286458, 886.8004698942686, 918.1415376622879, 8686.39195256326, 9011.188992990663, 9070.682526111554, 9104.089591040844, 9169.862452063224, 481745.0, 485320.0, 487235.0, 497920.0, 526420.0, 64717.35282647207, 65661.67169164124, 66774.66612667002, 67741.66129169421, 68535.0, 971.9562619682131, 983.5918093991056, 989.5596459575564, 991.3506653142059, 1010.5503051142318, 13471.3937872794, 13774.586762397144, 13938.651533711332, 14193.503227386991, 14219.075760075562, 32174.517382239752, 32573.34853302968, 32660.673393265763, 32955.505667415484, 33023.174420639676, 38698.0, 39037.804810975766, 40354.39468408035, 40826.59173408228, 42629.786851065546, 8484.40609157353, 8595.05454400028, 8622.439541429787, 8719.912800872164, 8739.475631462132, 10046.196304295492, 10347.586096556355, 16331.183440828148, 16502.092384918946, 16631.584210394838, 13476.326183690971, 13711.314434278047, 13842.515511957034, 13899.930500347433, 14086.295685215493, 13323.333833308103, 13332.600021999355, 13513.63511385484, 13916.0, 14106.858931410554, 9873.791017919348, 13479.056466047283, 13574.25341606221, 13702.52041178554, 14279.500217492754, 8233.547154906537, 8286.171382861665, 8370.079291278076, 8370.497770133812, 8524.531150786766, 8674.913250867663, 12606.0, 13028.804567931298, 13414.396352164371, 13543.25512096844], "unit": "score", "name": "jquery.html", "value": 7923.40496831253}, {"lowerIsBetter": false, "replicates": [1197.4910662968236, 1384.916904985701, 1386.2722070912773, 1472.3889585821885, 1665.7917760279965, 6013.308469526006, 6196.163517925079, 6728.15898012749, 6814.046033555306, 6834.624095674748, 6677.399034086943, 6689.832754181148, 6741.460683145348, 6770.22142453618, 6772.187337519492, 1721.4061148903609, 1760.4982579964712, 2015.4961259685078, 2054.3734161080865, 2054.8458865585067, 2061.6701327787555, 2100.936971890838, 2103.82117520011, 2104.379208133604, 2105.3683894831565, 2031.6038372517364, 2046.0792643310494, 2061.680439531875, 2082.531430428149, 2082.9062692178813, 2043.0806137238153, 2081.1779347157863, 2103.5056761661, 2113.6829475578634, 2117.3224568138203, 2069.4412508622736, 2105.947351316214, 2106.8314534837177, 2124.66005439129, 2125.128697234127, 6868.519203655746, 6933.0, 6936.93063069373, 6949.235584085746, 6960.373566378999, 4069.2471892699946, 4161.604647558477, 4185.769782661952, 4186.748795072275, 4190.8533201337805, 2666.8533230672306, 2763.5163846326814, 2767.0315389613675, 2812.325041989928, 2814.8592570371397, 844.1010324004915, 872.4154816273112, 882.4661080046544, 920.8388532006938, 922.5341202692597, 9177.632894684204, 9198.080191980749, 9224.861627075532, 9227.93878703951, 9246.35275530713, 3726.6087060858763, 3815.294170578452, 3890.4942357493346, 3895.0651843557907, 3898.161895192547, 8100.0, 8109.918900811034, 8133.14601966785, 8134.389920755967, 8147.9185208147155, 4246.087091275391, 4247.915041699211, 4250.341197114452, 4250.404943307939, 4250.978745106255, 3858.710596705202, 3872.6708229800784, 3879.18537107205, 3879.2241551689776, 3882.9611703883165, 2977.3003344214094, 3026.6519350275, 3029.3486900316097, 3397.2016576104597, 3491.266833964845, 945.8013817098349, 1070.7109080548364, 1089.2429761315968, 1093.10365500289, 1093.7648405592836, 855.2858363266618, 863.8229163021565, 864.6714248585497, 868.9913100868911, 929.665320484625, 6476.773312934025, 6532.771353002622, 6546.541742078009, 6556.836079097965, 6560.245571759213, 997.7356000659831, 1002.0630710285906, 1010.6664800615779, 1016.903394177552, 1020.9183265338903, 4811.927821082687, 4858.902821943541, 4865.294532292868, 4867.050925069578, 4870.6103511718975, 7848.0, 8012.919870801217, 8033.19668033192, 8115.229053239933, 8151.755447336589, 7972.521648701097, 8023.358131349478, 8053.15441878606, 8084.959575202086, 8091.0695270043525, 6661.9000714989315, 6737.461003119739, 6801.421879140328, 6813.250542440328, 6821.010953411826, 6082.878342433215, 6216.937830621817, 6223.688815559113, 6228.968855155877, 6243.8126856194385, 7579.583122928071, 7747.535147891144, 7800.258975397555, 7815.53106813593, 7817.5309481431295, 7457.664405101892, 7613.428992825671, 7794.649240784065, 7834.921650783419, 7960.601969901598, 6245.843853903689, 6351.396617321347, 6352.174217351715, 6358.491320694426, 6360.045993101072, 5719.342275638189, 6553.148090748172, 6759.763408280686, 6826.488013399115, 6872.381485666314, 5393.191021346829, 6020.39796020412, 6132.0, 6160.907586386297, 6179.412955769195, 5689.54483641316, 5823.70881455934, 5840.0, 5844.824655260349, 5935.198748168942, 5580.1629755537, 5609.691466969192, 5625.493705566519, 5626.212330273846, 5626.915596266142, 5476.288082549243, 5485.424030476743, 5486.972565137149, 5498.147787092847, 5498.945010550004, 5574.331080270394, 5618.129189975561, 5619.100943848965, 5627.746751396279, 5724.198612194379], "unit": "score", "name": "mootools.html", "value": 3948.2769000251915}, {"lowerIsBetter": false, "replicates": [308.8486641545642, 311.2809410262294, 321.1745813259922, 324.04568545633106, 326.2447434189852, 5225.843224703261, 5384.138537833937, 5416.106342453495, 5417.972910135453, 5430.076886929227, 5277.102892508273, 5373.462653734634, 5378.408375078739, 5384.300040994675, 5399.406065332811, 3923.6664883484796, 4016.9397459038137, 4021.919561608766, 4173.666106711464, 4175.290200665879, 4083.7549747015273, 4109.589041095896, 4113.218488487178, 4114.053767633446, 4114.897127571805, 4086.509618845743, 4103.753774773509, 4104.610062044101, 4109.137081212949, 4113.56807535209, 3893.8831835044853, 3980.8208630611693, 3991.9002024949173, 4082.448869402622, 4094.4063110849056, 3590.676839084495, 3590.838412271454, 3602.35157671619, 3607.2965771674535, 3615.5842078161086, 5022.924656130161, 5080.0, 5081.618878584084, 5095.108356037716, 5096.210087436416, 4698.919248572847, 4701.882452938669, 4708.916949101726, 4736.52634736527, 4753.191957367256, 5449.455054494559, 5609.934112518649, 5610.13042978339, 5612.607117501777, 5622.100463925753, 3932.6067393260732, 3934.8426062957446, 3935.370340745467, 3941.724079314449, 3943.507061617298, 5866.384029676865, 5915.290165180163, 5924.674142922137, 5956.22569066023, 5962.672053037038, 4050.02799328165, 4051.858184963571, 4056.411820286042, 4057.472528571267, 4058.9594104058583, 3978.104926391539, 4104.774237416971, 4116.4648595682365, 4122.525909520384, 4122.587741225853, 4679.672422930362, 4683.859484215479, 4687.109449204709, 4713.599344055725, 4734.887301484148, 5634.014047541664, 5644.6330988485615, 5644.85887852807, 5645.858853528694, 5652.293463317085, 1437.1377173695698, 1448.2251995182526, 1459.2047334202884, 1459.7810328450605, 1462.612407711957, 969.9078587534173, 978.618983839593, 985.4333758088984, 986.9851952220722, 1004.1213937804421, 4968.080905032581, 4968.22992436173, 4971.825986090469, 4974.403071631355, 4980.153373926441, 5839.9124013139835, 5849.093390524476, 5851.912221316684, 5853.502452291517, 5860.033094539353, 4959.404871415453, 4964.652474326763, 4970.130227210224, 4972.453030166679, 4974.502549745069, 2922.839243841609, 2981.5240662913193, 3064.8007879487764, 3127.0931429885077, 3136.8745250189736, 5518.696471694096, 5640.238567793295, 5643.5767317451355, 5646.463585959409, 5649.71751412436, 6043.7884674036195, 6076.605020673731, 6086.452219300284, 6099.207103076572, 6100.786472473442, 5636.97181514098, 5639.069553523623, 5640.1257805041105, 5642.633228840113, 5651.0, 5729.1119876419225, 5854.824355269348, 5893.057110862242, 5894.911576326273, 5900.0, 5744.885102297847, 5752.223449834386, 5754.136879468113, 5755.65466072037, 5761.164631128547, 5611.38274789781, 5614.803481878114, 5616.241807355955, 5619.044762390486, 5622.578306626938, 3991.4411982321917, 4085.2442298174933, 4086.366613174963, 4089.2026054919006, 4090.8159132839687, 5850.561207909339, 5902.675352855634, 5903.350631430453, 5903.881922361443, 5912.822615321547, 5667.801626943037, 5687.118496633028, 5688.715564221855, 5691.0, 5695.1457281406465, 5636.746346414339, 5646.491815736604, 5647.858803529944, 5648.85877853057, 5658.349289831722, 5337.146056630921, 5537.086380747131, 5556.444355564411, 5564.360098588714, 5573.7770489179975, 5710.486056254957, 5721.942780572307, 5727.484526392478, 5727.627704199213, 5728.513076388554, 5307.41618421981, 5387.784488620411, 5511.393746687781, 5564.248826408545, 5579.832605021856], "unit": "score", "name": "prototype.html", "value": 4239.016681959407}, {"lowerIsBetter": false, "replicates": [640.4044238857863, 676.4757313082364, 719.9388052015579, 754.6000619671576, 755.0, 11395.943020284898, 11565.826512602318, 11579.131565132617, 11581.53673853046, 11593.536258549648, 11272.436378181099, 11352.659420217407, 11361.091112710985, 11382.146339024564, 11383.260088094268, 605.2283338743093, 616.352829528995, 749.3630414147985, 753.0850017229066, 765.5062484697366, 755.2447552447552, 756.3646536908996, 763.7403282883819, 763.8090477380655, 764.4114032195206, 782.6478084861807, 787.6337503061076, 788.0582703669118, 789.917058708833, 796.1361922314296, 639.3734140542272, 649.2598437780933, 790.2216316927821, 803.2810634482106, 804.1676864445271, 598.308953159102, 598.374698440131, 598.7156100852104, 599.080411568245, 599.1163034524086, 10923.508442120125, 10941.79640239573, 11012.50443730026, 11030.448477576168, 11068.557257709683, 10022.298439109265, 10870.402127883042, 11023.118150547936, 11030.50362733671, 11248.043916267126, 8978.775530611721, 9121.042290559528, 9132.771680708036, 9143.817123657556, 9331.813363732688, 3169.112648458435, 3192.696693814084, 3219.259570298821, 3221.178599457147, 3297.1757060734817, 37754.244915101546, 37866.8106659465, 38087.23825523502, 39169.41245881314, 39193.60806391928, 8863.778405539913, 8864.157904999014, 8901.821963560693, 9015.233705135006, 9018.774530636787, 15038.473653422077, 15042.0, 15064.849351506564, 15067.623309417133, 15076.773848392282, 6245.406686364788, 6278.121063051177, 6319.431251187415, 6352.205974253218, 6514.5114116441455, 3305.983470082634, 3437.5874895012757, 3449.189440481485, 3454.29187016661, 3496.5804103507744, 2600.752928471792, 2650.310919161032, 2654.0047482194177, 2654.82743621664, 2661.0420248710448, 475.07834800486944, 479.2547588499916, 480.7788417328068, 484.62925861715814, 496.9801207951714, 409.57608874814423, 415.8690012646007, 435.31437985173477, 479.3648415849014, 549.409384911222, 6536.444402225769, 6771.356721111487, 7112.28877112295, 7215.0, 7397.0, 434.2682579852958, 452.42767898608287, 500.91074681238445, 514.5292057767101, 560.9214709940611, 3152.290734584746, 3324.7173990210617, 3377.273886114497, 3386.1365351835125, 3433.124553238958, 41342.37986430206, 41469.79265103655, 41478.792606036775, 41549.376759348634, 41560.37659435111, 38379.424308635396, 44410.0, 44550.0, 44585.0, 44665.77667111644, 39078.218435631126, 39707.60292397097, 39765.0, 39822.2035559293, 39930.40104398436, 6737.969502447457, 6867.931320686729, 6945.548539344926, 7002.404795592432, 7258.20159782413, 28316.85841570779, 28653.14040578786, 28862.855685721435, 29283.85358073196, 29354.559681604365, 39648.40527392149, 39699.206015880096, 40061.599384005785, 40260.0, 40430.595694042684, 9519.0, 9669.371490853073, 9737.17234035115, 9746.75633109178, 9853.0, 10524.473776311306, 10575.788484230427, 10625.787484250426, 10662.89337106619, 10923.453827308762, 9546.809063818824, 10034.448105354275, 10075.294729369167, 10092.394456332644, 10703.090237329914, 10503.10723588473, 10536.894631053592, 10588.364698118137, 10868.0, 10986.230963832455, 9432.811343773223, 9447.858282125637, 9502.002289759752, 9604.711858644252, 9608.471534065415, 7775.727849525466, 7902.881456778038, 8269.09040005587, 8430.030546486987, 8452.36607254446, 8246.886670299433, 8284.627191776264, 8371.916280837113, 8576.399652024298, 8638.308935285037], "unit": "score", "name": "yui.html", "value": 5372.6551996071985}], "name": "dromaeo_css", "value": 6142.295428327183}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 113.0, 112.0, 114.0, 103.0, 112.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 154.0, 171.0, 137.0, 151.0, 161.0, 133.0, 183.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 160.0, 159.0, 162.0, 162.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 88.0, 107.0, 74.0, 75.0, 73.0, 121.0, 92.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 134.0, 98.0, 97.0, 98.0, 143.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 71.0, 69.0, 70.0, 69.0, 78.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 90.0, 84.0, 92.0, 84.0, 84.0, 85.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 127.0, 121.0, 121.0, 122.0, 129.0, 130.0, 125.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 149.0, 148.0, 147.0, 137.0, 147.0, 147.0, 148.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 74.0, 69.0, 70.0, 72.0, 70.0, 74.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1533.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [598.6959098992294], "unit": "score", "name": "Splay", "value": 136.1141752475247}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19655.513657940835}]} 15:51:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19655.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1533.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6142.30"}}} 15:51:46 INFO - Return code: 0 15:51:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:46 INFO - # TBPL SUCCESS # 15:51:46 INFO - Running post-action listener: _resource_record_post_action 15:51:46 INFO - Running post-run listener: _resource_record_post_run 15:51:47 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543350784; Read time: 12; Write time: 556228 15:51:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 228212736; Read time: 0; Write time: 374860 15:51:47 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314941440; Read time: 12; Write time: 181340 15:51:47 INFO - Running post-run listener: _upload_blobber_files 15:51:47 INFO - Blob upload gear active. 15:51:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:47 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 15:51:47 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'] 15:51:47 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 15:51:47 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:48 INFO - (blobuploader) - INFO - Done attempting. 15:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:49 INFO - (blobuploader) - INFO - Done attempting. 15:51:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:49 INFO - Return code: 0 15:51:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7c7cfb55699300efb2be07f1601394dd879264226d86e5488a3dd42660b27f7b692b7201aaf9c2f49b7d848428e6f2de9287b26d002f7c618a3dd63c3ae496", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d68bf660c07261da443efeca0856ee8f8ed4cb8fe402daf9c31dbbe9184a961f5b39d2bcfbf3bb5aad8a3edd9423b9c470df1b47c8a94bea5dffc4f8bb647a9c"} 15:51:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:49 INFO - Contents: 15:51:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7c7cfb55699300efb2be07f1601394dd879264226d86e5488a3dd42660b27f7b692b7201aaf9c2f49b7d848428e6f2de9287b26d002f7c618a3dd63c3ae496", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d68bf660c07261da443efeca0856ee8f8ed4cb8fe402daf9c31dbbe9184a961f5b39d2bcfbf3bb5aad8a3edd9423b9c470df1b47c8a94bea5dffc4f8bb647a9c"} 15:51:49 INFO - Copying logs to upload dir... 15:51:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.079619 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-29 15:51:48.731621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:48.735722) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 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/7f7c7cfb55699300efb2be07f1601394dd879264226d86e5488a3dd42660b27f7b692b7201aaf9c2f49b7d848428e6f2de9287b26d002f7c618a3dd63c3ae496", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d68bf660c07261da443efeca0856ee8f8ed4cb8fe402daf9c31dbbe9184a961f5b39d2bcfbf3bb5aad8a3edd9423b9c470df1b47c8a94bea5dffc4f8bb647a9c"} build_url:https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/P9w5o2J8QeSrRpGcsVMSaA/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/7f7c7cfb55699300efb2be07f1601394dd879264226d86e5488a3dd42660b27f7b692b7201aaf9c2f49b7d848428e6f2de9287b26d002f7c618a3dd63c3ae496", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d68bf660c07261da443efeca0856ee8f8ed4cb8fe402daf9c31dbbe9184a961f5b39d2bcfbf3bb5aad8a3edd9423b9c470df1b47c8a94bea5dffc4f8bb647a9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:48.762309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:48.762837) ========= 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=e10134013339c31d8d0c4708000001d6-1451431386.748568-1622595776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 15:51:48.845125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 15:51:48.845442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 15:51:48.845752) ========= ========= Total master_lag: 0.27 =========