builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1451441904.48 results: success (0) buildid: 20151229174137 builduid: b89e0cc9272f4e769cb546ad80aaab31 revision: 153a1790611f5456b04315b01d34c9369547713f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.482082) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.482734) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.483075) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006339 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.507445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.507811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.529565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.529878) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.579536) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.579810) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.580335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:24.580614) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 18:18: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-29 18:18:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.417035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.010392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.010703) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019557 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.059960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.060316) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 153a1790611f5456b04315b01d34c9369547713f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 153a1790611f5456b04315b01d34c9369547713f --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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 18:18:25,838 truncating revision to first 12 chars 2015-12-29 18:18:25,838 Setting DEBUG logging. 2015-12-29 18:18:25,838 attempt 1/10 2015-12-29 18:18:25,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/153a1790611f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 18:18:26,231 unpacking tar archive at: b2g-inbound-153a1790611f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.719922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.720305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.729485) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.729852) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 18:18:25.730345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-29 18:18:25.730678) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:26 INFO - MultiFileLogger online at 20151229 18:18:26 in /builds/slave/test 18:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 18:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:26 INFO - {'append_to_log': False, 18:18:26 INFO - 'base_work_dir': '/builds/slave/test', 18:18:26 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 18:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:26 INFO - 'branch': 'B2G-Inbound-Non-PGO', 18:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:26 INFO - 'config_files': ('talos/linux_config.py',), 18:18:26 INFO - 'default_actions': ('clobber', 18:18:26 INFO - 'read-buildbot-config', 18:18:26 INFO - 'download-and-extract', 18:18:26 INFO - 'populate-webroot', 18:18:26 INFO - 'create-virtualenv', 18:18:26 INFO - 'install', 18:18:26 INFO - 'run-tests'), 18:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:26 INFO - 'download_minidump_stackwalk': True, 18:18:26 INFO - 'download_symbols': 'ondemand', 18:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:26 INFO - 'installer_path': 'installer.exe', 18:18:26 INFO - 'log_level': 'info', 18:18:26 INFO - 'log_name': 'talos', 18:18:26 INFO - 'log_to_console': True, 18:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:26 INFO - 'opt_config_files': (), 18:18:26 INFO - 'pip_index': False, 18:18:26 INFO - 'sps_profile': False, 18:18:26 INFO - 'sps_profile_interval': 0, 18:18:26 INFO - 'suite': 'dromaeojs', 18:18:26 INFO - 'system_bits': '32', 18:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:26 INFO - 'title': 'talos-linux64-ix-035', 18:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:26 INFO - 'use_talos_json': True, 18:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:26 INFO - 'work_dir': 'build'} 18:18:26 INFO - ##### 18:18:26 INFO - ##### Running clobber step. 18:18:26 INFO - ##### 18:18:26 INFO - Running pre-action listener: _resource_record_pre_action 18:18:26 INFO - Running main action method: clobber 18:18:26 INFO - rmtree: /builds/slave/test/build 18:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:27 INFO - Running post-action listener: _resource_record_post_action 18:18:27 INFO - ##### 18:18:27 INFO - ##### Running read-buildbot-config step. 18:18:27 INFO - ##### 18:18:27 INFO - Running pre-action listener: _resource_record_pre_action 18:18:27 INFO - Running main action method: read_buildbot_config 18:18:27 INFO - Using buildbot properties: 18:18:27 INFO - { 18:18:27 INFO - "project": "", 18:18:27 INFO - "product": "firefox", 18:18:27 INFO - "script_repo_revision": "production", 18:18:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 18:18:27 INFO - "repository": "", 18:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 18:18:27 INFO - "buildid": "20151229174137", 18:18:27 INFO - "pgo_build": "False", 18:18:27 INFO - "basedir": "/builds/slave/test", 18:18:27 INFO - "buildnumber": 805, 18:18:27 INFO - "slavename": "talos-linux64-ix-035", 18:18:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:18:27 INFO - "platform": "ubuntu64_hw", 18:18:27 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 18:18:27 INFO - "branch": "b2g-inbound", 18:18:27 INFO - "repo_path": "integration/b2g-inbound", 18:18:27 INFO - "revision": "153a1790611f5456b04315b01d34c9369547713f", 18:18:27 INFO - "stage_platform": "linux64", 18:18:27 INFO - "builduid": "b89e0cc9272f4e769cb546ad80aaab31", 18:18:27 INFO - "slavebuilddir": "test" 18:18:27 INFO - } 18:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:18:27 INFO - Running post-action listener: _resource_record_post_action 18:18:27 INFO - ##### 18:18:27 INFO - ##### Running download-and-extract step. 18:18:27 INFO - ##### 18:18:27 INFO - Running pre-action listener: _resource_record_pre_action 18:18:27 INFO - Running main action method: download_and_extract 18:18:27 INFO - mkdir: /builds/slave/test/build/tests 18:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:27 INFO - https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/test_packages.json 18:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/test_packages.json 18:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:18:31 INFO - Downloaded 1302 bytes. 18:18:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:18:31 INFO - Using the following test package requirements: 18:18:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'jsshell-linux-x86_64.zip'], 18:18:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18: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')]} 18:18:31 INFO - https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:36 INFO - Downloaded 21945586 bytes. 18:18:36 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 18:18:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:36 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 18:18:37 INFO - Return code: 0 18:18:37 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 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:37 INFO - https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:39 INFO - Downloaded 21945586 bytes. 18:18:39 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 18:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:18:39 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 18:18:40 INFO - Return code: 0 18:18:40 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')]} 18:18:40 INFO - https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:41 INFO - Downloaded 11132270 bytes. 18:18:41 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 18:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:41 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 18:18:41 INFO - Return code: 0 18:18:41 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')]} 18:18:41 INFO - https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cVPw6BcER524dwJzi6TSVg/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 18:18:42 INFO - Downloaded 53332683 bytes. 18:18:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:18:42 INFO - mkdir: /builds/slave/test/properties 18:18:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:42 INFO - Contents: 18:18:42 INFO - build_url:https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:18:42 INFO - Running post-action listener: _resource_record_post_action 18:18:42 INFO - Running post-action listener: set_extra_try_arguments 18:18:42 INFO - ##### 18:18:42 INFO - ##### Running populate-webroot step. 18:18:42 INFO - ##### 18:18:42 INFO - Running pre-action listener: _resource_record_pre_action 18:18:42 INFO - Running main action method: populate_webroot 18:18:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:42 INFO - '--tppagecycles', 18:18:42 INFO - '7'], 18:18:42 INFO - 'tests': ['tsvgm']}}, 18:18:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:18:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'tests': ['damp', 'tps']}, 18:18:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['damp', 'tps']}, 18:18:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:18:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:42 INFO - 'other': {'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'other_l64': {'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'other_nol64': {'tests': ['a11yr', 18:18:42 INFO - 'ts_paint', 18:18:42 INFO - 'tpaint', 18:18:42 INFO - 'sessionrestore', 18:18:42 INFO - 'sessionrestore_no_auto_restore']}, 18:18:42 INFO - 'svgr': {'tests': ['tsvgx', 18:18:42 INFO - 'tsvgr_opacity', 18:18:42 INFO - 'tart', 18:18:42 INFO - 'tscrollx', 18:18:42 INFO - 'cart']}, 18:18:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['tsvgx', 18:18:42 INFO - 'tsvgr_opacity', 18:18:42 INFO - 'tart', 18:18:42 INFO - 'tscrollx', 18:18:42 INFO - 'cart']}, 18:18:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'tests': ['tp5o']}, 18:18:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'talos_options': ['--e10s'], 18:18:42 INFO - 'tests': ['tp5o']}, 18:18:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'talos_options': ['--xperf_path', 18:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:42 INFO - 'tests': ['tp5n']}, 18:18:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:42 INFO - 'talos_options': ['--e10s', 18:18:42 INFO - '--xperf_path', 18:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:42 INFO - 'tests': ['tp5n']}}, 18:18:42 INFO - 'talos.zip': {'path': '', 18:18:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:42 INFO - Running post-action listener: _resource_record_post_action 18:18:42 INFO - ##### 18:18:42 INFO - ##### Running create-virtualenv step. 18:18:42 INFO - ##### 18:18:42 INFO - Running pre-action listener: _resource_record_pre_action 18:18:42 INFO - Running main action method: create_virtualenv 18:18:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:42 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 18:18:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:42 INFO - Using real prefix '/usr' 18:18:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:45 INFO - Installing pip.................done. 18:18:45 INFO - Return code: 0 18:18:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:45 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')]} 18:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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')]} 18:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18:45 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 18:18:45 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 18:18:45 INFO - Using env: {'DISPLAY': ':0', 18:18:45 INFO - 'HOME': '/home/cltbld', 18:18:45 INFO - 'LANG': 'en_US.UTF-8', 18:18:45 INFO - 'LANGUAGE': 'en_US:en', 18:18:45 INFO - 'LOGNAME': 'cltbld', 18:18:45 INFO - 'MAIL': '/var/mail/cltbld', 18:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:45 INFO - 'MOZ_NO_REMOTE': '1', 18:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:45 INFO - 'NO_EM_RESTART': '1', 18:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:45 INFO - 'PWD': '/builds/slave/test', 18:18:45 INFO - 'SHELL': '/bin/bash', 18:18:45 INFO - 'SHLVL': '1', 18:18:45 INFO - 'TERM': 'linux', 18:18:45 INFO - 'TMOUT': '86400', 18:18:45 INFO - 'USER': 'cltbld', 18:18:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:45 INFO - '_': '/tools/buildbot/bin/python'} 18:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:45 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 18:18:45 INFO - Cleaning up... 18:18:45 INFO - Return code: 0 18:18:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:18:45 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')]} 18:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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')]} 18:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18:45 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 18:18:45 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 18:18:45 INFO - Using env: {'DISPLAY': ':0', 18:18:45 INFO - 'HOME': '/home/cltbld', 18:18:45 INFO - 'LANG': 'en_US.UTF-8', 18:18:45 INFO - 'LANGUAGE': 'en_US:en', 18:18:45 INFO - 'LOGNAME': 'cltbld', 18:18:45 INFO - 'MAIL': '/var/mail/cltbld', 18:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:45 INFO - 'MOZ_NO_REMOTE': '1', 18:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:45 INFO - 'NO_EM_RESTART': '1', 18:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:45 INFO - 'PWD': '/builds/slave/test', 18:18:45 INFO - 'SHELL': '/bin/bash', 18:18:45 INFO - 'SHLVL': '1', 18:18:45 INFO - 'TERM': 'linux', 18:18:45 INFO - 'TMOUT': '86400', 18:18:45 INFO - 'USER': 'cltbld', 18:18:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:45 INFO - '_': '/tools/buildbot/bin/python'} 18:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:45 INFO - Downloading/unpacking psutil>=0.7.1 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:45 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 18:18:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:18:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:47 INFO - Installing collected packages: psutil 18:18:47 INFO - Running setup.py install for psutil 18:18:47 INFO - building 'psutil._psutil_linux' extension 18:18:47 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 18:18:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:18:47 INFO - building 'psutil._psutil_posix' extension 18:18:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:18:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:48 INFO - Successfully installed psutil 18:18:48 INFO - Cleaning up... 18:18:48 INFO - Return code: 0 18:18:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', '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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:18: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 mozsystemmonitor==0.0.0 18:18:48 INFO - Using env: {'DISPLAY': ':0', 18:18:48 INFO - 'HOME': '/home/cltbld', 18:18:48 INFO - 'LANG': 'en_US.UTF-8', 18:18:48 INFO - 'LANGUAGE': 'en_US:en', 18:18:48 INFO - 'LOGNAME': 'cltbld', 18:18:48 INFO - 'MAIL': '/var/mail/cltbld', 18:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:48 INFO - 'MOZ_NO_REMOTE': '1', 18:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:48 INFO - 'NO_EM_RESTART': '1', 18:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:48 INFO - 'PWD': '/builds/slave/test', 18:18:48 INFO - 'SHELL': '/bin/bash', 18:18:48 INFO - 'SHLVL': '1', 18:18:48 INFO - 'TERM': 'linux', 18:18:48 INFO - 'TMOUT': '86400', 18:18:48 INFO - 'USER': 'cltbld', 18:18:48 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:48 INFO - '_': '/tools/buildbot/bin/python'} 18:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:18:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:18:50 INFO - Installing collected packages: mozsystemmonitor 18:18:50 INFO - Running setup.py install for mozsystemmonitor 18:18:50 INFO - Successfully installed mozsystemmonitor 18:18:50 INFO - Cleaning up... 18:18:50 INFO - Return code: 0 18:18:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:50 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18:50 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 18:18:50 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 18:18:50 INFO - Using env: {'DISPLAY': ':0', 18:18:50 INFO - 'HOME': '/home/cltbld', 18:18:50 INFO - 'LANG': 'en_US.UTF-8', 18:18:50 INFO - 'LANGUAGE': 'en_US:en', 18:18:50 INFO - 'LOGNAME': 'cltbld', 18:18:50 INFO - 'MAIL': '/var/mail/cltbld', 18:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:50 INFO - 'MOZ_NO_REMOTE': '1', 18:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:50 INFO - 'NO_EM_RESTART': '1', 18:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:50 INFO - 'PWD': '/builds/slave/test', 18:18:50 INFO - 'SHELL': '/bin/bash', 18:18:50 INFO - 'SHLVL': '1', 18:18:50 INFO - 'TERM': 'linux', 18:18:50 INFO - 'TMOUT': '86400', 18:18:50 INFO - 'USER': 'cltbld', 18:18:50 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:50 INFO - '_': '/tools/buildbot/bin/python'} 18:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:52 INFO - Downloading docopt-0.6.1.tar.gz 18:18:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:53 INFO - Running setup.py install for blobuploader 18:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:53 INFO - Running setup.py install for requests 18:18:53 INFO - Running setup.py install for docopt 18:18:53 INFO - Successfully installed blobuploader requests docopt 18:18:53 INFO - Cleaning up... 18:18:53 INFO - Return code: 0 18:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:53 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18:53 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 18:18:53 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 18:18:53 INFO - Using env: {'DISPLAY': ':0', 18:18:53 INFO - 'HOME': '/home/cltbld', 18:18:53 INFO - 'LANG': 'en_US.UTF-8', 18:18:53 INFO - 'LANGUAGE': 'en_US:en', 18:18:53 INFO - 'LOGNAME': 'cltbld', 18:18:53 INFO - 'MAIL': '/var/mail/cltbld', 18:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:53 INFO - 'MOZ_NO_REMOTE': '1', 18:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:53 INFO - 'NO_EM_RESTART': '1', 18:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:53 INFO - 'PWD': '/builds/slave/test', 18:18:53 INFO - 'SHELL': '/bin/bash', 18:18:53 INFO - 'SHLVL': '1', 18:18:53 INFO - 'TERM': 'linux', 18:18:53 INFO - 'TMOUT': '86400', 18:18:53 INFO - 'USER': 'cltbld', 18:18:53 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:53 INFO - '_': '/tools/buildbot/bin/python'} 18:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:53 INFO - Running setup.py (path:/tmp/pip-8cMmKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:53 INFO - Running setup.py (path:/tmp/pip-J7k0c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:54 INFO - Running setup.py (path:/tmp/pip-my8vhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:54 INFO - Running setup.py (path:/tmp/pip-jKlUGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:54 INFO - Running setup.py (path:/tmp/pip-9SxXde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:54 INFO - Running setup.py (path:/tmp/pip-Vz3a45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:54 INFO - Running setup.py (path:/tmp/pip-aPl6yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:54 INFO - Running setup.py (path:/tmp/pip-6cxM3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:54 INFO - Running setup.py (path:/tmp/pip-QyPCcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:54 INFO - Running setup.py (path:/tmp/pip-vGbzul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:54 INFO - Running setup.py (path:/tmp/pip-iiFzz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:54 INFO - Running setup.py (path:/tmp/pip-4PWpVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:54 INFO - Running setup.py (path:/tmp/pip-x1kwPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:54 INFO - Running setup.py (path:/tmp/pip-xhjtSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:54 INFO - Running setup.py (path:/tmp/pip-im6NWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:54 INFO - Running setup.py (path:/tmp/pip-99OAQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:55 INFO - Running setup.py (path:/tmp/pip-tGYDow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:55 INFO - Running setup.py install for manifestparser 18:18:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Running setup.py install for mozcrash 18:18:55 INFO - Running setup.py install for mozdebug 18:18:55 INFO - Running setup.py install for mozdevice 18:18:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Running setup.py install for mozfile 18:18:55 INFO - Running setup.py install for mozhttpd 18:18:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Running setup.py install for mozinfo 18:18:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Running setup.py install for mozInstall 18:18:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:55 INFO - Running setup.py install for mozleak 18:18:55 INFO - Running setup.py install for mozlog 18:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for moznetwork 18:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozprocess 18:18:56 INFO - Running setup.py install for mozprofile 18:18:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozrunner 18:18:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Running setup.py install for mozscreenshot 18:18:56 INFO - Running setup.py install for moztest 18:18:56 INFO - Running setup.py install for mozversion 18:18:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:56 INFO - Cleaning up... 18:18:56 INFO - Return code: 0 18:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:56 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')]} 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:56 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')]} 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:56 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:18:56 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 18:18:56 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 18:18:56 INFO - Using env: {'DISPLAY': ':0', 18:18:56 INFO - 'HOME': '/home/cltbld', 18:18:56 INFO - 'LANG': 'en_US.UTF-8', 18:18:56 INFO - 'LANGUAGE': 'en_US:en', 18:18:56 INFO - 'LOGNAME': 'cltbld', 18:18:56 INFO - 'MAIL': '/var/mail/cltbld', 18:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:56 INFO - 'MOZ_NO_REMOTE': '1', 18:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:56 INFO - 'NO_EM_RESTART': '1', 18:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:56 INFO - 'PWD': '/builds/slave/test', 18:18:56 INFO - 'SHELL': '/bin/bash', 18:18:56 INFO - 'SHLVL': '1', 18:18:56 INFO - 'TERM': 'linux', 18:18:56 INFO - 'TMOUT': '86400', 18:18:56 INFO - 'USER': 'cltbld', 18:18:56 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:56 INFO - '_': '/tools/buildbot/bin/python'} 18:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:57 INFO - Running setup.py (path:/tmp/pip-ODEygQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:57 INFO - Running setup.py (path:/tmp/pip-hTttsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:57 INFO - Running setup.py (path:/tmp/pip-6uC_oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:57 INFO - Running setup.py (path:/tmp/pip-PxSCof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:57 INFO - Running setup.py (path:/tmp/pip-nVkl0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:57 INFO - Running setup.py (path:/tmp/pip-HKKqzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:57 INFO - Running setup.py (path:/tmp/pip-_qyAoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:57 INFO - Running setup.py (path:/tmp/pip-hVgWjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:57 INFO - Running setup.py (path:/tmp/pip-a4Ijbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:57 INFO - Running setup.py (path:/tmp/pip-218fLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:57 INFO - Running setup.py (path:/tmp/pip-S7Mdyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:57 INFO - Running setup.py (path:/tmp/pip-owfepw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:57 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)) 18:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:57 INFO - Running setup.py (path:/tmp/pip-7Yyqav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:58 INFO - Running setup.py (path:/tmp/pip-CqdePe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:58 INFO - Running setup.py (path:/tmp/pip-fTYrzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:58 INFO - Running setup.py (path:/tmp/pip-GzdqH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:58 INFO - Running setup.py (path:/tmp/pip-A7TT9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:59 INFO - Downloading blessings-1.5.1.tar.gz 18:18:59 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 18:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:00 INFO - Installing collected packages: blessings 18:19:00 INFO - Running setup.py install for blessings 18:19:00 INFO - Successfully installed blessings 18:19:00 INFO - Cleaning up... 18:19:00 INFO - Return code: 0 18:19:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:00 INFO - Reading from file tmpfile_stdout 18:19:00 INFO - Current package versions: 18:19:00 INFO - argparse == 1.2.1 18:19:00 INFO - blessings == 1.5.1 18:19:00 INFO - blobuploader == 1.2.4 18:19:00 INFO - docopt == 0.6.1 18:19:00 INFO - manifestparser == 1.1 18:19:00 INFO - mozInstall == 1.12 18:19:00 INFO - mozcrash == 0.16 18:19:00 INFO - mozdebug == 0.1 18:19:00 INFO - mozdevice == 0.47 18:19:00 INFO - mozfile == 1.2 18:19:00 INFO - mozhttpd == 0.7 18:19:00 INFO - mozinfo == 0.9 18:19:00 INFO - mozleak == 0.1 18:19:00 INFO - mozlog == 3.1 18:19:00 INFO - moznetwork == 0.27 18:19:00 INFO - mozprocess == 0.22 18:19:00 INFO - mozprofile == 0.28 18:19:00 INFO - mozrunner == 6.11 18:19:00 INFO - mozscreenshot == 0.1 18:19:00 INFO - mozsystemmonitor == 0.0 18:19:00 INFO - moztest == 0.7 18:19:00 INFO - mozversion == 1.4 18:19:00 INFO - psutil == 3.1.1 18:19:00 INFO - requests == 1.2.3 18:19:00 INFO - wsgiref == 0.1.2 18:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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/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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:19: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/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 18:19: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/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 18:19:00 INFO - Using env: {'DISPLAY': ':0', 18:19:00 INFO - 'HOME': '/home/cltbld', 18:19:00 INFO - 'LANG': 'en_US.UTF-8', 18:19:00 INFO - 'LANGUAGE': 'en_US:en', 18:19:00 INFO - 'LOGNAME': 'cltbld', 18:19:00 INFO - 'MAIL': '/var/mail/cltbld', 18:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:00 INFO - 'MOZ_NO_REMOTE': '1', 18:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:00 INFO - 'NO_EM_RESTART': '1', 18:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:00 INFO - 'PWD': '/builds/slave/test', 18:19:00 INFO - 'SHELL': '/bin/bash', 18:19:00 INFO - 'SHLVL': '1', 18:19:00 INFO - 'TERM': 'linux', 18:19:00 INFO - 'TMOUT': '86400', 18:19:00 INFO - 'USER': 'cltbld', 18:19:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:00 INFO - '_': '/tools/buildbot/bin/python'} 18:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 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)) 18:19:00 INFO - Cleaning up... 18:19:00 INFO - Return code: 0 18:19:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:19:00 INFO - Using env: {'DISPLAY': ':0', 18:19:00 INFO - 'HOME': '/home/cltbld', 18:19:00 INFO - 'LANG': 'en_US.UTF-8', 18:19:00 INFO - 'LANGUAGE': 'en_US:en', 18:19:00 INFO - 'LOGNAME': 'cltbld', 18:19:00 INFO - 'MAIL': '/var/mail/cltbld', 18:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:00 INFO - 'MOZ_NO_REMOTE': '1', 18:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:00 INFO - 'NO_EM_RESTART': '1', 18:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:00 INFO - 'PWD': '/builds/slave/test', 18:19:00 INFO - 'SHELL': '/bin/bash', 18:19:00 INFO - 'SHLVL': '1', 18:19:00 INFO - 'TERM': 'linux', 18:19:00 INFO - 'TMOUT': '86400', 18:19:00 INFO - 'USER': 'cltbld', 18:19:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:00 INFO - '_': '/tools/buildbot/bin/python'} 18:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:00 INFO - Downloading/unpacking jsonschema 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:02 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 18:19:02 INFO - Downloading/unpacking functools32 (from jsonschema) 18:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:02 INFO - warning: no files found matching '*.txt' 18:19:02 INFO - no previously-included directories found matching 'build' 18:19:02 INFO - no previously-included directories found matching 'dist' 18:19:02 INFO - no previously-included directories found matching '.git*' 18:19:02 INFO - Installing collected packages: jsonschema, functools32 18:19:03 INFO - Running setup.py install for functools32 18:19:03 INFO - warning: no files found matching '*.txt' 18:19:03 INFO - no previously-included directories found matching 'build' 18:19:03 INFO - no previously-included directories found matching 'dist' 18:19:03 INFO - no previously-included directories found matching '.git*' 18:19:03 INFO - Successfully installed jsonschema functools32 18:19:03 INFO - Cleaning up... 18:19:03 INFO - Return code: 0 18:19:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:03 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 0x7ff3fc01af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26fbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', '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 18:19:03 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 18:19:03 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 18:19:03 INFO - Using env: {'DISPLAY': ':0', 18:19:03 INFO - 'HOME': '/home/cltbld', 18:19:03 INFO - 'LANG': 'en_US.UTF-8', 18:19:03 INFO - 'LANGUAGE': 'en_US:en', 18:19:03 INFO - 'LOGNAME': 'cltbld', 18:19:03 INFO - 'MAIL': '/var/mail/cltbld', 18:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:03 INFO - 'MOZ_NO_REMOTE': '1', 18:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:03 INFO - 'NO_EM_RESTART': '1', 18:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:03 INFO - 'PWD': '/builds/slave/test', 18:19:03 INFO - 'SHELL': '/bin/bash', 18:19:03 INFO - 'SHLVL': '1', 18:19:03 INFO - 'TERM': 'linux', 18:19:03 INFO - 'TMOUT': '86400', 18:19:03 INFO - 'USER': 'cltbld', 18:19:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:03 INFO - '_': '/tools/buildbot/bin/python'} 18:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:03 INFO - Downloading/unpacking flake8 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:19:05 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 18:19:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:19:05 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 18:19:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 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 18:19:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:19:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:05 INFO - no previously-included directories found matching 'docs/_build' 18:19:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:19:05 INFO - Running setup.py install for pep8 18:19:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:05 INFO - no previously-included directories found matching 'docs/_build' 18:19:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:19:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Running post-action listener: _resource_record_post_action 18:19:05 INFO - Running post-action listener: _start_resource_monitoring 18:19:05 INFO - Starting resource monitoring. 18:19:05 INFO - ##### 18:19:05 INFO - ##### Running install step. 18:19:05 INFO - ##### 18:19:05 INFO - Running pre-action listener: _resource_record_pre_action 18:19:05 INFO - Running main action method: install 18:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:06 INFO - Reading from file tmpfile_stdout 18:19:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:06 INFO - Reading from file tmpfile_stdout 18:19:06 INFO - Output received: 18:19:06 INFO - Usage: mozinstall [options] installer 18:19:06 INFO - Options: 18:19:06 INFO - -h, --help show this help message and exit 18:19:06 INFO - -d DEST, --destination=DEST 18:19:06 INFO - Directory to install application into. [default: 18:19:06 INFO - "/builds/slave/test"] 18:19:06 INFO - --app=APP Application being installed. [default: firefox] 18:19:06 INFO - mkdir: /builds/slave/test/build/application 18:19:06 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'] 18:19:06 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 18:19:21 INFO - Reading from file tmpfile_stdout 18:19:21 INFO - Output received: 18:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:21 INFO - Running post-action listener: _resource_record_post_action 18:19:21 INFO - ##### 18:19:21 INFO - ##### Running run-tests step. 18:19:21 INFO - ##### 18:19:21 INFO - Running pre-action listener: _resource_record_pre_action 18:19:21 INFO - Running main action method: run_tests 18:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:21 INFO - Python 2.7.3 18:19:21 INFO - Return code: 0 18:19:21 INFO - grabbing minidump binary from tooltool 18:19:21 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')]} 18:19:21 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 0x278e3d0>, '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 0x26f9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fa360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:21 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 18:19:21 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 18:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:21 INFO - Return code: 0 18:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:19:22 INFO - Return code: 0 18:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 18:19:22 INFO - Using env: {'DISPLAY': ':0', 18:19:22 INFO - 'HOME': '/home/cltbld', 18:19:22 INFO - 'LANG': 'en_US.UTF-8', 18:19:22 INFO - 'LANGUAGE': 'en_US:en', 18:19:22 INFO - 'LOGNAME': 'cltbld', 18:19:22 INFO - 'MAIL': '/var/mail/cltbld', 18:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:22 INFO - 'MOZ_NO_REMOTE': '1', 18:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:22 INFO - 'NO_EM_RESTART': '1', 18:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:22 INFO - 'PWD': '/builds/slave/test', 18:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:22 INFO - 'SHELL': '/bin/bash', 18:19:22 INFO - 'SHLVL': '1', 18:19:22 INFO - 'TERM': 'linux', 18:19:22 INFO - 'TMOUT': '86400', 18:19:22 INFO - 'USER': 'cltbld', 18:19:22 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202', 18:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:22 INFO - '_': '/tools/buildbot/bin/python'} 18:19:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 18:19:22 INFO - mozversion application_buildid: 20151229174137 18:19:22 INFO - mozversion application_changeset: 153a1790611f5456b04315b01d34c9369547713f 18:19:22 INFO - mozversion application_display_name: Nightly 18:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:22 INFO - mozversion application_name: Firefox 18:19:22 INFO - mozversion application_remotingname: firefox 18:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 18:19:22 INFO - mozversion application_vendor: Mozilla 18:19:22 INFO - mozversion application_version: 46.0a1 18:19:22 INFO - mozversion platform_buildid: 20151229174137 18:19:22 INFO - mozversion platform_changeset: 153a1790611f5456b04315b01d34c9369547713f 18:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 18:19:22 INFO - mozversion platform_version: 46.0a1 18:19:22 INFO - using testdate: 1451441962 18:19:22 INFO - actual date: 1451441962 18:19:23 INFO - starting webserver on 'localhost:46722' 18:19:23 INFO - SUITE-START | Running 3 tests 18:19:23 INFO - TEST-START | dromaeo_css 18:19:23 INFO - operating with platform_type : linux_ 18:19:23 INFO - Initialising browser for dromaeo_css test... 18:19:23 INFO - TEST-INFO | started process 26166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtF0pC/profile http://localhost:46722/getInfo.html) 18:19:27 INFO - PROCESS | 26166 | __metrics Screen width/height:1600/1200 18:19:27 INFO - PROCESS | 26166 | colorDepth:24 18:19:27 INFO - PROCESS | 26166 | Browser inner width/height: 1024/697 18:19:27 INFO - PROCESS | 26166 | __metrics 18:19:27 INFO - PROCESS | 26166 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:19:27 INFO - PROCESS | 26166 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:28 INFO - TEST-INFO | 26166: exit 0 18:19:28 INFO - Browser initialized. 18:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:28 INFO - TEST-INFO | started process 26259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtF0pC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:40 INFO - PROCESS | 26259 | RSS: Main: 148930560 18:19:40 INFO - PROCESS | 26259 | 18:20:31 INFO - PROCESS | 26259 | 1451442031532 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] 18:22:43 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46722/tests/dromaeo/cssquery-ext.html) 18:22:44 INFO - PROCESS | 26259 | RSS: Main: 244908032 18:22:44 INFO - PROCESS | 26259 | 18:25:47 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-ext.html (next: http://localhost:46722/tests/dromaeo/cssquery-jquery.html) 18:25:47 INFO - PROCESS | 26259 | RSS: Main: 229765120 18:25:47 INFO - PROCESS | 26259 | 18:28:49 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46722/tests/dromaeo/cssquery-mootools.html) 18:28:50 INFO - PROCESS | 26259 | RSS: Main: 235802624 18:28:50 INFO - PROCESS | 26259 | 18:31:52 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46722/tests/dromaeo/cssquery-prototype.html) 18:31:52 INFO - PROCESS | 26259 | RSS: Main: 213995520 18:31:52 INFO - PROCESS | 26259 | 18:34:55 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46722/tests/dromaeo/cssquery-yui.html) 18:34:56 INFO - PROCESS | 26259 | RSS: Main: 219725824 18:34:56 INFO - PROCESS | 26259 | 18:37:58 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:46722/tests/dromaeo/cssquery-yui.html (next: http://localhost:46722/tests/dromaeo/cssquery-dojo.html) 18:37:59 INFO - PROCESS | 26259 | RSS: Main: 259911680 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | __start_tp_report 18:37:59 INFO - PROCESS | 26259 | _x_x_mozilla_page_load 18:37:59 INFO - PROCESS | 26259 | _x_x_mozilla_page_load_details 18:37:59 INFO - PROCESS | 26259 | |i|pagename|runs| 18:37:59 INFO - PROCESS | 26259 | |0;dojo.html;2625.4486557822856;2701.797365197611;2701.8784154713035;2706.134037108125;2726.9590956135658;4500.21246281901;4618.861434156972;4692.929606055907;4693.929591056132;4694.788734506947;4649.046945376198;4651.488336283014;4749.335093086971;4755.191617425037;4786.042791441717;4287.8070486828165;4308.0737641407095;4312.331588603772;4368.956310436903;4388.626966707834;4174.35297528882;4378.6934914555995;4386.802593883267;4434.844780432685;4444.622207112399;4249.468816397965;4260.70175087744;4270.402143699885;4380.102079073782;4383.846565370197;4326.351047342892;4334.544872788343;4339.7396156230725;4343.9348409773875;4378.299472084483;4317.136572685476;4318.676099292566;4325.82696692132;4341.848035318781;4360.607545320936;4438.025994721398;4577.610903073243;4586.495485496593;4603.654725895538;4723.952760472385;4939.357883475125;4953.356063711694;4958.826441074545;4965.528274813887;4999.875003124915;4973.055119527278;4981.526754958273;4986.077575648516;4990.151674215392;5046.21783623539;4472.84345047925;4573.817047318136;4591.609713174417;4597.770111494412;4700.153972285021;5107.080725469451;5141.742912854417;5141.922871156936;5142.331496905378;5152.458991805881;4936;4941.382327209099;4954.355933728592;4957.677750946177;4985.252212168131;4745.881352966204;4834.564889159922;4860.756962151878;4877.902441951142;4966.776495057731;4943.530364615356;4951.183054795991;4956.801727930914;4962.354893863847;4963.478834722302;4919.434265059493;4926.802927882916;4929.950700492949;4930.433000205022;4960.603151747851;4022.1955608878343;4057.91884162321;4103.753774773523;4210.115875666083;4252.468441444819;3652.123490362347;3664.4686520454384;3714.182879766447;3740.532433445819;3747;4267.4238977737605;4283.507396649363;4289.506706728704;4292.871213863589;4320.330348795942;4744.383230180124;5009.073321435546;5036.7733451994745;5087.491250874957;5089.796408143633;4212.052288235122;4219.556946520633;4261.339492378686;4362.476502819619;4367.716098453654;4514.932276015862;4517.254652982221;4533.863984080483;4534.614557762628;4556.7721613919175;4798.1123492153365;4805.37530121082;4806.279058141236;4822.903541929142;4849.636277279289;4845.878853028561;4904.681195722266;4977.4773648767805;4978.203487442137;5034.748262586929;4799.616030717604;4819.975900120477;4827.08285425768;4836.733979631154;4867.829625963074;4964.280179373898;4987.351644286219;4988.2018876980965;5004.099262132851;5004.47453017428;4771.427428708577;4852.51474852526;4892.877678058077;5019.874503137305;5080.390353157644;4885.682430641997;4887.975560122177;4889.682170658896;4895.167821470287;4938.925916111333;4847.030593881167;4854.95145048545;4857.441394239567;4859.173940430206;4908.092002979461;4582.88542786433;4705.5059218781535;4708.4349878014855;4745.572898439157;4779.665423420327;4958.057968985881;4966.776495057803;4970.577500912463;4977.054359671651;4987.1521841287795;4830.734309613005;4836.975815120902;4838.443578988461;4842;4887 18:37:59 INFO - PROCESS | 26259 | |1;ext.html;495.8785097651076;504.98737531561704;506.0915656396765;522.6984807828507;535.9758810853511;24460.633090503634;24844.130455434064;24958.126465573707;25001.874990625023;30655.38689226214;36126.63873361266;36621.26757464849;36663.08342291444;36686.8165659172;36715;7423.814404639887;7561.281678240586;7572.280633339824;7581;7581.166071732105;6774.051632771416;6907.9654601726925;9648.276379271547;9873.654422095227;9886.505674716236;9642.891067527218;9737.1236588707;9743.756406089833;9752.707418777449;9758.072983066633;6779.796606101775;6922;9602.999999999965;9669.564869580885;9701.902980970206;9753.853692194623;10030.799384012353;10033.698989030341;10035.046670566284;10036.14692751117;32952.176195595064;33341.16647083818;33364.83317583396;33400.66599334;33429.83285083583;2665.2803742989286;2770.2104900103577;3207.0378886334006;3304.4052070627276;3361.865525378982;25722.742772572223;25785.74214257852;26515.337116572045;27761.72238277632;28027.719722802714;3388.6272510023878;3403;3408.062782734743;3436.6735160159747;3529.911752206215;216441;216722;217268;217388;217817.99999999843;51452.22821657678;51803.48196518062;52057.73971130196;52088.739556301975;52096;47041.764791175825;48062.51937480651;55568;55591.722041389534;56926;11009;11154.330740155616;11187;11211.159163062639;11219.551217951353;8626.913730862736;8765.123487651312;8813.603387847563;8832.646694132163;8833.293336533063;16823;16994.06532640692;17054;17081.829181708024;17265.482035538953;6981.79054628362;7157.284271572905;7214.855702885913;7237.638118094074;7308;784.5880912520859;812.5612169428442;911.3392790227032;971.9697121051707;1036.3160314192749;23532.29403117909;25284.115055972954;27894.32634041964;28068.719312807018;28581.14256572306;890.955452227386;891.3047822698305;895.7939673875045;916.4455504419864;1010.7018429563296;12205.389730513616;12262;12318.199317044364;12336.568220112433;12387.442565084593;258481;258665;259698;260930;262636;43105.568944310784;43494;43519.564804351554;43533.56466435359;43593;1152.2798251093068;1165.4638866121509;1167.3404526442532;1172.454808514045;1304.341307639636;24036.450925495737;24759.87620061888;25438;25484.617730733684;25487.87256063708;32546.349073018882;32696.836515817267;33253.16867078342;34814.303713925074;35557;158242;158474.20762896113;159397;159431;159439;23453.76546234584;25350.873245633655;25692.486150277262;25726;25730.68423841863;26012.609810852475;26480.86759566267;29370.853145734134;29908;34865.47701784526;29382.55926161152;31944.201394965312;32571.34857302888;33043.83478082594;33120.66879331176;27863.721362786113;32614.83692581522;32778.50832237566;32822.507662385564;35293.82353088218;29881.252968675955;31177;31274.374512510076;31363;31372.84313578509;26270.73729262683;28274.575881361383;28594.714052859206;28729;28798.424031518833;22493;22844.4288892779;22856.54286914219;22866.885665571564;24275.39311517226 18:37:59 INFO - PROCESS | 26259 | |2;jquery.html;335.7649645248327;337.16551534951;339.6857906436546;340.684866498489;341.29352240861414;14123.788143177848;14497.49258775943;14623.488177913776;15222.391104355813;15233.619159521017;8490.320774338054;8669.783255418602;8686.348523860705;8696.782580435476;9599.760005999853;3457.239407330383;4156.355764856452;4269.252880745873;4283.250431174548;4296.548862369453;3909.550401703812;3945;5788.82633520995;5791.971040144794;5793.884122317551;5730.656160630355;5730.942690573103;5738.0532212184935;5738.196652468637;5738.196652468658;3454.9654503455145;3577.749557530974;4799.880002999936;4989;4992.500749925015;4796.640251981115;4939.506049395031;4959.404871415417;4963.181075122637;4963.726995015273;16614.916925415295;16850.578735531588;17100.572485687833;17121.400750973782;17307.221175047154;1619.093307747665;1636.2473262299357;1690.5435532406304;1697.2701738252547;1715.7941047074305;8538;8689.3048556116;8704;9975.650852220137;12598.559050433283;1649.546374746942;1659.9336026558924;1695.6608678264397;1706.2321955120246;1714.8971061736336;54740;58450.70774646142;58556.121658175165;58780.70609646967;59547;9554.761130971643;9751.463669498246;9799.853002204973;9945.651902183388;9991.950040249752;12652.683682907817;12670.303133327756;12686.302253376152;12712.42794074269;12723.491060357483;6079.574429789961;6307.905381419282;6382.5532212744665;6415.166028416276;6512.674366281762;5984.910226346608;5994.970025149846;6029.427204415573;6036;6059;4126.731762435492;4155.231282212801;4177.832886684499;4180.770057646798;4213.578642135823;1730.8182640822533;1753.8947663139998;1754.1492376197534;1757.0775342945055;1764.858811295119;835.8161204535114;851.1701091435924;964.1900803325241;974.878140232471;998.1964518562627;12422.37888105591;14224.786628200585;14468.927655361656;15003.2498375083;15070.397184112513;827.6399766101765;839.5969934431507;855.2302927365297;855.320020583625;904.0868722590232;7023.508354415142;8040.115587285394;8171.877421838677;8179.509229446133;8368.456050356708;102944;103368.48315758523;103724;104012;104206;63481.682591586745;64397.35602644007;65108;67416;75383.62308188534;1025.5385076715509;1030.855680204772;1034.270839058462;1050.648032908984;1059.057438879398;13442.865571344162;13892.30538473052;14268.857311426753;14336.641583960485;14643.194624295766;28204.85897570499;28515;29689.851550742107;29859.552106718853;30032.09903702805;34744.82627586846;41217.38173927333;41231.381529277685;44289;46908;7696.345810606162;8535;8610.268127209007;8620.65517379323;8625.654973801229;9884.950575247078;9988.850167247643;15213.695726085638;15956.361745530514;16004.359825606845;12371;12388.752224955631;12525.185862918881;12688.17526860788;13080.149790263602;10612.575496980035;11686.532538698697;13016.958643308702;13326.600201993955;13372.665683357995;11790.882091178979;11799.52801887915;11939.76120477603;12967;13118.606441806762;8630;9132;9256.907430925605;9284.396514226553;9331.813363732552;13356.666083347995;13482.52811151605;13622;13848;14258.71482570322 18:37:59 INFO - PROCESS | 26259 | |3;mootools.html;1219.7377563823777;1376.4219028008235;1397.3013493253372;1467.706458708258;1646.1933652510274;5819.156222347757;6007.939920600793;6584.440322572587;6624.701888415021;6694.5648532845335;6766.289539598345;6837.863242735142;6916.481263905214;6931.965340173305;6933.237343892168;1727.9136043197852;1756.5872020075335;2082.541840795023;2121.1727426303755;2122.4375540481783;2100.4538819906857;2132.360291912428;2136.412486566191;2137.412211641803;2137.935861924137;1995.6008798240337;2023.8482113841521;2028.8376929845576;2042.2647846775149;2042.336240721764;2013.1544751204528;2021.6765317549196;2051.774304826468;2055.599158164151;2056.1158701758236;1843.8709290349682;1853.0179005127304;1853.5551467647801;1854.9258029678797;1859.8326150646508;6861.2795656455855;6865.382115609569;6905.102336696247;6907.067545881292;6917.9308206917785;4040.919181616351;4112.259793237216;4116.876493705194;4120.320147175712;4120.793960302003;2680.624712540246;2743.492453896016;2749.766269867064;2753.0914798116573;2780.8609569521645;851.5316575883239;855.6620135046684;877.3419935048713;878.775912142406;882.5057967538135;9582.712518624452;9588.520573971273;9590.808183836354;9601.90398096017;9620.518974051269;3848.807559622008;3914.5693973662874;3926.1362500249897;3935.4490371348033;3999.7600143991453;8284.337253019745;8284.378671599654;8297.294729947902;8321.459105158145;8323.583820808935;4234.301340278881;4263.957360426418;4268.189044081614;4268.893277668021;4276.914461710749;3877.806109694504;3878.7478813877005;3881.146147847469;3883.980580097138;3891.2412079644196;2895.406441679451;2925.3710452252867;3352.949705754416;3398.8640454382044;3474.7915125092068;1088.2491081154137;1096.2435919215716;1100.273819279272;1111.2388014210292;1111.4553868604326;872.097379212512;874.1433395272542;877.2937785083069;908.9545522723837;934.8083642853198;6468.353164683588;6549.9345006550275;6553.475721942234;6560.212774467094;6568.343165683394;1000.1698590170141;1006.5219020964983;1014.3457469932;1021.6271061062658;1039.7088815131776;5171.560417364566;5208.244804503402;5209.583233341324;5217.973910130425;5221.530062294411;8016;8282;8365.07984121746;8400.831983360298;8564.957175214084;8477.788055298666;8487.830243395098;8514.191151840565;8535.615897284637;8558.828823423497;6544.149260596092;6617.602943823386;6712.496562757813;6719.160104986877;6733.326667333227;6347.17486726741;6403.359664033559;6417.165768450258;6424.421802037839;6431.163948686641;7431.665575049027;7523.510971786816;7545.207753185837;7687.346575540918;7712.652930618024;7675.309222170032;7850.293473587404;7855.567943763148;7940.880886786818;7944.126146123806;5941.435563621449;6023.457888789854;6031.276246850231;6038.69806509664;6041.2750469943885;6298.685065746786;6354.841128971812;6377.649229292248;6690;6733.663316834237;6073.149759033827;6087.847803804941;6146.446819786241;6146.477549408171;6160.260768707783;5935.317438494629;5965.34381218057;6032.758689652364;6050.818475445743;6095.634261944298;6064.423879731418;6109.11417844419;6151.354107818794;6153.969230153821;6158.907616385668;5419.4038655747045;5452.2094296327605;5457.808976685797;5468.808591699271;5477.726113694379;5763.049096898964;5793.710314484343;5803.883922321445;5809.593328466966;5824.796132135355 18:37:59 INFO - PROCESS | 26259 | |4;prototype.html;302.7214962234744;303.7190598696206;304.24243633352955;308.6620150934727;312.3316103538428;5215.322008138936;5250.159974404096;5326.733663316833;5359.732013399324;5415.729213539327;5121.871953201172;5278.604104692145;5282.947170528294;5284.180951952453;5288.444713305095;4134.607212314832;4138.379243113527;4139.151473947849;4141.192467468844;4142.606452387018;3897.162110146318;3984.342583473723;4026.053877338823;4128.97935510322;4165.375193720935;4130.318497447917;4137.1518838638;4139;4141.358089496133;4143.02638879863;4110.4656394668655;4116.464859568267;4122.752634841919;4123.463949686537;4138.110306284163;3649.416093425066;3650.470681751158;3651.269746050774;3661.029827095795;3662.157703728131;5002.049610574016;5105.081085404626;5108;5112.207607820794;5112.565431938289;4785.545373189541;4788.3056956741075;4789.521047895182;4796.8560943171415;4797.832075877328;5565.193047008162;5594.692291923942;5607.046802043662;5610.270664813589;5617.241672374218;3762.209935913434;3859.8456061757497;3868.574456809749;3972.4239985201984;3998.2203470323298;5863.677497737623;5869;5887.087501437241;5887.676177810262;5889.116632505158;4127.422160897477;4127.690423218271;4132.442120313779;4135.069609337875;4136.524299705572;4193.91612167761;4196.958030419657;4202.075543380452;4202.3696445533415;4206.26390381682;4648.883777905579;4741.762911854394;4743.217369134123;4755.714657120584;4759.714417134983;5586.720663966786;5589.301337332833;5597.692126932976;5601.243832082698;5601.439856014366;1462.722082804264;1487.2340744516582;1487.367868655817;1487.4570781664615;1488.3823213366547;995.6216637677636;1020.2756043209405;1023.488255872064;1038.672818062308;1039.750459889621;4864.464908860023;4865.318855360252;4875.1224779540025;4882.438519570223;4882.803713090245;5803.9419605803405;5804.158397032406;5805.680687562224;5810.564207684441;5814.912776308359;4858.58702010326;4874.19575770001;4875.171220892456;4884.1941079722155;4887.584555312767;3056.5273430307475;3092.9536056959164;3100.472919603673;3131.1076343242066;3133.435981523348;5508.586855985817;5521.171824226398;5525.917111243334;5526.06056970316;5526.58550608706;5961.5826892118;5973.731182096816;5975.073863551156;5980.162777211194;5986.700664966735;5504.6421982571;5514.6691198528215;5525.696086715189;5576.832695019156;5578.721063946705;5677.602567820213;5789.478946894799;5800.303963524404;5801.448862358069;5805.680687562224;5474.315710536183;5613.88772224545;5622.522085622768;5651.717414129359;5666.829995100154;5410.59420543453;5471.206675032177;5477.068898287381;5527.032769265443;5551.972240138935;4095.651869591118;4132.235536425771;4134.111166099303;4134.91730165401;4137.689673274456;5725.541956643375;5804.738786754522;5816.272965879265;5837.824865254049;5843.853903652443;5621;5621.494065534122;5635.042042852643;5642.463965923231;5645.520130788929;5572.080606700011;5595.468430499096;5596.3284405871555;5609.80365687199;5622.606417550732;5461.972690136524;5482.862928426821;5483.067878460592;5484;5506.394296627448;5532.640378375393;5671.291088613923;5678.233438485751;5679.545636349165;5680.545556355564;5524.558035357242;5525.889482210414;5530.917036244379;5531.917021244604;5536.003519366392 18:37:59 INFO - PROCESS | 26259 | |5;yui.html;727.9017332660089;730.9524880882742;751.7218629107231;778.1945686214767;778.6068035642;10790.51442685079;12178.878211217885;12402.689932751675;12408.759124087586;12409.441575129118;12192.268463892173;12245.387730613456;12292.754144917119;12307.446164922578;12320;622.6793201501231;627.8712863862897;775.9806004849868;777.133496151791;789.4079440419686;779.7738655789814;781.2656103262943;787.7479206653873;788.0189164490217;788.0897563314381;826.1862065865118;833.6457005772553;834.6494472321609;834.8163404051099;835.1189495082685;641.7625478572911;651.3128649275037;793.4683761879497;807.0315621254518;808.8746244332137;590.8877313310501;593.6438137117738;594.1592646405331;595.6366616364057;596.1534620838377;11563.595274165364;11775.587854425054;11795.528178872835;11816.113791465588;11820.468078936468;10066.547005384775;10089.293749437542;10253.692389228336;10796.568137274578;10998.725031874266;8906.86639700405;9157.496337701425;9293.395929264576;9593.944666086725;9711.320207585472;3156.2740569668877;3229.2572708276994;3262.4453842846538;3290.917727056819;3305.619853716805;39249.41125883114;39789.40315895264;40052.399214012104;40292.19415611671;40332;9330.300227482965;9373.203277721334;9388.34281600295;9408.482533460725;9448.57481413338;15332.233388330538;15339.309731062129;15342.463013794464;15361.155136467378;15361.846381536265;6262.15460912771;6313.9368606314265;6416.4225219729515;6463.224413070461;6476.31998640136;3167.920801979969;3277.7301619543496;3340.315235376742;3342.615599206074;3365.4110530657526;2694.8383097014244;2721.6053672217417;2724.82288651237;2727.0046433051793;2727.5635898256182;480.05668860688917;489.8310083021352;493.437481271351;495.8760309922519;505.8710028942596;388.1402693034885;393.9507561554806;406.9886332463825;439.01879299765;472.29156265601597;6434.292227854932;6451.452496742887;6478.125453063871;6633.834154146185;6641.203055633258;390.03271885723564;442.9689921705514;482.36568911880767;540.2922171954751;579.9494658098432;3079.414911166871;3186.2193762528327;3267.6732326767133;3270.2898009020646;3287.474004159371;47094.76452617784;47340.28989565159;47467;47511;48493.515064849606;39676.40485392721;39691.60308396879;39762.801185993885;39863.800680996406;40116.59883401129;37182;38899.80550097288;39339.2132157361;39363.60636393657;39454.21091578152;6610;6677.499187560855;6734.730610775514;6848.417884479875;6878.621675807879;30678.84660576772;31041.379172415975;31360.843195783877;31424;31761.523577145897;36046.819765901004;36120.27759444849;36629;39313;39536.40695389629;9460.763480913032;9522.85715714251;9573.664921727706;9739.172170365599;9841.852372214566;11205.215634905479;11330.830037549607;11357.432128393382;11359.432028398713;11380.260283081574;9306.813863722553;9328.113829186488;9368.15686588183;9728.367656102331;10050;9568.330216884751;9747.415155090717;9955.071884983967;10058.195344372287;10366.688999330032;9103.089691030844;9178.26573874075;9187.356885017985;9193.172614464464;9208.3093767969;8973.82052358936;9124.361294709306;9290.303227258119;9295.209907157967;9307.674231401868;8173.959130204311;8546.78633034179;8560.828783424422;8590.957045214735;8654.48073115615 18:37:59 INFO - PROCESS | 26259 | __end_tp_report 18:37:59 INFO - PROCESS | 26259 | __start_cc_report 18:37:59 INFO - PROCESS | 26259 | _x_x_mozilla_cycle_collect,843 18:37:59 INFO - PROCESS | 26259 | __end_cc_report 18:37:59 INFO - PROCESS | 26259 | __startTimestamp1451443079161__endTimestamp 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | ------- Summary: start ------- 18:37:59 INFO - PROCESS | 26259 | Number of tests: 6 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#0] dojo.html Cycles:165 Average:4619.20 Median:4786.04 stddev:472.59 (9.9%) stddev-sans-first:447.41 18:37:59 INFO - PROCESS | 26259 | Values: 2625.4 2701.8 2701.9 2706.1 2727.0 4500.2 4618.9 4692.9 4693.9 4694.8 4649.0 4651.5 4749.3 4755.2 4786.0 4287.8 4308.1 4312.3 4369.0 4388.6 4174.4 4378.7 4386.8 4434.8 4444.6 4249.5 4260.7 4270.4 4380.1 4383.8 4326.4 4334.5 4339.7 4343.9 4378.3 4317.1 4318.7 4325.8 4341.8 4360.6 4438.0 4577.6 4586.5 4603.7 4724.0 4939.4 4953.4 4958.8 4965.5 4999.9 4973.1 4981.5 4986.1 4990.2 5046.2 4472.8 4573.8 4591.6 4597.8 4700.2 5107.1 5141.7 5141.9 5142.3 5152.5 4936.0 4941.4 4954.4 4957.7 4985.3 4745.9 4834.6 4860.8 4877.9 4966.8 4943.5 4951.2 4956.8 4962.4 4963.5 4919.4 4926.8 4930.0 4930.4 4960.6 4022.2 4057.9 4103.8 4210.1 4252.5 3652.1 3664.5 3714.2 3740.5 3747.0 4267.4 4283.5 4289.5 4292.9 4320.3 4744.4 5009.1 5036.8 5087.5 5089.8 4212.1 4219.6 4261.3 4362.5 4367.7 4514.9 4517.3 4533.9 4534.6 4556.8 4798.1 4805.4 4806.3 4822.9 4849.6 4845.9 4904.7 4977.5 4978.2 5034.7 4799.6 4820.0 4827.1 4836.7 4867.8 4964.3 4987.4 4988.2 5004.1 5004.5 4771.4 4852.5 4892.9 5019.9 5080.4 4885.7 4888.0 4889.7 4895.2 4938.9 4847.0 4855.0 4857.4 4859.2 4908.1 4582.9 4705.5 4708.4 4745.6 4779.7 4958.1 4966.8 4970.6 4977.1 4987.2 4830.7 4837.0 4838.4 4842.0 4887.0 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#1] ext.html Cycles:180 Average:36227.49 Median:17876.69 stddev:56308.39 (315.0%) stddev-sans-first:56402.43 18:37:59 INFO - PROCESS | 26259 | Values: 495.9 505.0 506.1 522.7 536.0 24460.6 24844.1 24958.1 25001.9 30655.4 36126.6 36621.3 36663.1 36686.8 36715.0 7423.8 7561.3 7572.3 7581.0 7581.2 6774.1 6908.0 9648.3 9873.7 9886.5 9642.9 9737.1 9743.8 9752.7 9758.1 6779.8 6922.0 9603.0 9669.6 9701.9 9753.9 10030.8 10033.7 10035.0 10036.1 32952.2 33341.2 33364.8 33400.7 33429.8 2665.3 2770.2 3207.0 3304.4 3361.9 25722.7 25785.7 26515.3 27761.7 28027.7 3388.6 3403.0 3408.1 3436.7 3529.9 216441.0 216722.0 217268.0 217388.0 217818.0 51452.2 51803.5 52057.7 52088.7 52096.0 47041.8 48062.5 55568.0 55591.7 56926.0 11009.0 11154.3 11187.0 11211.2 11219.6 8626.9 8765.1 8813.6 8832.6 8833.3 16823.0 16994.1 17054.0 17081.8 17265.5 6981.8 7157.3 7214.9 7237.6 7308.0 784.6 812.6 911.3 972.0 1036.3 23532.3 25284.1 27894.3 28068.7 28581.1 891.0 891.3 895.8 916.4 1010.7 12205.4 12262.0 12318.2 12336.6 12387.4 258481.0 258665.0 259698.0 260930.0 262636.0 43105.6 43494.0 43519.6 43533.6 43593.0 1152.3 1165.5 1167.3 1172.5 1304.3 24036.5 24759.9 25438.0 25484.6 25487.9 32546.3 32696.8 33253.2 34814.3 35557.0 158242.0 158474.2 159397.0 159431.0 159439.0 23453.8 25350.9 25692.5 25726.0 25730.7 26012.6 26480.9 29370.9 29908.0 34865.5 29382.6 31944.2 32571.3 33043.8 33120.7 27863.7 32614.8 32778.5 32822.5 35293.8 29881.3 31177.0 31274.4 31363.0 31372.8 26270.7 28274.6 28594.7 28729.0 28798.4 22493.0 22844.4 22856.5 22866.9 24275.4 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#2] jquery.html Cycles:180 Average:14994.61 Median:41224.38 stddev:20997.49 (50.9%) stddev-sans-first:21027.54 18:37:59 INFO - PROCESS | 26259 | Values: 335.8 337.2 339.7 340.7 341.3 14123.8 14497.5 14623.5 15222.4 15233.6 8490.3 8669.8 8686.3 8696.8 9599.8 3457.2 4156.4 4269.3 4283.3 4296.5 3909.6 3945.0 5788.8 5792.0 5793.9 5730.7 5730.9 5738.1 5738.2 5738.2 3455.0 3577.7 4799.9 4989.0 4992.5 4796.6 4939.5 4959.4 4963.2 4963.7 16614.9 16850.6 17100.6 17121.4 17307.2 1619.1 1636.2 1690.5 1697.3 1715.8 8538.0 8689.3 8704.0 9975.7 12598.6 1649.5 1659.9 1695.7 1706.2 1714.9 54740.0 58450.7 58556.1 58780.7 59547.0 9554.8 9751.5 9799.9 9945.7 9992.0 12652.7 12670.3 12686.3 12712.4 12723.5 6079.6 6307.9 6382.6 6415.2 6512.7 5984.9 5995.0 6029.4 6036.0 6059.0 4126.7 4155.2 4177.8 4180.8 4213.6 1730.8 1753.9 1754.1 1757.1 1764.9 835.8 851.2 964.2 974.9 998.2 12422.4 14224.8 14468.9 15003.2 15070.4 827.6 839.6 855.2 855.3 904.1 7023.5 8040.1 8171.9 8179.5 8368.5 102944.0 103368.5 103724.0 104012.0 104206.0 63481.7 64397.4 65108.0 67416.0 75383.6 1025.5 1030.9 1034.3 1050.6 1059.1 13442.9 13892.3 14268.9 14336.6 14643.2 28204.9 28515.0 29689.9 29859.6 30032.1 34744.8 41217.4 41231.4 44289.0 46908.0 7696.3 8535.0 8610.3 8620.7 8625.7 9885.0 9988.9 15213.7 15956.4 16004.4 12371.0 12388.8 12525.2 12688.2 13080.1 10612.6 11686.5 13017.0 13326.6 13372.7 11790.9 11799.5 11939.8 12967.0 13118.6 8630.0 9132.0 9256.9 9284.4 9331.8 13356.7 13482.5 13622.0 13848.0 14258.7 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#3] mootools.html Cycles:180 Average:4849.05 Median:6027.37 stddev:2525.65 (41.9%) stddev-sans-first:2518.00 18:37:59 INFO - PROCESS | 26259 | Values: 1219.7 1376.4 1397.3 1467.7 1646.2 5819.2 6007.9 6584.4 6624.7 6694.6 6766.3 6837.9 6916.5 6932.0 6933.2 1727.9 1756.6 2082.5 2121.2 2122.4 2100.5 2132.4 2136.4 2137.4 2137.9 1995.6 2023.8 2028.8 2042.3 2042.3 2013.2 2021.7 2051.8 2055.6 2056.1 1843.9 1853.0 1853.6 1854.9 1859.8 6861.3 6865.4 6905.1 6907.1 6917.9 4040.9 4112.3 4116.9 4120.3 4120.8 2680.6 2743.5 2749.8 2753.1 2780.9 851.5 855.7 877.3 878.8 882.5 9582.7 9588.5 9590.8 9601.9 9620.5 3848.8 3914.6 3926.1 3935.4 3999.8 8284.3 8284.4 8297.3 8321.5 8323.6 4234.3 4264.0 4268.2 4268.9 4276.9 3877.8 3878.7 3881.1 3884.0 3891.2 2895.4 2925.4 3352.9 3398.9 3474.8 1088.2 1096.2 1100.3 1111.2 1111.5 872.1 874.1 877.3 909.0 934.8 6468.4 6549.9 6553.5 6560.2 6568.3 1000.2 1006.5 1014.3 1021.6 1039.7 5171.6 5208.2 5209.6 5218.0 5221.5 8016.0 8282.0 8365.1 8400.8 8565.0 8477.8 8487.8 8514.2 8535.6 8558.8 6544.1 6617.6 6712.5 6719.2 6733.3 6347.2 6403.4 6417.2 6424.4 6431.2 7431.7 7523.5 7545.2 7687.3 7712.7 7675.3 7850.3 7855.6 7940.9 7944.1 5941.4 6023.5 6031.3 6038.7 6041.3 6298.7 6354.8 6377.6 6690.0 6733.7 6073.1 6087.8 6146.4 6146.5 6160.3 5935.3 5965.3 6032.8 6050.8 6095.6 6064.4 6109.1 6151.4 6154.0 6158.9 5419.4 5452.2 5457.8 5468.8 5477.7 5763.0 5793.7 5803.9 5809.6 5824.8 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#4] prototype.html Cycles:180 Average:4660.35 Median:5232.74 stddev:1353.62 (25.9%) stddev-sans-first:1317.31 18:37:59 INFO - PROCESS | 26259 | Values: 302.7 303.7 304.2 308.7 312.3 5215.3 5250.2 5326.7 5359.7 5415.7 5121.9 5278.6 5282.9 5284.2 5288.4 4134.6 4138.4 4139.2 4141.2 4142.6 3897.2 3984.3 4026.1 4129.0 4165.4 4130.3 4137.2 4139.0 4141.4 4143.0 4110.5 4116.5 4122.8 4123.5 4138.1 3649.4 3650.5 3651.3 3661.0 3662.2 5002.0 5105.1 5108.0 5112.2 5112.6 4785.5 4788.3 4789.5 4796.9 4797.8 5565.2 5594.7 5607.0 5610.3 5617.2 3762.2 3859.8 3868.6 3972.4 3998.2 5863.7 5869.0 5887.1 5887.7 5889.1 4127.4 4127.7 4132.4 4135.1 4136.5 4193.9 4197.0 4202.1 4202.4 4206.3 4648.9 4741.8 4743.2 4755.7 4759.7 5586.7 5589.3 5597.7 5601.2 5601.4 1462.7 1487.2 1487.4 1487.5 1488.4 995.6 1020.3 1023.5 1038.7 1039.8 4864.5 4865.3 4875.1 4882.4 4882.8 5803.9 5804.2 5805.7 5810.6 5814.9 4858.6 4874.2 4875.2 4884.2 4887.6 3056.5 3093.0 3100.5 3131.1 3133.4 5508.6 5521.2 5525.9 5526.1 5526.6 5961.6 5973.7 5975.1 5980.2 5986.7 5504.6 5514.7 5525.7 5576.8 5578.7 5677.6 5789.5 5800.3 5801.4 5805.7 5474.3 5613.9 5622.5 5651.7 5666.8 5410.6 5471.2 5477.1 5527.0 5552.0 4095.7 4132.2 4134.1 4134.9 4137.7 5725.5 5804.7 5816.3 5837.8 5843.9 5621.0 5621.5 5635.0 5642.5 5645.5 5572.1 5595.5 5596.3 5609.8 5622.6 5462.0 5482.9 5483.1 5484.0 5506.4 5532.6 5671.3 5678.2 5679.5 5680.5 5524.6 5525.9 5530.9 5531.9 5536.0 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - PROCESS | 26259 | [#5] yui.html Cycles:180 Average:11690.36 Median:24487.94 stddev:13162.20 (53.7%) stddev-sans-first:13173.38 18:37:59 INFO - PROCESS | 26259 | Values: 727.9 731.0 751.7 778.2 778.6 10790.5 12178.9 12402.7 12408.8 12409.4 12192.3 12245.4 12292.8 12307.4 12320.0 622.7 627.9 776.0 777.1 789.4 779.8 781.3 787.7 788.0 788.1 826.2 833.6 834.6 834.8 835.1 641.8 651.3 793.5 807.0 808.9 590.9 593.6 594.2 595.6 596.2 11563.6 11775.6 11795.5 11816.1 11820.5 10066.5 10089.3 10253.7 10796.6 10998.7 8906.9 9157.5 9293.4 9593.9 9711.3 3156.3 3229.3 3262.4 3290.9 3305.6 39249.4 39789.4 40052.4 40292.2 40332.0 9330.3 9373.2 9388.3 9408.5 9448.6 15332.2 15339.3 15342.5 15361.2 15361.8 6262.2 6313.9 6416.4 6463.2 6476.3 3167.9 3277.7 3340.3 3342.6 3365.4 2694.8 2721.6 2724.8 2727.0 2727.6 480.1 489.8 493.4 495.9 505.9 388.1 394.0 407.0 439.0 472.3 6434.3 6451.5 6478.1 6633.8 6641.2 390.0 443.0 482.4 540.3 579.9 3079.4 3186.2 3267.7 3270.3 3287.5 47094.8 47340.3 47467.0 47511.0 48493.5 39676.4 39691.6 39762.8 39863.8 40116.6 37182.0 38899.8 39339.2 39363.6 39454.2 6610.0 6677.5 6734.7 6848.4 6878.6 30678.8 31041.4 31360.8 31424.0 31761.5 36046.8 36120.3 36629.0 39313.0 39536.4 9460.8 9522.9 9573.7 9739.2 9841.9 11205.2 11330.8 11357.4 11359.4 11380.3 9306.8 9328.1 9368.2 9728.4 10050.0 9568.3 9747.4 9955.1 10058.2 10366.7 9103.1 9178.3 9187.4 9193.2 9208.3 8973.8 9124.4 9290.3 9295.2 9307.7 8174.0 8546.8 8560.8 8591.0 8654.5 18:37:59 INFO - PROCESS | 26259 | -------- Summary: end -------- 18:37:59 INFO - PROCESS | 26259 | 18:37:59 INFO - TEST-INFO | 26259: exit 0 18:37:59 INFO - TEST-OK | dromaeo_css | took 1116920ms 18:37:59 INFO - TEST-START | kraken 18:37:59 INFO - operating with platform_type : linux_ 18:37:59 INFO - Initialising browser for kraken test... 18:37:59 INFO - TEST-INFO | started process 26443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkkThD/profile http://localhost:46722/getInfo.html) 18:38:04 INFO - PROCESS | 26443 | __metrics Screen width/height:1600/1200 18:38:04 INFO - PROCESS | 26443 | colorDepth:24 18:38:04 INFO - PROCESS | 26443 | Browser inner width/height: 1024/697 18:38:04 INFO - PROCESS | 26443 | __metrics 18:38:04 INFO - PROCESS | 26443 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:38:04 INFO - PROCESS | 26443 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:05 INFO - TEST-INFO | 26443: exit 0 18:38:05 INFO - Browser initialized. 18:38:05 INFO - Running cycle 1/1 for kraken test... 18:38:05 INFO - TEST-INFO | started process 26525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkkThD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:17 INFO - PROCESS | 26525 | RSS: Main: 148299776 18:38:17 INFO - PROCESS | 26525 | 18:38:19 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46722/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:20 INFO - PROCESS | 26525 | RSS: Main: 184840192 18:38:20 INFO - PROCESS | 26525 | 18:38:23 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46722/tests/kraken/driver.html?testName=audio-dft) 18:38:23 INFO - PROCESS | 26525 | RSS: Main: 176332800 18:38:23 INFO - PROCESS | 26525 | 18:38:26 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46722/tests/kraken/driver.html?testName=audio-fft) 18:38:27 INFO - PROCESS | 26525 | RSS: Main: 161435648 18:38:27 INFO - PROCESS | 26525 | 18:38:29 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46722/tests/kraken/driver.html?testName=audio-oscillator) 18:38:29 INFO - PROCESS | 26525 | RSS: Main: 163450880 18:38:29 INFO - PROCESS | 26525 | 18:38:32 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:32 INFO - PROCESS | 26525 | RSS: Main: 165007360 18:38:32 INFO - PROCESS | 26525 | 18:38:35 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46722/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:36 INFO - PROCESS | 26525 | RSS: Main: 165040128 18:38:36 INFO - PROCESS | 26525 | 18:38:39 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46722/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:40 INFO - PROCESS | 26525 | RSS: Main: 165949440 18:38:40 INFO - PROCESS | 26525 | 18:38:43 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46722/tests/kraken/driver.html?testName=json-parse-financial) 18:38:43 INFO - PROCESS | 26525 | RSS: Main: 164827136 18:38:43 INFO - PROCESS | 26525 | 18:38:45 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:45 INFO - PROCESS | 26525 | RSS: Main: 176152576 18:38:45 INFO - PROCESS | 26525 | 18:38:47 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:48 INFO - PROCESS | 26525 | RSS: Main: 171925504 18:38:48 INFO - PROCESS | 26525 | 18:38:50 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:51 INFO - PROCESS | 26525 | RSS: Main: 187023360 18:38:51 INFO - PROCESS | 26525 | 18:38:53 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:54 INFO - PROCESS | 26525 | RSS: Main: 191737856 18:38:54 INFO - PROCESS | 26525 | 18:38:56 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:57 INFO - PROCESS | 26525 | RSS: Main: 188825600 18:38:57 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | Cycle 1(1): loaded http://localhost:46722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46722/tests/kraken/driver.html?testName=ai-astar) 18:38:59 INFO - PROCESS | 26525 | RSS: Main: 246841344 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | __start_tp_report 18:38:59 INFO - PROCESS | 26525 | _x_x_mozilla_page_load 18:38:59 INFO - PROCESS | 26525 | _x_x_mozilla_page_load_details 18:38:59 INFO - PROCESS | 26525 | |i|pagename|runs| 18:38:59 INFO - PROCESS | 26525 | |0;ai-astar;110;112;108;112;112;113;103;111;110;103 18:38:59 INFO - PROCESS | 26525 | |1;audio-beat-detection;158;131;151;169;138;156;156;128;167;130 18:38:59 INFO - PROCESS | 26525 | |2;audio-dft;160;161;161;159;160;161;162;164;162;160 18:38:59 INFO - PROCESS | 26525 | |3;audio-fft;75;72;81;92;75;71;71;91;93;72 18:38:59 INFO - PROCESS | 26525 | |4;audio-oscillator;98;98;134;97;97;98;138;97;97;131 18:38:59 INFO - PROCESS | 26525 | |5;imaging-gaussian-blur;109;109;109;109;110;110;109;110;109;109 18:38:59 INFO - PROCESS | 26525 | |6;imaging-darkroom;148;147;148;147;147;146;147;147;148;147 18:38:59 INFO - PROCESS | 26525 | |7;imaging-desaturate;95;96;96;95;95;95;96;95;95;96 18:38:59 INFO - PROCESS | 26525 | |8;json-parse-financial;70;70;69;70;70;70;71;80;68;68 18:38:59 INFO - PROCESS | 26525 | |9;json-stringify-tinderbox;70;69;70;69;69;74;69;70;69;68 18:38:59 INFO - PROCESS | 26525 | |10;stanford-crypto-aes;93;86;85;87;85;91;85;88;86;85 18:38:59 INFO - PROCESS | 26525 | |11;stanford-crypto-ccm;138;126;128;124;127;122;121;121;123;128 18:38:59 INFO - PROCESS | 26525 | |12;stanford-crypto-pbkdf2;138;148;149;147;148;147;148;146;150;136 18:38:59 INFO - PROCESS | 26525 | |13;stanford-crypto-sha256-iterative;69;69;70;69;69;69;68;69;69;69 18:38:59 INFO - PROCESS | 26525 | __end_tp_report 18:38:59 INFO - PROCESS | 26525 | __start_cc_report 18:38:59 INFO - PROCESS | 26525 | _x_x_mozilla_cycle_collect,971 18:38:59 INFO - PROCESS | 26525 | __end_cc_report 18:38:59 INFO - PROCESS | 26525 | __startTimestamp1451443139420__endTimestamp 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | ------- Summary: start ------- 18:38:59 INFO - PROCESS | 26525 | Number of tests: 14 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:3.66 (3.3%) stddev-sans-first:3.87 18:38:59 INFO - PROCESS | 26525 | Values: 110.0 112.0 108.0 112.0 112.0 113.0 103.0 111.0 110.0 103.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.00 stddev:15.46 (9.9%) stddev-sans-first:16.00 18:38:59 INFO - PROCESS | 26525 | Values: 158.0 131.0 151.0 169.0 138.0 156.0 156.0 128.0 167.0 130.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 18:38:59 INFO - PROCESS | 26525 | Values: 160.0 161.0 161.0 159.0 160.0 161.0 162.0 164.0 162.0 160.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#3] audio-fft Cycles:10 Average:79.30 Median:78.00 stddev:9.25 (11.9%) stddev-sans-first:9.68 18:38:59 INFO - PROCESS | 26525 | Values: 75.0 72.0 81.0 92.0 75.0 71.0 71.0 91.0 93.0 72.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:97.00 stddev:17.91 (18.5%) stddev-sans-first:18.59 18:38:59 INFO - PROCESS | 26525 | Values: 98.0 98.0 134.0 97.0 97.0 98.0 138.0 97.0 97.0 131.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:38:59 INFO - PROCESS | 26525 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 18:38:59 INFO - PROCESS | 26525 | Values: 148.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:38:59 INFO - PROCESS | 26525 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:70.00 stddev:3.44 (4.9%) stddev-sans-first:3.64 18:38:59 INFO - PROCESS | 26525 | Values: 70.0 70.0 69.0 70.0 70.0 70.0 71.0 80.0 68.0 68.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:1.64 (2.4%) stddev-sans-first:1.73 18:38:59 INFO - PROCESS | 26525 | Values: 70.0 69.0 70.0 69.0 69.0 74.0 69.0 70.0 69.0 68.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.81 (3.2%) stddev-sans-first:2.01 18:38:59 INFO - PROCESS | 26525 | Values: 93.0 86.0 85.0 87.0 85.0 91.0 85.0 88.0 86.0 85.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:5.07 (4.0%) stddev-sans-first:2.88 18:38:59 INFO - PROCESS | 26525 | Values: 138.0 126.0 128.0 124.0 127.0 122.0 121.0 121.0 123.0 128.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:148.00 stddev:4.74 (3.2%) stddev-sans-first:4.13 18:38:59 INFO - PROCESS | 26525 | Values: 138.0 148.0 149.0 147.0 148.0 147.0 148.0 146.0 150.0 136.0 18:38:59 INFO - PROCESS | 26525 | 18:38:59 INFO - PROCESS | 26525 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 18:38:59 INFO - PROCESS | 26525 | Values: 69.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 18:38:59 INFO - PROCESS | 26525 | -------- Summary: end -------- 18:38:59 INFO - PROCESS | 26525 | 18:39:00 INFO - TEST-INFO | 26525: exit 0 18:39:00 INFO - TEST-OK | kraken | took 60395ms 18:39:00 INFO - TEST-START | v8_7 18:39:00 INFO - operating with platform_type : linux_ 18:39:00 INFO - Initialising browser for v8_7 test... 18:39:00 INFO - TEST-INFO | started process 26771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR8JkaT/profile http://localhost:46722/getInfo.html) 18:39:04 INFO - PROCESS | 26771 | __metrics Screen width/height:1600/1200 18:39:04 INFO - PROCESS | 26771 | colorDepth:24 18:39:04 INFO - PROCESS | 26771 | Browser inner width/height: 1024/697 18:39:04 INFO - PROCESS | 26771 | __metrics 18:39:04 INFO - PROCESS | 26771 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:39:04 INFO - PROCESS | 26771 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:39:05 INFO - TEST-INFO | 26771: exit 0 18:39:05 INFO - Browser initialized. 18:39:05 INFO - Running cycle 1/1 for v8_7 test... 18:39:05 INFO - TEST-INFO | started process 26855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR8JkaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:17 INFO - PROCESS | 26855 | RSS: Main: 150503424 18:39:17 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | Cycle 1(1): loaded http://localhost:46722/tests/v8_7/run.html (next: http://localhost:46722/tests/v8_7/run.html) 18:39:39 INFO - PROCESS | 26855 | RSS: Main: 449490944 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | __start_tp_report 18:39:39 INFO - PROCESS | 26855 | _x_x_mozilla_page_load 18:39:39 INFO - PROCESS | 26855 | _x_x_mozilla_page_load_details 18:39:39 INFO - PROCESS | 26855 | |i|pagename|runs| 18:39:39 INFO - PROCESS | 26855 | |0;Richards;167.7289500167729 18:39:39 INFO - PROCESS | 26855 | |1;DeltaBlue;189.465706707086 18:39:39 INFO - PROCESS | 26855 | |2;Encrypt;278.78449958182324 18:39:39 INFO - PROCESS | 26855 | |3;Decrypt;5181.347150259067 18:39:39 INFO - PROCESS | 26855 | |4;RayTrace;1988.0715705765408 18:39:39 INFO - PROCESS | 26855 | |5;Earley;810.3727714748784 18:39:39 INFO - PROCESS | 26855 | |6;Boyer;12072.289156626506 18:39:39 INFO - PROCESS | 26855 | |7;RegExp;26763.157894736843 18:39:39 INFO - PROCESS | 26855 | |8;Splay;609.3845216331505 18:39:39 INFO - PROCESS | 26855 | |9;NavierStokes;4830.917874396136 18:39:39 INFO - PROCESS | 26855 | __end_tp_report 18:39:39 INFO - PROCESS | 26855 | __startTimestamp1451443179288__endTimestamp 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | ------- Summary: start ------- 18:39:39 INFO - PROCESS | 26855 | Number of tests: 10 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 167.7 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#1] DeltaBlue Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 189.5 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 278.8 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 5181.3 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 1988.1 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#5] Earley Cycles:1 Average:810.37 Median:810.37 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 810.4 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 12072.3 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 26763.2 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 609.4 18:39:39 INFO - PROCESS | 26855 | 18:39:39 INFO - PROCESS | 26855 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:39:39 INFO - PROCESS | 26855 | Values: 4830.9 18:39:39 INFO - PROCESS | 26855 | -------- Summary: end -------- 18:39:39 INFO - PROCESS | 26855 | 18:39:40 INFO - TEST-INFO | 26855: exit 0 18:39:40 INFO - TEST-OK | v8_7 | took 39860ms 18:39:40 INFO - SUITE-END | took 1217s 18:39:40 INFO - Completed test suite (00:20:17) 18:39:40 INFO - Working with test: dromaeo_css 18:39:40 INFO - Generating results file: dromaeo_css 18:39:40 INFO - Working with test: kraken 18:39:40 INFO - Generating results file: kraken 18:39:40 INFO - javascript benchmark 18:39:40 INFO - Working with test: v8_7 18:39:40 INFO - Generating results file: v8_7 18:39:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 18:39:40 INFO - process_Request line: dromaeo_css 6059.40 graph.html#tests=[[72,203,35]] 18:39:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:40 INFO - process_Request line: kraken 1526.40 graph.html#tests=[[232,203,35]] 18:39:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:40 INFO - process_Request line: v8_7 19710.39 graph.html#tests=[[230,203,35]] 18:39:40 INFO - RETURN: dromaeo_css: 6059.40 18:39:40 INFO - RETURN: kraken: 1526.40 18:39:40 INFO - RETURN: v8_7: 19710.39 18:39:40 INFO - javascript benchmark 18:39:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.4486557822856, 2701.797365197611, 2701.8784154713035, 2706.134037108125, 2726.9590956135658, 4500.21246281901, 4618.861434156972, 4692.929606055907, 4693.929591056132, 4694.788734506947, 4649.046945376198, 4651.488336283014, 4749.335093086971, 4755.191617425037, 4786.042791441717, 4287.8070486828165, 4308.0737641407095, 4312.331588603772, 4368.956310436903, 4388.626966707834, 4174.35297528882, 4378.6934914555995, 4386.802593883267, 4434.844780432685, 4444.622207112399, 4249.468816397965, 4260.70175087744, 4270.402143699885, 4380.102079073782, 4383.846565370197, 4326.351047342892, 4334.544872788343, 4339.7396156230725, 4343.9348409773875, 4378.299472084483, 4317.136572685476, 4318.676099292566, 4325.82696692132, 4341.848035318781, 4360.607545320936, 4438.025994721398, 4577.610903073243, 4586.495485496593, 4603.654725895538, 4723.952760472385, 4939.357883475125, 4953.356063711694, 4958.826441074545, 4965.528274813887, 4999.875003124915, 4973.055119527278, 4981.526754958273, 4986.077575648516, 4990.151674215392, 5046.21783623539, 4472.84345047925, 4573.817047318136, 4591.609713174417, 4597.770111494412, 4700.153972285021, 5107.080725469451, 5141.742912854417, 5141.922871156936, 5142.331496905378, 5152.458991805881, 4936.0, 4941.382327209099, 4954.355933728592, 4957.677750946177, 4985.252212168131, 4745.881352966204, 4834.564889159922, 4860.756962151878, 4877.902441951142, 4966.776495057731, 4943.530364615356, 4951.183054795991, 4956.801727930914, 4962.354893863847, 4963.478834722302, 4919.434265059493, 4926.802927882916, 4929.950700492949, 4930.433000205022, 4960.603151747851, 4022.1955608878343, 4057.91884162321, 4103.753774773523, 4210.115875666083, 4252.468441444819, 3652.123490362347, 3664.4686520454384, 3714.182879766447, 3740.532433445819, 3747.0, 4267.4238977737605, 4283.507396649363, 4289.506706728704, 4292.871213863589, 4320.330348795942, 4744.383230180124, 5009.073321435546, 5036.7733451994745, 5087.491250874957, 5089.796408143633, 4212.052288235122, 4219.556946520633, 4261.339492378686, 4362.476502819619, 4367.716098453654, 4514.932276015862, 4517.254652982221, 4533.863984080483, 4534.614557762628, 4556.7721613919175, 4798.1123492153365, 4805.37530121082, 4806.279058141236, 4822.903541929142, 4849.636277279289, 4845.878853028561, 4904.681195722266, 4977.4773648767805, 4978.203487442137, 5034.748262586929, 4799.616030717604, 4819.975900120477, 4827.08285425768, 4836.733979631154, 4867.829625963074, 4964.280179373898, 4987.351644286219, 4988.2018876980965, 5004.099262132851, 5004.47453017428, 4771.427428708577, 4852.51474852526, 4892.877678058077, 5019.874503137305, 5080.390353157644, 4885.682430641997, 4887.975560122177, 4889.682170658896, 4895.167821470287, 4938.925916111333, 4847.030593881167, 4854.95145048545, 4857.441394239567, 4859.173940430206, 4908.092002979461, 4582.88542786433, 4705.5059218781535, 4708.4349878014855, 4745.572898439157, 4779.665423420327, 4958.057968985881, 4966.776495057803, 4970.577500912463, 4977.054359671651, 4987.1521841287795, 4830.734309613005, 4836.975815120902, 4838.443578988461, 4842.0, 4887.0], "unit": "score", "name": "dojo.html", "value": 4590.3132406796685}, {"lowerIsBetter": false, "replicates": [495.8785097651076, 504.98737531561704, 506.0915656396765, 522.6984807828507, 535.9758810853511, 24460.633090503634, 24844.130455434064, 24958.126465573707, 25001.874990625023, 30655.38689226214, 36126.63873361266, 36621.26757464849, 36663.08342291444, 36686.8165659172, 36715.0, 7423.814404639887, 7561.281678240586, 7572.280633339824, 7581.0, 7581.166071732105, 6774.051632771416, 6907.9654601726925, 9648.276379271547, 9873.654422095227, 9886.505674716236, 9642.891067527218, 9737.1236588707, 9743.756406089833, 9752.707418777449, 9758.072983066633, 6779.796606101775, 6922.0, 9602.999999999965, 9669.564869580885, 9701.902980970206, 9753.853692194623, 10030.799384012353, 10033.698989030341, 10035.046670566284, 10036.14692751117, 32952.176195595064, 33341.16647083818, 33364.83317583396, 33400.66599334, 33429.83285083583, 2665.2803742989286, 2770.2104900103577, 3207.0378886334006, 3304.4052070627276, 3361.865525378982, 25722.742772572223, 25785.74214257852, 26515.337116572045, 27761.72238277632, 28027.719722802714, 3388.6272510023878, 3403.0, 3408.062782734743, 3436.6735160159747, 3529.911752206215, 216441.0, 216722.0, 217268.0, 217388.0, 217817.99999999843, 51452.22821657678, 51803.48196518062, 52057.73971130196, 52088.739556301975, 52096.0, 47041.764791175825, 48062.51937480651, 55568.0, 55591.722041389534, 56926.0, 11009.0, 11154.330740155616, 11187.0, 11211.159163062639, 11219.551217951353, 8626.913730862736, 8765.123487651312, 8813.603387847563, 8832.646694132163, 8833.293336533063, 16823.0, 16994.06532640692, 17054.0, 17081.829181708024, 17265.482035538953, 6981.79054628362, 7157.284271572905, 7214.855702885913, 7237.638118094074, 7308.0, 784.5880912520859, 812.5612169428442, 911.3392790227032, 971.9697121051707, 1036.3160314192749, 23532.29403117909, 25284.115055972954, 27894.32634041964, 28068.719312807018, 28581.14256572306, 890.955452227386, 891.3047822698305, 895.7939673875045, 916.4455504419864, 1010.7018429563296, 12205.389730513616, 12262.0, 12318.199317044364, 12336.568220112433, 12387.442565084593, 258481.0, 258665.0, 259698.0, 260930.0, 262636.0, 43105.568944310784, 43494.0, 43519.564804351554, 43533.56466435359, 43593.0, 1152.2798251093068, 1165.4638866121509, 1167.3404526442532, 1172.454808514045, 1304.341307639636, 24036.450925495737, 24759.87620061888, 25438.0, 25484.617730733684, 25487.87256063708, 32546.349073018882, 32696.836515817267, 33253.16867078342, 34814.303713925074, 35557.0, 158242.0, 158474.20762896113, 159397.0, 159431.0, 159439.0, 23453.76546234584, 25350.873245633655, 25692.486150277262, 25726.0, 25730.68423841863, 26012.609810852475, 26480.86759566267, 29370.853145734134, 29908.0, 34865.47701784526, 29382.55926161152, 31944.201394965312, 32571.34857302888, 33043.83478082594, 33120.66879331176, 27863.721362786113, 32614.83692581522, 32778.50832237566, 32822.507662385564, 35293.82353088218, 29881.252968675955, 31177.0, 31274.374512510076, 31363.0, 31372.84313578509, 26270.73729262683, 28274.575881361383, 28594.714052859206, 28729.0, 28798.424031518833, 22493.0, 22844.4288892779, 22856.54286914219, 22866.885665571564, 24275.39311517226], "unit": "score", "name": "ext.html", "value": 15773.412764524466}, {"lowerIsBetter": false, "replicates": [335.7649645248327, 337.16551534951, 339.6857906436546, 340.684866498489, 341.29352240861414, 14123.788143177848, 14497.49258775943, 14623.488177913776, 15222.391104355813, 15233.619159521017, 8490.320774338054, 8669.783255418602, 8686.348523860705, 8696.782580435476, 9599.760005999853, 3457.239407330383, 4156.355764856452, 4269.252880745873, 4283.250431174548, 4296.548862369453, 3909.550401703812, 3945.0, 5788.82633520995, 5791.971040144794, 5793.884122317551, 5730.656160630355, 5730.942690573103, 5738.0532212184935, 5738.196652468637, 5738.196652468658, 3454.9654503455145, 3577.749557530974, 4799.880002999936, 4989.0, 4992.500749925015, 4796.640251981115, 4939.506049395031, 4959.404871415417, 4963.181075122637, 4963.726995015273, 16614.916925415295, 16850.578735531588, 17100.572485687833, 17121.400750973782, 17307.221175047154, 1619.093307747665, 1636.2473262299357, 1690.5435532406304, 1697.2701738252547, 1715.7941047074305, 8538.0, 8689.3048556116, 8704.0, 9975.650852220137, 12598.559050433283, 1649.546374746942, 1659.9336026558924, 1695.6608678264397, 1706.2321955120246, 1714.8971061736336, 54740.0, 58450.70774646142, 58556.121658175165, 58780.70609646967, 59547.0, 9554.761130971643, 9751.463669498246, 9799.853002204973, 9945.651902183388, 9991.950040249752, 12652.683682907817, 12670.303133327756, 12686.302253376152, 12712.42794074269, 12723.491060357483, 6079.574429789961, 6307.905381419282, 6382.5532212744665, 6415.166028416276, 6512.674366281762, 5984.910226346608, 5994.970025149846, 6029.427204415573, 6036.0, 6059.0, 4126.731762435492, 4155.231282212801, 4177.832886684499, 4180.770057646798, 4213.578642135823, 1730.8182640822533, 1753.8947663139998, 1754.1492376197534, 1757.0775342945055, 1764.858811295119, 835.8161204535114, 851.1701091435924, 964.1900803325241, 974.878140232471, 998.1964518562627, 12422.37888105591, 14224.786628200585, 14468.927655361656, 15003.2498375083, 15070.397184112513, 827.6399766101765, 839.5969934431507, 855.2302927365297, 855.320020583625, 904.0868722590232, 7023.508354415142, 8040.115587285394, 8171.877421838677, 8179.509229446133, 8368.456050356708, 102944.0, 103368.48315758523, 103724.0, 104012.0, 104206.0, 63481.682591586745, 64397.35602644007, 65108.0, 67416.0, 75383.62308188534, 1025.5385076715509, 1030.855680204772, 1034.270839058462, 1050.648032908984, 1059.057438879398, 13442.865571344162, 13892.30538473052, 14268.857311426753, 14336.641583960485, 14643.194624295766, 28204.85897570499, 28515.0, 29689.851550742107, 29859.552106718853, 30032.09903702805, 34744.82627586846, 41217.38173927333, 41231.381529277685, 44289.0, 46908.0, 7696.345810606162, 8535.0, 8610.268127209007, 8620.65517379323, 8625.654973801229, 9884.950575247078, 9988.850167247643, 15213.695726085638, 15956.361745530514, 16004.359825606845, 12371.0, 12388.752224955631, 12525.185862918881, 12688.17526860788, 13080.149790263602, 10612.575496980035, 11686.532538698697, 13016.958643308702, 13326.600201993955, 13372.665683357995, 11790.882091178979, 11799.52801887915, 11939.76120477603, 12967.0, 13118.606441806762, 8630.0, 9132.0, 9256.907430925605, 9284.396514226553, 9331.813363732552, 13356.666083347995, 13482.52811151605, 13622.0, 13848.0, 14258.71482570322], "unit": "score", "name": "jquery.html", "value": 7502.602799950285}, {"lowerIsBetter": false, "replicates": [1219.7377563823777, 1376.4219028008235, 1397.3013493253372, 1467.706458708258, 1646.1933652510274, 5819.156222347757, 6007.939920600793, 6584.440322572587, 6624.701888415021, 6694.5648532845335, 6766.289539598345, 6837.863242735142, 6916.481263905214, 6931.965340173305, 6933.237343892168, 1727.9136043197852, 1756.5872020075335, 2082.541840795023, 2121.1727426303755, 2122.4375540481783, 2100.4538819906857, 2132.360291912428, 2136.412486566191, 2137.412211641803, 2137.935861924137, 1995.6008798240337, 2023.8482113841521, 2028.8376929845576, 2042.2647846775149, 2042.336240721764, 2013.1544751204528, 2021.6765317549196, 2051.774304826468, 2055.599158164151, 2056.1158701758236, 1843.8709290349682, 1853.0179005127304, 1853.5551467647801, 1854.9258029678797, 1859.8326150646508, 6861.2795656455855, 6865.382115609569, 6905.102336696247, 6907.067545881292, 6917.9308206917785, 4040.919181616351, 4112.259793237216, 4116.876493705194, 4120.320147175712, 4120.793960302003, 2680.624712540246, 2743.492453896016, 2749.766269867064, 2753.0914798116573, 2780.8609569521645, 851.5316575883239, 855.6620135046684, 877.3419935048713, 878.775912142406, 882.5057967538135, 9582.712518624452, 9588.520573971273, 9590.808183836354, 9601.90398096017, 9620.518974051269, 3848.807559622008, 3914.5693973662874, 3926.1362500249897, 3935.4490371348033, 3999.7600143991453, 8284.337253019745, 8284.378671599654, 8297.294729947902, 8321.459105158145, 8323.583820808935, 4234.301340278881, 4263.957360426418, 4268.189044081614, 4268.893277668021, 4276.914461710749, 3877.806109694504, 3878.7478813877005, 3881.146147847469, 3883.980580097138, 3891.2412079644196, 2895.406441679451, 2925.3710452252867, 3352.949705754416, 3398.8640454382044, 3474.7915125092068, 1088.2491081154137, 1096.2435919215716, 1100.273819279272, 1111.2388014210292, 1111.4553868604326, 872.097379212512, 874.1433395272542, 877.2937785083069, 908.9545522723837, 934.8083642853198, 6468.353164683588, 6549.9345006550275, 6553.475721942234, 6560.212774467094, 6568.343165683394, 1000.1698590170141, 1006.5219020964983, 1014.3457469932, 1021.6271061062658, 1039.7088815131776, 5171.560417364566, 5208.244804503402, 5209.583233341324, 5217.973910130425, 5221.530062294411, 8016.0, 8282.0, 8365.07984121746, 8400.831983360298, 8564.957175214084, 8477.788055298666, 8487.830243395098, 8514.191151840565, 8535.615897284637, 8558.828823423497, 6544.149260596092, 6617.602943823386, 6712.496562757813, 6719.160104986877, 6733.326667333227, 6347.17486726741, 6403.359664033559, 6417.165768450258, 6424.421802037839, 6431.163948686641, 7431.665575049027, 7523.510971786816, 7545.207753185837, 7687.346575540918, 7712.652930618024, 7675.309222170032, 7850.293473587404, 7855.567943763148, 7940.880886786818, 7944.126146123806, 5941.435563621449, 6023.457888789854, 6031.276246850231, 6038.69806509664, 6041.2750469943885, 6298.685065746786, 6354.841128971812, 6377.649229292248, 6690.0, 6733.663316834237, 6073.149759033827, 6087.847803804941, 6146.446819786241, 6146.477549408171, 6160.260768707783, 5935.317438494629, 5965.34381218057, 6032.758689652364, 6050.818475445743, 6095.634261944298, 6064.423879731418, 6109.11417844419, 6151.354107818794, 6153.969230153821, 6158.907616385668, 5419.4038655747045, 5452.2094296327605, 5457.808976685797, 5468.808591699271, 5477.726113694379, 5763.049096898964, 5793.710314484343, 5803.883922321445, 5809.593328466966, 5824.796132135355], "unit": "score", "name": "mootools.html", "value": 3976.229695339224}, {"lowerIsBetter": false, "replicates": [302.7214962234744, 303.7190598696206, 304.24243633352955, 308.6620150934727, 312.3316103538428, 5215.322008138936, 5250.159974404096, 5326.733663316833, 5359.732013399324, 5415.729213539327, 5121.871953201172, 5278.604104692145, 5282.947170528294, 5284.180951952453, 5288.444713305095, 4134.607212314832, 4138.379243113527, 4139.151473947849, 4141.192467468844, 4142.606452387018, 3897.162110146318, 3984.342583473723, 4026.053877338823, 4128.97935510322, 4165.375193720935, 4130.318497447917, 4137.1518838638, 4139.0, 4141.358089496133, 4143.02638879863, 4110.4656394668655, 4116.464859568267, 4122.752634841919, 4123.463949686537, 4138.110306284163, 3649.416093425066, 3650.470681751158, 3651.269746050774, 3661.029827095795, 3662.157703728131, 5002.049610574016, 5105.081085404626, 5108.0, 5112.207607820794, 5112.565431938289, 4785.545373189541, 4788.3056956741075, 4789.521047895182, 4796.8560943171415, 4797.832075877328, 5565.193047008162, 5594.692291923942, 5607.046802043662, 5610.270664813589, 5617.241672374218, 3762.209935913434, 3859.8456061757497, 3868.574456809749, 3972.4239985201984, 3998.2203470323298, 5863.677497737623, 5869.0, 5887.087501437241, 5887.676177810262, 5889.116632505158, 4127.422160897477, 4127.690423218271, 4132.442120313779, 4135.069609337875, 4136.524299705572, 4193.91612167761, 4196.958030419657, 4202.075543380452, 4202.3696445533415, 4206.26390381682, 4648.883777905579, 4741.762911854394, 4743.217369134123, 4755.714657120584, 4759.714417134983, 5586.720663966786, 5589.301337332833, 5597.692126932976, 5601.243832082698, 5601.439856014366, 1462.722082804264, 1487.2340744516582, 1487.367868655817, 1487.4570781664615, 1488.3823213366547, 995.6216637677636, 1020.2756043209405, 1023.488255872064, 1038.672818062308, 1039.750459889621, 4864.464908860023, 4865.318855360252, 4875.1224779540025, 4882.438519570223, 4882.803713090245, 5803.9419605803405, 5804.158397032406, 5805.680687562224, 5810.564207684441, 5814.912776308359, 4858.58702010326, 4874.19575770001, 4875.171220892456, 4884.1941079722155, 4887.584555312767, 3056.5273430307475, 3092.9536056959164, 3100.472919603673, 3131.1076343242066, 3133.435981523348, 5508.586855985817, 5521.171824226398, 5525.917111243334, 5526.06056970316, 5526.58550608706, 5961.5826892118, 5973.731182096816, 5975.073863551156, 5980.162777211194, 5986.700664966735, 5504.6421982571, 5514.6691198528215, 5525.696086715189, 5576.832695019156, 5578.721063946705, 5677.602567820213, 5789.478946894799, 5800.303963524404, 5801.448862358069, 5805.680687562224, 5474.315710536183, 5613.88772224545, 5622.522085622768, 5651.717414129359, 5666.829995100154, 5410.59420543453, 5471.206675032177, 5477.068898287381, 5527.032769265443, 5551.972240138935, 4095.651869591118, 4132.235536425771, 4134.111166099303, 4134.91730165401, 4137.689673274456, 5725.541956643375, 5804.738786754522, 5816.272965879265, 5837.824865254049, 5843.853903652443, 5621.0, 5621.494065534122, 5635.042042852643, 5642.463965923231, 5645.520130788929, 5572.080606700011, 5595.468430499096, 5596.3284405871555, 5609.80365687199, 5622.606417550732, 5461.972690136524, 5482.862928426821, 5483.067878460592, 5484.0, 5506.394296627448, 5532.640378375393, 5671.291088613923, 5678.233438485751, 5679.545636349165, 5680.545556355564, 5524.558035357242, 5525.889482210414, 5530.917036244379, 5531.917021244604, 5536.003519366392], "unit": "score", "name": "prototype.html", "value": 4229.011299833545}, {"lowerIsBetter": false, "replicates": [727.9017332660089, 730.9524880882742, 751.7218629107231, 778.1945686214767, 778.6068035642, 10790.51442685079, 12178.878211217885, 12402.689932751675, 12408.759124087586, 12409.441575129118, 12192.268463892173, 12245.387730613456, 12292.754144917119, 12307.446164922578, 12320.0, 622.6793201501231, 627.8712863862897, 775.9806004849868, 777.133496151791, 789.4079440419686, 779.7738655789814, 781.2656103262943, 787.7479206653873, 788.0189164490217, 788.0897563314381, 826.1862065865118, 833.6457005772553, 834.6494472321609, 834.8163404051099, 835.1189495082685, 641.7625478572911, 651.3128649275037, 793.4683761879497, 807.0315621254518, 808.8746244332137, 590.8877313310501, 593.6438137117738, 594.1592646405331, 595.6366616364057, 596.1534620838377, 11563.595274165364, 11775.587854425054, 11795.528178872835, 11816.113791465588, 11820.468078936468, 10066.547005384775, 10089.293749437542, 10253.692389228336, 10796.568137274578, 10998.725031874266, 8906.86639700405, 9157.496337701425, 9293.395929264576, 9593.944666086725, 9711.320207585472, 3156.2740569668877, 3229.2572708276994, 3262.4453842846538, 3290.917727056819, 3305.619853716805, 39249.41125883114, 39789.40315895264, 40052.399214012104, 40292.19415611671, 40332.0, 9330.300227482965, 9373.203277721334, 9388.34281600295, 9408.482533460725, 9448.57481413338, 15332.233388330538, 15339.309731062129, 15342.463013794464, 15361.155136467378, 15361.846381536265, 6262.15460912771, 6313.9368606314265, 6416.4225219729515, 6463.224413070461, 6476.31998640136, 3167.920801979969, 3277.7301619543496, 3340.315235376742, 3342.615599206074, 3365.4110530657526, 2694.8383097014244, 2721.6053672217417, 2724.82288651237, 2727.0046433051793, 2727.5635898256182, 480.05668860688917, 489.8310083021352, 493.437481271351, 495.8760309922519, 505.8710028942596, 388.1402693034885, 393.9507561554806, 406.9886332463825, 439.01879299765, 472.29156265601597, 6434.292227854932, 6451.452496742887, 6478.125453063871, 6633.834154146185, 6641.203055633258, 390.03271885723564, 442.9689921705514, 482.36568911880767, 540.2922171954751, 579.9494658098432, 3079.414911166871, 3186.2193762528327, 3267.6732326767133, 3270.2898009020646, 3287.474004159371, 47094.76452617784, 47340.28989565159, 47467.0, 47511.0, 48493.515064849606, 39676.40485392721, 39691.60308396879, 39762.801185993885, 39863.800680996406, 40116.59883401129, 37182.0, 38899.80550097288, 39339.2132157361, 39363.60636393657, 39454.21091578152, 6610.0, 6677.499187560855, 6734.730610775514, 6848.417884479875, 6878.621675807879, 30678.84660576772, 31041.379172415975, 31360.843195783877, 31424.0, 31761.523577145897, 36046.819765901004, 36120.27759444849, 36629.0, 39313.0, 39536.40695389629, 9460.763480913032, 9522.85715714251, 9573.664921727706, 9739.172170365599, 9841.852372214566, 11205.215634905479, 11330.830037549607, 11357.432128393382, 11359.432028398713, 11380.260283081574, 9306.813863722553, 9328.113829186488, 9368.15686588183, 9728.367656102331, 10050.0, 9568.330216884751, 9747.415155090717, 9955.071884983967, 10058.195344372287, 10366.688999330032, 9103.089691030844, 9178.26573874075, 9187.356885017985, 9193.172614464464, 9208.3093767969, 8973.82052358936, 9124.361294709306, 9290.303227258119, 9295.209907157967, 9307.674231401868, 8173.959130204311, 8546.78633034179, 8560.828783424422, 8590.957045214735, 8654.48073115615], "unit": "score", "name": "yui.html", "value": 5418.108148219142}], "name": "dromaeo_css", "value": 6059.405216269182}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 112.0, 112.0, 113.0, 103.0, 111.0, 110.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 151.0, 169.0, 138.0, 156.0, 156.0, 128.0, 167.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 159.0, 160.0, 161.0, 162.0, 164.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 81.0, 92.0, 75.0, 71.0, 71.0, 91.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 134.0, 97.0, 97.0, 98.0, 138.0, 97.0, 97.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 71.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 69.0, 69.0, 74.0, 69.0, 70.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [93.0, 86.0, 85.0, 87.0, 85.0, 91.0, 85.0, 88.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 128.0, 124.0, 127.0, 122.0, 121.0, 121.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 146.0, 150.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1526.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "DeltaBlue", "value": 348.97080399999993}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [810.3727714748784], "unit": "score", "name": "Earley", "value": 822.4153420000002}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19710.389736966656}]} 18:39:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19710.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1526.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6059.40"}}} 18:39:40 INFO - Return code: 0 18:39:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:39:40 INFO - # TBPL SUCCESS # 18:39:40 INFO - Running post-action listener: _resource_record_post_action 18:39:40 INFO - Running post-run listener: _resource_record_post_run 18:39:41 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545505280; Read time: 52; Write time: 330020 18:39:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 228540416; Read time: 0; Write time: 164852 18:39:41 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316964864; Read time: 52; Write time: 165168 18:39:41 INFO - Running post-run listener: _upload_blobber_files 18:39:41 INFO - Blob upload gear active. 18:39:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:41 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 18:39:41 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:41 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:42 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:42 INFO - (blobuploader) - INFO - Done attempting. 18:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:43 INFO - (blobuploader) - INFO - Done attempting. 18:39:43 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:43 INFO - Return code: 0 18:39:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/540ab5d086db32970d4c3cfe741c0ba5e6d175b6a1920ac8a0a2f60f4c85b9c7d792120f805a81715bfedfaf57e8279b270cc7f08d02657ffe545c8beabe35fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6790071e81703e56f2a78bac52bc8d1a22c207e4f6e5e3f5de0ac741f5e0ccba617237c6a3420a3275be45e89937e4609f0145e064539707148e9e7f46f53d6e"} 18:39:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:43 INFO - Contents: 18:39:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/540ab5d086db32970d4c3cfe741c0ba5e6d175b6a1920ac8a0a2f60f4c85b9c7d792120f805a81715bfedfaf57e8279b270cc7f08d02657ffe545c8beabe35fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6790071e81703e56f2a78bac52bc8d1a22c207e4f6e5e3f5de0ac741f5e0ccba617237c6a3420a3275be45e89937e4609f0145e064539707148e9e7f46f53d6e"} 18:39:43 INFO - Copying logs to upload dir... 18:39:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.262426 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-29 18:39:43.006660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 18:39:43.010731) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/540ab5d086db32970d4c3cfe741c0ba5e6d175b6a1920ac8a0a2f60f4c85b9c7d792120f805a81715bfedfaf57e8279b270cc7f08d02657ffe545c8beabe35fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6790071e81703e56f2a78bac52bc8d1a22c207e4f6e5e3f5de0ac741f5e0ccba617237c6a3420a3275be45e89937e4609f0145e064539707148e9e7f46f53d6e"} build_url:https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/cVPw6BcER524dwJzi6TSVg/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/B2G-Inbound-Non-PGO/sha512/540ab5d086db32970d4c3cfe741c0ba5e6d175b6a1920ac8a0a2f60f4c85b9c7d792120f805a81715bfedfaf57e8279b270cc7f08d02657ffe545c8beabe35fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/6790071e81703e56f2a78bac52bc8d1a22c207e4f6e5e3f5de0ac741f5e0ccba617237c6a3420a3275be45e89937e4609f0145e064539707148e9e7f46f53d6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 18:39:43.041560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:39:43.041934) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451437715.786390-504163202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 18:39:43.127065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 18:39:43.127577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 18:39:43.128098) ========= ========= Total master_lag: 0.23 =========