builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1451395764.18 results: success (0) buildid: 20151229034039 builduid: ab1b06b9b77e4eb88b9b756091788924 revision: b50e4b404973b62b34bf4a182d7bd9990b654b8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.184254) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.184692) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.185040) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.208519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.208805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.228897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.229167) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.277553) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.277814) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.278149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.278417) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 05:29:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.6M=0s 2015-12-29 05:29:25 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155580 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.446234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.446546) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022462 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:24.496012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 05:29:24.496379) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b50e4b404973b62b34bf4a182d7bd9990b654b8a --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 b50e4b404973b62b34bf4a182d7bd9990b654b8a --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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 05:29:25,279 truncating revision to first 12 chars 2015-12-29 05:29:25,279 Setting DEBUG logging. 2015-12-29 05:29:25,279 attempt 1/10 2015-12-29 05:29:25,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b50e4b404973?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 05:29:26,338 unpacking tar archive at: b2g-inbound-b50e4b404973/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-29 05:29:25.811880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:25.812196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:25.821068) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:25.821365) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 05:29:25.821773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-29 05:29:25.822071) ========= /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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:26 INFO - MultiFileLogger online at 20151229 05:29:26 in /builds/slave/test 05:29: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 05:29:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:26 INFO - {'append_to_log': False, 05:29:26 INFO - 'base_work_dir': '/builds/slave/test', 05:29:26 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 05:29:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:26 INFO - 'branch': 'B2G-Inbound-Non-PGO', 05:29:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:26 INFO - 'config_files': ('talos/linux_config.py',), 05:29:26 INFO - 'default_actions': ('clobber', 05:29:26 INFO - 'read-buildbot-config', 05:29:26 INFO - 'download-and-extract', 05:29:26 INFO - 'populate-webroot', 05:29:26 INFO - 'create-virtualenv', 05:29:26 INFO - 'install', 05:29:26 INFO - 'run-tests'), 05:29:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:26 INFO - 'download_minidump_stackwalk': True, 05:29:26 INFO - 'download_symbols': 'ondemand', 05:29:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:26 INFO - 'installer_path': 'installer.exe', 05:29:26 INFO - 'log_level': 'info', 05:29:26 INFO - 'log_name': 'talos', 05:29:26 INFO - 'log_to_console': True, 05:29:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:26 INFO - 'opt_config_files': (), 05:29:26 INFO - 'pip_index': False, 05:29:26 INFO - 'sps_profile': False, 05:29:26 INFO - 'sps_profile_interval': 0, 05:29:26 INFO - 'suite': 'dromaeojs', 05:29:26 INFO - 'system_bits': '32', 05:29:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:26 INFO - 'title': 'talos-linux64-ix-024', 05:29:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:26 INFO - 'use_talos_json': True, 05:29:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:26 INFO - 'work_dir': 'build'} 05:29:26 INFO - ##### 05:29:26 INFO - ##### Running clobber step. 05:29:26 INFO - ##### 05:29:26 INFO - Running pre-action listener: _resource_record_pre_action 05:29:26 INFO - Running main action method: clobber 05:29:26 INFO - rmtree: /builds/slave/test/build 05:29:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:27 INFO - Running post-action listener: _resource_record_post_action 05:29:27 INFO - ##### 05:29:27 INFO - ##### Running read-buildbot-config step. 05:29:27 INFO - ##### 05:29:27 INFO - Running pre-action listener: _resource_record_pre_action 05:29:27 INFO - Running main action method: read_buildbot_config 05:29:27 INFO - Using buildbot properties: 05:29:27 INFO - { 05:29:27 INFO - "project": "", 05:29:27 INFO - "product": "firefox", 05:29:27 INFO - "script_repo_revision": "production", 05:29:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 05:29:27 INFO - "repository": "", 05:29:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 05:29:27 INFO - "buildid": "20151229034039", 05:29:27 INFO - "pgo_build": "False", 05:29:27 INFO - "basedir": "/builds/slave/test", 05:29:27 INFO - "buildnumber": 803, 05:29:27 INFO - "slavename": "talos-linux64-ix-024", 05:29:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:29:27 INFO - "platform": "ubuntu64_hw", 05:29:27 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 05:29:27 INFO - "branch": "b2g-inbound", 05:29:27 INFO - "repo_path": "integration/b2g-inbound", 05:29:27 INFO - "revision": "b50e4b404973b62b34bf4a182d7bd9990b654b8a", 05:29:27 INFO - "stage_platform": "linux64", 05:29:27 INFO - "builduid": "ab1b06b9b77e4eb88b9b756091788924", 05:29:27 INFO - "slavebuilddir": "test" 05:29:27 INFO - } 05:29:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:29:27 INFO - Running post-action listener: _resource_record_post_action 05:29:27 INFO - ##### 05:29:27 INFO - ##### Running download-and-extract step. 05:29:27 INFO - ##### 05:29:27 INFO - Running pre-action listener: _resource_record_pre_action 05:29:27 INFO - Running main action method: download_and_extract 05:29:27 INFO - mkdir: /builds/slave/test/build/tests 05:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:27 INFO - https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/test_packages.json 05:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/test_packages.json 05:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:29:29 INFO - Downloaded 1302 bytes. 05:29:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:29:29 INFO - Using the following test package requirements: 05:29:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'jsshell-linux-x86_64.zip'], 05:29:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:29 INFO - https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:30 INFO - Downloaded 21943040 bytes. 05:29:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:29:31 INFO - Return code: 0 05:29:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:29: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')]} 05:29:31 INFO - https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:29:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:33 INFO - Downloaded 21943040 bytes. 05:29:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:29:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:29:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:29:35 INFO - Return code: 0 05:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:35 INFO - https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:29:36 INFO - Downloaded 11132270 bytes. 05:29:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:29:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:29:37 INFO - Return code: 0 05:29: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')]} 05:29:37 INFO - https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:29:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:29:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:29:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:29:39 INFO - Downloaded 53335034 bytes. 05:29:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:29:39 INFO - mkdir: /builds/slave/test/properties 05:29:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:39 INFO - Contents: 05:29:39 INFO - build_url:https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:29:39 INFO - Running post-action listener: _resource_record_post_action 05:29:39 INFO - Running post-action listener: set_extra_try_arguments 05:29:39 INFO - ##### 05:29:39 INFO - ##### Running populate-webroot step. 05:29:39 INFO - ##### 05:29:39 INFO - Running pre-action listener: _resource_record_pre_action 05:29:39 INFO - Running main action method: populate_webroot 05:29:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:39 INFO - '--tppagecycles', 05:29:39 INFO - '7'], 05:29:39 INFO - 'tests': ['tsvgm']}}, 05:29:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['damp', 'tps']}, 05:29:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['damp', 'tps']}, 05:29:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:39 INFO - 'other': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other_l64': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:39 INFO - 'ts_paint', 05:29:39 INFO - 'tpaint', 05:29:39 INFO - 'sessionrestore', 05:29:39 INFO - 'sessionrestore_no_auto_restore']}, 05:29:39 INFO - 'svgr': {'tests': ['tsvgx', 05:29:39 INFO - 'tsvgr_opacity', 05:29:39 INFO - 'tart', 05:29:39 INFO - 'tscrollx', 05:29:39 INFO - 'cart']}, 05:29:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tsvgx', 05:29:39 INFO - 'tsvgr_opacity', 05:29:39 INFO - 'tart', 05:29:39 INFO - 'tscrollx', 05:29:39 INFO - 'cart']}, 05:29:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'tests': ['tp5o']}, 05:29:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s'], 05:29:39 INFO - 'tests': ['tp5o']}, 05:29:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--xperf_path', 05:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:39 INFO - 'tests': ['tp5n']}, 05:29:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:39 INFO - 'talos_options': ['--e10s', 05:29:39 INFO - '--xperf_path', 05:29:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:39 INFO - 'tests': ['tp5n']}}, 05:29:39 INFO - 'talos.zip': {'path': '', 05:29:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:39 INFO - Running post-action listener: _resource_record_post_action 05:29:39 INFO - ##### 05:29:39 INFO - ##### Running create-virtualenv step. 05:29:39 INFO - ##### 05:29:39 INFO - Running pre-action listener: _resource_record_pre_action 05:29:39 INFO - Running main action method: create_virtualenv 05:29:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:29:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:39 INFO - Using real prefix '/usr' 05:29:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:41 INFO - Installing pip.................done. 05:29:41 INFO - Return code: 0 05:29:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:41 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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:29:41 INFO - Using env: {'DISPLAY': ':0', 05:29:41 INFO - 'HOME': '/home/cltbld', 05:29:41 INFO - 'LANG': 'en_US.UTF-8', 05:29:41 INFO - 'LANGUAGE': 'en_US:en', 05:29:41 INFO - 'LOGNAME': 'cltbld', 05:29:41 INFO - 'MAIL': '/var/mail/cltbld', 05:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:41 INFO - 'MOZ_NO_REMOTE': '1', 05:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:41 INFO - 'NO_EM_RESTART': '1', 05:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:41 INFO - 'PWD': '/builds/slave/test', 05:29:41 INFO - 'SHELL': '/bin/bash', 05:29:41 INFO - 'SHLVL': '1', 05:29:41 INFO - 'TERM': 'linux', 05:29:41 INFO - 'TMOUT': '86400', 05:29:41 INFO - 'USER': 'cltbld', 05:29:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:41 INFO - '_': '/tools/buildbot/bin/python'} 05:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:29:41 INFO - Cleaning up... 05:29:41 INFO - Return code: 0 05:29:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:41 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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:29:41 INFO - Using env: {'DISPLAY': ':0', 05:29:41 INFO - 'HOME': '/home/cltbld', 05:29:41 INFO - 'LANG': 'en_US.UTF-8', 05:29:41 INFO - 'LANGUAGE': 'en_US:en', 05:29:41 INFO - 'LOGNAME': 'cltbld', 05:29:41 INFO - 'MAIL': '/var/mail/cltbld', 05:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:41 INFO - 'MOZ_NO_REMOTE': '1', 05:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:41 INFO - 'NO_EM_RESTART': '1', 05:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:41 INFO - 'PWD': '/builds/slave/test', 05:29:41 INFO - 'SHELL': '/bin/bash', 05:29:41 INFO - 'SHLVL': '1', 05:29:41 INFO - 'TERM': 'linux', 05:29:41 INFO - 'TMOUT': '86400', 05:29:41 INFO - 'USER': 'cltbld', 05:29:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:41 INFO - '_': '/tools/buildbot/bin/python'} 05:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:42 INFO - Downloading/unpacking psutil>=0.7.1 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:29:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:43 INFO - Installing collected packages: psutil 05:29:43 INFO - Running setup.py install for psutil 05:29:44 INFO - building 'psutil._psutil_linux' extension 05:29:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:29:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:29:44 INFO - building 'psutil._psutil_posix' extension 05:29:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:29:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:29:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:44 INFO - Successfully installed psutil 05:29:44 INFO - Cleaning up... 05:29:44 INFO - Return code: 0 05:29:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:44 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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:29:44 INFO - Using env: {'DISPLAY': ':0', 05:29:44 INFO - 'HOME': '/home/cltbld', 05:29:44 INFO - 'LANG': 'en_US.UTF-8', 05:29:44 INFO - 'LANGUAGE': 'en_US:en', 05:29:44 INFO - 'LOGNAME': 'cltbld', 05:29:44 INFO - 'MAIL': '/var/mail/cltbld', 05:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:44 INFO - 'MOZ_NO_REMOTE': '1', 05:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:44 INFO - 'NO_EM_RESTART': '1', 05:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:44 INFO - 'PWD': '/builds/slave/test', 05:29:44 INFO - 'SHELL': '/bin/bash', 05:29:44 INFO - 'SHLVL': '1', 05:29:44 INFO - 'TERM': 'linux', 05:29:44 INFO - 'TMOUT': '86400', 05:29:44 INFO - 'USER': 'cltbld', 05:29:44 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:44 INFO - '_': '/tools/buildbot/bin/python'} 05:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:29:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:29:46 INFO - Installing collected packages: mozsystemmonitor 05:29:46 INFO - Running setup.py install for mozsystemmonitor 05:29:46 INFO - Successfully installed mozsystemmonitor 05:29:46 INFO - Cleaning up... 05:29:46 INFO - Return code: 0 05:29:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:29:46 INFO - Using env: {'DISPLAY': ':0', 05:29:46 INFO - 'HOME': '/home/cltbld', 05:29:46 INFO - 'LANG': 'en_US.UTF-8', 05:29:46 INFO - 'LANGUAGE': 'en_US:en', 05:29:46 INFO - 'LOGNAME': 'cltbld', 05:29:46 INFO - 'MAIL': '/var/mail/cltbld', 05:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:46 INFO - 'MOZ_NO_REMOTE': '1', 05:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:46 INFO - 'NO_EM_RESTART': '1', 05:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:46 INFO - 'PWD': '/builds/slave/test', 05:29:46 INFO - 'SHELL': '/bin/bash', 05:29:46 INFO - 'SHLVL': '1', 05:29:46 INFO - 'TERM': 'linux', 05:29:46 INFO - 'TMOUT': '86400', 05:29:46 INFO - 'USER': 'cltbld', 05:29:46 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:46 INFO - '_': '/tools/buildbot/bin/python'} 05:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:29:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:29:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:29:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:49 INFO - Downloading docopt-0.6.1.tar.gz 05:29:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:29:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:29:49 INFO - Running setup.py install for blobuploader 05:29:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:29:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:29:49 INFO - Running setup.py install for requests 05:29:49 INFO - Running setup.py install for docopt 05:29:49 INFO - Successfully installed blobuploader requests docopt 05:29:49 INFO - Cleaning up... 05:29:49 INFO - Return code: 0 05:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:49 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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:29:49 INFO - Using env: {'DISPLAY': ':0', 05:29:49 INFO - 'HOME': '/home/cltbld', 05:29:49 INFO - 'LANG': 'en_US.UTF-8', 05:29:49 INFO - 'LANGUAGE': 'en_US:en', 05:29:49 INFO - 'LOGNAME': 'cltbld', 05:29:49 INFO - 'MAIL': '/var/mail/cltbld', 05:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:49 INFO - 'MOZ_NO_REMOTE': '1', 05:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:49 INFO - 'NO_EM_RESTART': '1', 05:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:49 INFO - 'PWD': '/builds/slave/test', 05:29:49 INFO - 'SHELL': '/bin/bash', 05:29:49 INFO - 'SHLVL': '1', 05:29:49 INFO - 'TERM': 'linux', 05:29:49 INFO - 'TMOUT': '86400', 05:29:49 INFO - 'USER': 'cltbld', 05:29:49 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:49 INFO - '_': '/tools/buildbot/bin/python'} 05:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:50 INFO - Running setup.py (path:/tmp/pip-FRDMYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:50 INFO - Running setup.py (path:/tmp/pip-Px5j5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:50 INFO - Running setup.py (path:/tmp/pip-C6T42w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:50 INFO - Running setup.py (path:/tmp/pip-cBOWuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:50 INFO - Running setup.py (path:/tmp/pip-mecJq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:50 INFO - Running setup.py (path:/tmp/pip-T_Tuzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:50 INFO - Running setup.py (path:/tmp/pip-TSKsfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:50 INFO - Running setup.py (path:/tmp/pip-4O0kDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:50 INFO - Running setup.py (path:/tmp/pip-jOSHkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:50 INFO - Running setup.py (path:/tmp/pip-GZOvlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:50 INFO - Running setup.py (path:/tmp/pip-udmv9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:50 INFO - Running setup.py (path:/tmp/pip-jU4lTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:50 INFO - Running setup.py (path:/tmp/pip-Wg_eON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:51 INFO - Running setup.py (path:/tmp/pip-_t3uYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:51 INFO - Running setup.py (path:/tmp/pip-539F1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:51 INFO - Running setup.py (path:/tmp/pip-1PoHuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:51 INFO - Running setup.py (path:/tmp/pip-5otQ7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:29:51 INFO - Running setup.py install for manifestparser 05:29:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:29:51 INFO - Running setup.py install for mozcrash 05:29:51 INFO - Running setup.py install for mozdebug 05:29:51 INFO - Running setup.py install for mozdevice 05:29:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:29:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:29:51 INFO - Running setup.py install for mozfile 05:29:51 INFO - Running setup.py install for mozhttpd 05:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:29:51 INFO - Running setup.py install for mozinfo 05:29:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for mozInstall 05:29:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for mozleak 05:29:52 INFO - Running setup.py install for mozlog 05:29:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for moznetwork 05:29:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for mozprocess 05:29:52 INFO - Running setup.py install for mozprofile 05:29:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for mozrunner 05:29:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:29:52 INFO - Running setup.py install for mozscreenshot 05:29:52 INFO - Running setup.py install for moztest 05:29:53 INFO - Running setup.py install for mozversion 05:29:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:29:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:29:53 INFO - Cleaning up... 05:29:53 INFO - Return code: 0 05:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:29:53 INFO - Using env: {'DISPLAY': ':0', 05:29:53 INFO - 'HOME': '/home/cltbld', 05:29:53 INFO - 'LANG': 'en_US.UTF-8', 05:29:53 INFO - 'LANGUAGE': 'en_US:en', 05:29:53 INFO - 'LOGNAME': 'cltbld', 05:29:53 INFO - 'MAIL': '/var/mail/cltbld', 05:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:53 INFO - 'MOZ_NO_REMOTE': '1', 05:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:53 INFO - 'NO_EM_RESTART': '1', 05:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:53 INFO - 'PWD': '/builds/slave/test', 05:29:53 INFO - 'SHELL': '/bin/bash', 05:29:53 INFO - 'SHLVL': '1', 05:29:53 INFO - 'TERM': 'linux', 05:29:53 INFO - 'TMOUT': '86400', 05:29:53 INFO - 'USER': 'cltbld', 05:29:53 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:53 INFO - '_': '/tools/buildbot/bin/python'} 05:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:29:53 INFO - Running setup.py (path:/tmp/pip-p7dWqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:29:53 INFO - Running setup.py (path:/tmp/pip-38OlZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:29:53 INFO - Running setup.py (path:/tmp/pip-dqyKoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:29:53 INFO - Running setup.py (path:/tmp/pip-4NiIKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:29:53 INFO - Running setup.py (path:/tmp/pip-NNUOV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:29:53 INFO - Running setup.py (path:/tmp/pip-kQtevd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:29:53 INFO - Running setup.py (path:/tmp/pip-vwO201-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:29:53 INFO - Running setup.py (path:/tmp/pip-n361VO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:29:53 INFO - Running setup.py (path:/tmp/pip-c1XO3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:29:54 INFO - Running setup.py (path:/tmp/pip-eEwj7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:29:54 INFO - Running setup.py (path:/tmp/pip-ROWGYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:29:54 INFO - Running setup.py (path:/tmp/pip-idNhZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:29:54 INFO - Running setup.py (path:/tmp/pip-wbE8Wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:29:54 INFO - Running setup.py (path:/tmp/pip-RpoDHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:54 INFO - Running setup.py (path:/tmp/pip-41ZTGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:29:54 INFO - Running setup.py (path:/tmp/pip-KyOsuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:29:54 INFO - Running setup.py (path:/tmp/pip-gY0hKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:29:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:56 INFO - Downloading blessings-1.5.1.tar.gz 05:29:56 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:29:56 INFO - Installing collected packages: blessings 05:29:56 INFO - Running setup.py install for blessings 05:29:56 INFO - Successfully installed blessings 05:29:56 INFO - Cleaning up... 05:29:56 INFO - Return code: 0 05:29:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:56 INFO - Reading from file tmpfile_stdout 05:29:56 INFO - Current package versions: 05:29:56 INFO - argparse == 1.2.1 05:29:56 INFO - blessings == 1.5.1 05:29:56 INFO - blobuploader == 1.2.4 05:29:56 INFO - docopt == 0.6.1 05:29:56 INFO - manifestparser == 1.1 05:29:56 INFO - mozInstall == 1.12 05:29:56 INFO - mozcrash == 0.16 05:29:56 INFO - mozdebug == 0.1 05:29:56 INFO - mozdevice == 0.47 05:29:56 INFO - mozfile == 1.2 05:29:56 INFO - mozhttpd == 0.7 05:29:56 INFO - mozinfo == 0.9 05:29:56 INFO - mozleak == 0.1 05:29:56 INFO - mozlog == 3.1 05:29:56 INFO - moznetwork == 0.27 05:29:56 INFO - mozprocess == 0.22 05:29:56 INFO - mozprofile == 0.28 05:29:56 INFO - mozrunner == 6.11 05:29:56 INFO - mozscreenshot == 0.1 05:29:56 INFO - mozsystemmonitor == 0.0 05:29:56 INFO - moztest == 0.7 05:29:56 INFO - mozversion == 1.4 05:29:56 INFO - psutil == 3.1.1 05:29:56 INFO - requests == 1.2.3 05:29:56 INFO - wsgiref == 0.1.2 05:29:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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/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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29: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/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:29: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/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:29:56 INFO - Using env: {'DISPLAY': ':0', 05:29:56 INFO - 'HOME': '/home/cltbld', 05:29:56 INFO - 'LANG': 'en_US.UTF-8', 05:29:56 INFO - 'LANGUAGE': 'en_US:en', 05:29:56 INFO - 'LOGNAME': 'cltbld', 05:29:56 INFO - 'MAIL': '/var/mail/cltbld', 05:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:56 INFO - 'MOZ_NO_REMOTE': '1', 05:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:56 INFO - 'NO_EM_RESTART': '1', 05:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:56 INFO - 'PWD': '/builds/slave/test', 05:29:56 INFO - 'SHELL': '/bin/bash', 05:29:56 INFO - 'SHLVL': '1', 05:29:56 INFO - 'TERM': 'linux', 05:29:56 INFO - 'TMOUT': '86400', 05:29:56 INFO - 'USER': 'cltbld', 05:29:56 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:56 INFO - '_': '/tools/buildbot/bin/python'} 05:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:29:56 INFO - Cleaning up... 05:29:56 INFO - Return code: 0 05:29:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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', '--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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:29:56 INFO - Using env: {'DISPLAY': ':0', 05:29:56 INFO - 'HOME': '/home/cltbld', 05:29:56 INFO - 'LANG': 'en_US.UTF-8', 05:29:56 INFO - 'LANGUAGE': 'en_US:en', 05:29:56 INFO - 'LOGNAME': 'cltbld', 05:29:56 INFO - 'MAIL': '/var/mail/cltbld', 05:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:56 INFO - 'MOZ_NO_REMOTE': '1', 05:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:56 INFO - 'NO_EM_RESTART': '1', 05:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:56 INFO - 'PWD': '/builds/slave/test', 05:29:56 INFO - 'SHELL': '/bin/bash', 05:29:56 INFO - 'SHLVL': '1', 05:29:56 INFO - 'TERM': 'linux', 05:29:56 INFO - 'TMOUT': '86400', 05:29:56 INFO - 'USER': 'cltbld', 05:29:56 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:56 INFO - '_': '/tools/buildbot/bin/python'} 05:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:57 INFO - Downloading/unpacking jsonschema 05:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:29:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:29:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:29:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:29:59 INFO - warning: no files found matching '*.txt' 05:29:59 INFO - no previously-included directories found matching 'build' 05:29:59 INFO - no previously-included directories found matching 'dist' 05:29:59 INFO - no previously-included directories found matching '.git*' 05:29:59 INFO - Installing collected packages: jsonschema, functools32 05:29:59 INFO - Running setup.py install for functools32 05:29:59 INFO - warning: no files found matching '*.txt' 05:29:59 INFO - no previously-included directories found matching 'build' 05:29:59 INFO - no previously-included directories found matching 'dist' 05:29:59 INFO - no previously-included directories found matching '.git*' 05:29:59 INFO - Successfully installed jsonschema functools32 05:29:59 INFO - Cleaning up... 05:29:59 INFO - Return code: 0 05:29:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:59 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 0x7fda42a42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:29:59 INFO - Using env: {'DISPLAY': ':0', 05:29:59 INFO - 'HOME': '/home/cltbld', 05:29:59 INFO - 'LANG': 'en_US.UTF-8', 05:29:59 INFO - 'LANGUAGE': 'en_US:en', 05:29:59 INFO - 'LOGNAME': 'cltbld', 05:29:59 INFO - 'MAIL': '/var/mail/cltbld', 05:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:59 INFO - 'MOZ_NO_REMOTE': '1', 05:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:59 INFO - 'NO_EM_RESTART': '1', 05:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:59 INFO - 'PWD': '/builds/slave/test', 05:29:59 INFO - 'SHELL': '/bin/bash', 05:29:59 INFO - 'SHLVL': '1', 05:29:59 INFO - 'TERM': 'linux', 05:29:59 INFO - 'TMOUT': '86400', 05:29:59 INFO - 'USER': 'cltbld', 05:29:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:59 INFO - '_': '/tools/buildbot/bin/python'} 05:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:59 INFO - Downloading/unpacking flake8 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:30:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:30:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:30:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:30:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:01 INFO - no previously-included directories found matching 'docs/_build' 05:30:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:30:01 INFO - Running setup.py install for pep8 05:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:30:02 INFO - no previously-included directories found matching 'docs/_build' 05:30:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:30:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:30:02 INFO - Cleaning up... 05:30:02 INFO - Return code: 0 05:30:02 INFO - Running post-action listener: _resource_record_post_action 05:30:02 INFO - Running post-action listener: _start_resource_monitoring 05:30:02 INFO - Starting resource monitoring. 05:30:02 INFO - ##### 05:30:02 INFO - ##### Running install step. 05:30:02 INFO - ##### 05:30:02 INFO - Running pre-action listener: _resource_record_pre_action 05:30:02 INFO - Running main action method: install 05:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:02 INFO - Reading from file tmpfile_stdout 05:30:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:02 INFO - Reading from file tmpfile_stdout 05:30:02 INFO - Output received: 05:30:02 INFO - Usage: mozinstall [options] installer 05:30:02 INFO - Options: 05:30:02 INFO - -h, --help show this help message and exit 05:30:02 INFO - -d DEST, --destination=DEST 05:30:02 INFO - Directory to install application into. [default: 05:30:02 INFO - "/builds/slave/test"] 05:30:02 INFO - --app=APP Application being installed. [default: firefox] 05:30:02 INFO - mkdir: /builds/slave/test/build/application 05:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:30:17 INFO - Reading from file tmpfile_stdout 05:30:17 INFO - Output received: 05:30:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:17 INFO - Running post-action listener: _resource_record_post_action 05:30:17 INFO - ##### 05:30:17 INFO - ##### Running run-tests step. 05:30:17 INFO - ##### 05:30:17 INFO - Running pre-action listener: _resource_record_pre_action 05:30:17 INFO - Running main action method: run_tests 05:30:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:18 INFO - Python 2.7.3 05:30:18 INFO - Return code: 0 05:30:18 INFO - grabbing minidump binary from tooltool 05:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:18 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 0x23ed3d0>, '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 0x2358ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2359360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:30:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:30:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:18 INFO - Return code: 0 05:30:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:30:18 INFO - Return code: 0 05:30:18 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/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:30:18 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/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:30:19 INFO - Using env: {'DISPLAY': ':0', 05:30:19 INFO - 'HOME': '/home/cltbld', 05:30:19 INFO - 'LANG': 'en_US.UTF-8', 05:30:19 INFO - 'LANGUAGE': 'en_US:en', 05:30:19 INFO - 'LOGNAME': 'cltbld', 05:30:19 INFO - 'MAIL': '/var/mail/cltbld', 05:30:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:19 INFO - 'MOZ_NO_REMOTE': '1', 05:30:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:19 INFO - 'NO_EM_RESTART': '1', 05:30:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:19 INFO - 'PWD': '/builds/slave/test', 05:30:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:19 INFO - 'SHELL': '/bin/bash', 05:30:19 INFO - 'SHLVL': '1', 05:30:19 INFO - 'TERM': 'linux', 05:30:19 INFO - 'TMOUT': '86400', 05:30:19 INFO - 'USER': 'cltbld', 05:30:19 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467', 05:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:19 INFO - '_': '/tools/buildbot/bin/python'} 05:30:19 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/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:30:19 INFO - mozversion application_buildid: 20151229034039 05:30:19 INFO - mozversion application_changeset: b50e4b404973b62b34bf4a182d7bd9990b654b8a 05:30:19 INFO - mozversion application_display_name: Nightly 05:30:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:19 INFO - mozversion application_name: Firefox 05:30:19 INFO - mozversion application_remotingname: firefox 05:30:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 05:30:19 INFO - mozversion application_vendor: Mozilla 05:30:19 INFO - mozversion application_version: 46.0a1 05:30:19 INFO - mozversion platform_buildid: 20151229034039 05:30:19 INFO - mozversion platform_changeset: b50e4b404973b62b34bf4a182d7bd9990b654b8a 05:30:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 05:30:19 INFO - mozversion platform_version: 46.0a1 05:30:19 INFO - using testdate: 1451395819 05:30:19 INFO - actual date: 1451395819 05:30:19 INFO - starting webserver on 'localhost:47320' 05:30:19 INFO - SUITE-START | Running 3 tests 05:30:19 INFO - TEST-START | dromaeo_css 05:30:19 INFO - operating with platform_type : linux_ 05:30:19 INFO - Initialising browser for dromaeo_css test... 05:30:19 INFO - TEST-INFO | started process 14736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7DC5P/profile http://localhost:47320/getInfo.html) 05:30:23 INFO - PROCESS | 14736 | __metrics Screen width/height:1600/1200 05:30:23 INFO - PROCESS | 14736 | colorDepth:24 05:30:23 INFO - PROCESS | 14736 | Browser inner width/height: 1024/697 05:30:23 INFO - PROCESS | 14736 | __metrics 05:30:23 INFO - PROCESS | 14736 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:30:23 INFO - PROCESS | 14736 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:24 INFO - TEST-INFO | 14736: exit 0 05:30:24 INFO - Browser initialized. 05:30:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:24 INFO - TEST-INFO | started process 14829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG7DC5P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:36 INFO - PROCESS | 14829 | RSS: Main: 148316160 05:30:36 INFO - PROCESS | 14829 | 05:31:27 INFO - PROCESS | 14829 | 1451395887360 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:33:39 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47320/tests/dromaeo/cssquery-ext.html) 05:33:40 INFO - PROCESS | 14829 | RSS: Main: 254377984 05:33:40 INFO - PROCESS | 14829 | 05:36:43 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-ext.html (next: http://localhost:47320/tests/dromaeo/cssquery-jquery.html) 05:36:43 INFO - PROCESS | 14829 | RSS: Main: 232484864 05:36:43 INFO - PROCESS | 14829 | 05:39:45 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47320/tests/dromaeo/cssquery-mootools.html) 05:39:46 INFO - PROCESS | 14829 | RSS: Main: 229380096 05:39:46 INFO - PROCESS | 14829 | 05:42:48 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47320/tests/dromaeo/cssquery-prototype.html) 05:42:48 INFO - PROCESS | 14829 | RSS: Main: 215347200 05:42:48 INFO - PROCESS | 14829 | 05:45:51 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47320/tests/dromaeo/cssquery-yui.html) 05:45:52 INFO - PROCESS | 14829 | RSS: Main: 216702976 05:45:52 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | Cycle 1(1): loaded http://localhost:47320/tests/dromaeo/cssquery-yui.html (next: http://localhost:47320/tests/dromaeo/cssquery-dojo.html) 05:48:54 INFO - PROCESS | 14829 | RSS: Main: 263557120 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | __start_tp_report 05:48:54 INFO - PROCESS | 14829 | _x_x_mozilla_page_load 05:48:54 INFO - PROCESS | 14829 | _x_x_mozilla_page_load_details 05:48:54 INFO - PROCESS | 14829 | |i|pagename|runs| 05:48:54 INFO - PROCESS | 14829 | |0;dojo.html;2613.163787587972;2703.256604433779;2704.891804327827;2715.416185520114;2731.399092199715;4450;4574.336721175428;4621.168189725852;4658.208104622214;4670.743109128996;4634.976825115869;4672.97663511682;4721.740304283263;4725.196716558185;4786.186348320785;4291.914161716763;4304.160688665712;4322.07075478772;4323.070539833935;4337.1325734853;4207.72649777765;4396.318570621559;4404.185225733234;4450.688451808374;4467.24056910326;4298.570142985692;4303.892402689927;4319.719218250803;4404.69167158299;4414.624756895668;4280.6361459275995;4281.593248641405;4282.272013757669;4298.763568003758;4322.610965013132;4260.659147268211;4277.935830962538;4278.893027674302;4315.43899293093;4330.696851220416;4444.799984000695;4539.954600454019;4574.588287054148;4634.443866735979;4773.0453909218295;5056.367954005749;5062;5063.0380227756605;5066.138756411419;5066.392032956032;5070.989889769719;5083.491650834924;5084.110280700863;5087.058894104603;5117.181250999859;4502.549745025472;4599.08018396322;4601.102784956968;4660.067986402733;4694.43666759991;5171.50870667286;5176.456472070454;5177.042247184283;5178.81874134411;5206.427292997767;4953.925691114636;4959.20652695567;4959.950400496021;4965.404151501771;5002.149634562061;4861.611071114373;4978.502149784992;4980.551750342414;4993.725345106054;5052.595792336604;4968.031233909425;4969.0310389474425;4972.8508144755715;4974.328465657162;4982.551570358685;4927.605791536668;4933.901321973541;4938.802447902115;4940.382452193476;4989.151844186497;4097.569755175723;4166.500019997619;4169.374593810952;4193.30810416284;4265.97867010663;3697.685696715809;3703.203811180609;3720.6465385788306;3728.7203459740626;3752.699784017272;4295.119500502452;4295.634871035934;4304.763238021939;4340.956590434118;4344.978929951459;4805.879853003633;4913.31213630092;4917.65576409655;5026.773795179226;5035.370578677665;4255.4255175551525;4297.742135471819;4335.523092459827;4357.934630980538;4376.146651402946;4499.842505512292;4509.12072145935;4509.413776209138;4519.728816271035;4564.338170965191;4578.65660075489;4688.624910007123;4694.812207511662;4790.0180463005;4792.2092854678585;4960.355153829979;5022.070916880389;5040.218766091261;5042.09242336383;5085.593152547861;4821.951780482291;4833.081714474239;4836.879078023077;4841.806327746992;4884.169691152583;4812.783424745825;4919.926201107058;4925.852224433273;5016.122178618654;5068.771905264198;4980.701157930535;5024.723640199824;5043.2939388486375;5043.44522102561;5089.931114466003;4870.683405578768;4877.926831097608;4884.267359896044;4885.8045678172475;4925.039617274597;4691.296305554194;4758.833440829693;4810.7113573185725;4862.92705609409;4908.460069392436;4737.644676649334;4784.091022705675;4789.114013907439;4805.183118869731;4856.732879691651;4901.975490122527;4903.141950158637;4903.7302948336755;4933.383327084114;4942.505749425029;4598.126355992351;4716.504766999553;4723.4331880174595;4788.904221915473;4831.154547954165 05:48:54 INFO - PROCESS | 14829 | |1;ext.html;503.60718639461214;508.95928325733945;521.3170746322315;524.6930545630805;545.7544105152682;25190;25650.486990260208;25701;32477.837610811912;32745.34509309818;36586.4512032319;36968.44547331786;37087.4436883447;37144.814275928584;37159.62840371596;7473.476856620039;7613.390928725717;7625.084989801204;7638.197989211136;7647.426443016768;7029.156501219861;7207.171175314854;9707.417554946725;9885.060919212663;9897.4556399398;9604.711858644252;9729.513524323791;9741;9742.951285243564;9745.220382369393;6882.8623427531165;7075.2217256101785;9601.087896649808;9773.680553125309;9778.706638800848;6955.374016338554;7105.182903966059;7108;9699.612015519371;9936.205103591696;31957;32464.513032304534;32534.18664533382;32579.83710081458;32691.50962735561;2602.8047896407843;2674.638923745289;2705.9052933147245;2961.978117549442;3051.61854768154;28375.109066391753;28785.85607071972;28849.278768030756;28853;29232.853835730686;3281.868725250987;3293.55537002504;3313.801171929692;3320.7509436792097;3350.4471762159214;208910;209088;209158;209877;210101;46467.76766116148;48874.75562622164;49025;49040.5095949036;49145.26282105771;41518.58481415208;58533.41466585365;59981.70009149926;60050.49368828897;60265;11747.29516229029;11758.94120529409;11796.174267801343;11823.349715765544;11835.940820295844;9357.064293570724;9488.478133702574;9494.667686630935;9502.47736374506;9505.144536991704;18009.819901801075;18905.432837014912;19034.61930761377;19097.61804763897;19107.23571057142;7259.745908893164;7615.314621684075;7759.495632783851;7782.377409807202;7808;831.4553967151526;831.7130589946458;857.5840717252128;920.5075284722775;1014.5586669798661;26649.866750666122;28419.71580284212;29954.25114372158;30256.394872102435;30558;914.3964983111115;922.9723108306762;942.835003874333;1033.302520798458;1073.8281874900135;12929.094963352663;14311.427542898376;14996.625084372978;15234.314455849513;15278.847211527966;245508;253599;254143;254278;254601;38992.220155596726;38992.80503597464;39145.804270978464;39409.60590394117;39429.40855887164;1111.9499622517005;1116.8548088748412;1117.9273347232404;1128.1313388690662;1160.9071274298205;24705.382365441008;25713.100041499205;26174.34564135912;26177.607335889596;26186.345341366618;37126.44310335293;37545.81227093847;37597;37617.81191094027;39405.2118957625;143369.28315358356;308208;314989;317393;319588;24645.87677061675;25181.24456266315;25185;25209.621855672547;25309;38934.6106538931;39217.6078239214;39243.80378098205;40016.59983400245;40262;33137.33725325528;33384.83307583447;33806.49290260599;34421;34842.47736284009;32814.34371312608;33875.49186762151;33911.66088339085;34100.488492673125;34103;33220.667793322726;33892.15269618181;34027.65972340344;34151.31697366088;34155.4876676855;28885.133445996653;30819;30828.69171308348;30916;31066.378672426876;23872;24074.39814004664;24095.879520602284;24388.146414875395;24502 05:48:54 INFO - PROCESS | 14829 | |2;jquery.html;335.882441145599;337.65390474763365;338.7764075710032;339.65355337555695;341.55427167546344;12385;12711.110222284444;14585.781213281809;14749.041312314705;15148.46980355689;12458.937705311484;14177.574672759834;14525.709485810277;15068.623284417896;15105.848941510581;4432.601065904068;4671.766411679419;4788.569028787409;4921.18800397934;4929.580985616209;4910.705357678533;4964;4966.130927087764;4966.528179822911;4969.975150124263;4798.496157903405;4878.780454879539;4898.14282500561;4927.827526036589;5013.448520662724;4982.551570358667;4994.525520075587;5012.799488020475;5027.220780778966;5030;4452.510223875371;4455.977720111378;4461.442319710036;4470.284754439274;4472.686911916167;10981.670549883516;11137.610183643614;16221.513354599381;16553.119328831115;16800.32798688051;1643.6959162554965;1644.925978330966;1645.0129922046797;1694.9915250423792;1769.539919620895;8617.965844098748;8786.912130878738;10381.429021403896;11393.54425822966;11618.593349232737;1614.5075751895668;1718.4243278501717;1722.5521364445335;1742.634046850163;1749.0380290839987;52330.21504677433;54160.18759718607;54610;55128.0384765369;55177.44822551763;9674.322797404115;9787.706368808947;9788.804223915482;9797.510124493747;9872.35829671069;10131.240156988255;10917.126629869592;11202.319652052094;12439;12460.376981150906;5635.380108188096;5637.43625637433;5640.576956728261;5665.886682266414;5844.47399734026;5143.5627971622835;5172.508611681884;5187.546699875467;5221.190715439113;5281.867953301198;3392;3535.2399234164777;3555.5022296878456;3610.837512311952;3685.8341374638208;1623;1678.932842686279;1714.5597697933795;1737.4961261234353;1754.1843042985074;393.3254468586388;396.738152819138;408.85485652593496;825.2861274997084;838.6938767349874;8855.51294678786;9263.722088337361;9371.297152713574;9530.809383812284;9578.473183974947;380.5718566612561;382.2488809489311;385.21608526648134;390.9296326661228;391.7531954868415;4590.311453281967;5058.595312375001;5148.279240906276;5378.220158077057;5429.945700542944;496203;515231;548042;548853;550797;52536.211956820676;68562;69704;71638.28361716316;72776.27223727695;389.8966773804944;392.39766957719763;413.2582015282575;415.16551731020263;419.02785537552586;8778;8903.688370906988;8911.06433824465;9016.504092274989;9082.909170908206;31304.373912521165;31862.362752745277;31886;32257.67742322547;33167;40570;42761;42901.78549107235;43530.56469435265;45530.77234613806;8112.472689275178;8232.50604963704;8367.28878045373;8390.119037500974;8442.240198382175;9751.658691945748;9844.655437059668;9902.801943960936;9927.305088644014;9968.202543796333;10150.847737283799;12157.878421215675;12204.38978051076;13503.324833758077;13675.79486307726;13387.799183012068;13402.798958015443;13485.595432137052;13833.446662133805;13850.86149138536;12679;12695.111342206326;12828.56257311108;13327.533536326182;13632.454701811816;8467.110953350057;8476.576171191538;8510.276626486819;8617.913820861711;8774.429662071945;11893.286402815858;12852.678683032998;12966.35168241603;13359;13598.86401135976 05:48:54 INFO - PROCESS | 14829 | |3;mootools.html;1142.0535019649305;1145.3700464744388;1166.416791604198;1213.696575856036;1661.3022530537166;5883.205767221424;6947.30526947305;7058.364747172754;7069.293070692928;7090.78727638171;6672.633005184713;6838.3161683831595;6853.828654283633;6868.62222577758;6868.82827929302;1748.0647853398434;1761.779777527809;1762.2510433065959;2050.2311633137538;2087.4781304673834;1764.5765016396037;1773.1754734048666;2074.460640233535;2099.748030236366;2107.3677896631025;2040.2043203150783;2044.4071219346372;2045.1103769860158;2045.8772473651554;2046.1610739596695;1994.2023190723683;2044.72396226509;2048.5902819436096;2048.6414877396546;2053.219776484934;2030.4720772599082;2032.7763945965933;2050.241410678059;2061.391889392633;2062.257587268582;7155;7210.2789721028;7221.855562888765;7224;7228.096487939008;4131.8967025824295;4195;4207.97896010518;4209.2633789087095;4211.220924129046;2707.390837061665;2712.2541301142146;2714.7285271472892;2746.1761471558652;2790.8465034423098;868.891388576428;870.2124577257592;896.3143195455482;914.236612428623;914.6965574056942;9334.71995840126;9357.532123393803;9369.109934556207;9373.343865929388;9383.108604682544;3764.642358975893;3805.8667946621736;3842.2315536892734;3880.0881792778673;3889.824957876846;7838;7838.176991415819;7841.294283514511;7864.685412583547;7871.567063811431;4153.709240353207;4155.459790227251;4173.4157217989505;4175.498940127204;4190.182914331676;3797.4303854421505;3827.483289755903;3835.9808200959374;3841.1741475582885;3842.8078596070086;3349.363620912019;3349.916252093717;3368.4778859276853;3393.406153923103;3397.3205358928312;944.3483996042709;965.9227261819037;1090.220492347975;1101.6805126513382;1108.2187058124002;865.7662431143556;886.2821114896955;887.6449420231959;890.1543533642936;918.6555041859302;6656.201255849232;6733.528652994341;6741.7303307868115;6743;6747.561408508432;989.618996686281;1013.7871047080196;1023.9078482936422;1026.1175389165312;1028.4292217819032;5228.63399562027;5257.7896884124975;5263.7104959226845;5266.499682530153;5277.604179686462;8450.535220562806;8496.957515212385;8650.653973841101;8718.825623487495;8749.300055995505;8635.870461943075;8689.56552172389;8692.087330830298;8712;8745.91254087451;6599.967000164968;6697.531172817856;6744.460443164535;6780.593164410151;6783.287754785676;6427.58220715652;6435.22777266731;6457.354264573505;6467.514936379885;6483.4164925156965;7141.9642901785155;7360.742374016883;7404.074490688664;7728.652210650646;7845.411594130577;7387.261273872569;7498.812529686801;7528.096628404407;7987.201279871966;8037.196280371916;6365.777197798055;6470.352964703492;6478.481721462366;6479.2224933006455;6479.352064793483;5689.459501347365;6464.741410343534;6483.494174560101;7000.719971201299;7012.824679383056;5469.070258056219;6218;6249.0626406039455;6255.24937007562;6346.809595712136;6241.126242326169;6267.091271765659;6317.178766760292;6356.618602883842;6363.204599425072;6381.074744162163;6408.455281301141;6412.871742565216;6416.967915160394;6424.229092508929;5633.267675202197;5707.828765137053;5712.314522257356;5725.8568535786935;5806.767729290781;5986.760529578943;5991.88016239664;6006;6029.849253768515;6031.276246850406 05:48:54 INFO - PROCESS | 14829 | |4;prototype.html;302.40577265672954;309.14675495632054;313.50153256322443;322.5661485302269;325.9771815972883;5307.124324486455;5381.058314794915;5417.349918009834;5419.75611097501;5419.864503387413;5317.069512835258;5332.653377530468;5334.773002209494;5340.412554618999;5349.170878513827;3975.602439756016;4065.8373665053364;4200.663946884242;4212.53662097169;4222.218889505443;4090.059286364123;4129.463169787923;4157.0646604513895;4173.56177601352;4175.686823488235;4120.031792528754;4120.217158739845;4125.64931980782;4130.607592278729;4130.814113364906;3946.151577410856;4017.2568074905944;4042.7776472294013;4123.752574845519;4132.070284186064;3633.854645814164;3653.2328211075705;3655.122770535079;3660.7803531788177;3661.56061272649;5082.3138876251605;5133.948660513422;5135.6148288878485;5171.50870667286;5171.689698618095;4799.208130658437;4811.398575178103;4814.927776083362;4817.78319975602;4824.6863953842885;5483.972580137113;5611.410801865827;5630.15547667849;5630.268065151545;5630.465105814941;4006.959930400688;4010.6590939770153;4015.7992100394863;4019.135885784541;4024.5371782245124;5912.970435147797;5918.201042859202;5924.229850119457;5926.6444013358905;5930.7034648267845;4150.128473020639;4156.147989662112;4157.376393540993;4160.791960402028;4177.373393990925;4121.5878412159145;4197.391378250137;4210.642095421862;4218.704690671623;4242.109157077049;4759.547842954914;4769.618430525549;4777.187878060738;4782.784774685148;4784.976075119672;5624.55003599711;5630.183623374588;5631.436856314336;5639.520640745501;5651.26533550644;1476.6086986948467;1497.475883440787;1498.400639744111;1500.0849481816083;1500.0849481816083;1013.133770626104;1032.194887987371;1037.3775734559204;1037.9169666426667;1062.7290041039485;4877.365942427462;4880.975595122072;4885.096257192431;4888.682235654671;4892.315075889378;5837.503812175928;5840.445157710011;5852.970735146297;5856.970715146397;5865.706714664249;4884.218525035977;4885.340479035356;4886.755662216875;4889.315495830587;4898.608111351084;2912.184588315275;2986.8357240351556;3032.5906002689353;3128.1710346758127;3160.683931606821;5485.122380419114;5579.776808927598;5598.608097433222;5600.719964001783;5604.6917419542315;6034.668093254825;6039.305479869871;6044.879102417927;6044.969775151096;6049.153118563317;5431.646942948696;5575.721213939287;5578.63738856973;5579.884023195377;5586.636868603528;5841.678707671119;5874.412558744091;5879.470847623735;5894.528437725057;5894.911576326273;5724.4561766632105;5729.796742684083;5730.885382292247;5733.942660573341;5738.5696072795545;5571.944280557304;5583.55331573465;5585.078462053716;5589.944100559105;5590.748416321357;4113.362428823537;4177.644900183518;4190.392393103044;4209.726367786084;4213.136307056985;5846.298444186725;5865.032269675456;5870.295564532284;5892.145638882424;5896.70516474166;5666.858328541819;5667.1782591524825;5668.914966275427;5676.68778217202;5676.829695109153;5477.233187353853;5612.102063669957;5613.663180209201;5614.719264036864;5635;5562.777488900399;5573.498385145356;5582.358028826737;5584.162375643686;5585.441455854382;5714.428557144252;5727.914081288867;5749.252597162342;5750.396208398058;5755.7409916553015;5576.358718747234;5585.832425027255;5585.916211256916;5588.469095435927;5588.804391846428 05:48:54 INFO - PROCESS | 14829 | |5;yui.html;630.6153246519625;693.0609024771435;697.8743826111302;700.6566782276686;701.8982247574102;11038.668839934804;11209.439528023586;11218.270812397188;11234.550617975281;11250.493727782248;11236;11347;11350.20548561601;11362.488688009038;11379.544818207261;611.8837420890039;620.9689515524228;770.1566784371119;780.6955287437904;785.5914924239393;771.440705488522;773.9690412383497;776.8446310737846;781.3007358414216;781.9218078192192;810.9391795615353;816.2286639126029;816.2694388522269;816.2816721285261;816.6161903905155;639.0669622351372;646.4505170604972;803.8352137811735;820.6963423533272;820.9958950205271;604.2959951656316;606.8027890935464;607.0651197156418;607.5655906027167;608.3369127650838;10884.129269658408;10932.398718070503;10937.945310273397;11000.614978475714;11030;10082.294239403245;10715.62495312668;10805.459727013696;10905.618303359344;10930.125589952784;8798.560071996439;8800.47197168172;8877.378583499158;8886.688965886227;8910.108989101038;3154.036651807826;3164.430402527544;3225.193701574606;3252.36578867121;3262.5106234064842;38415.23169536594;39339;39427.605723942965;39444.80277598622;39504;8863.689770857989;8878.245349145265;8980.416272942239;9086.636534538544;9089.636414543344;16046.277917493508;16058.518244452685;16062.919685401499;16074;16076.919615402083;5849;5893.469587737124;5942.346341902387;6015.398460154037;6088.178095957078;3309.303740041701;3378.847951842173;3404.4893266010295;3416.8974930752115;3502.2120022994623;2922.167182353019;2990.088023152959;2995.670476247611;3000.9549856752164;3002.23443022028;540.0198639469351;546.2980070609327;550.1390324142703;553.4465534465535;553.9362973258127;399.6283456385589;400.44538314434135;402.31003828434376;403.9555648878621;405.1532297498243;6125.509959203253;6247.312795592481;6440.67796610177;6473.190851143607;6567.540272180901;417.71386600178977;438.57020120281663;450.6538948308859;462.54670422985663;534.0920435260074;3155.731762800188;3298.3897978873983;3328.3509715605223;3341.281624450755;3383.0696558446625;49553;49691.75154124206;49790.751046244535;49870.50129498731;49936;45295.773521132185;45446;45481.54518454773;45654.54345456569;46097.53902460999;38416.61583384186;39224.215515689524;39523.40714889336;40258.59741402607;40345.19309613791;6936.79189624312;7200.495965282589;7229.7469588564145;7312.361893884932;7350.191478937206;30288;30319;30629.693703062683;30644.92742753993;30847.537286940264;36464.27071458503;36516.26967460583;36749.03887975196;41181;41266.79366603148;9185.954070229605;9376.624935002796;9672.85490717654;9686.660966866126;9938.801223975624;10661.733456663334;10761.730956726144;10765.623203187852;10988.945055274673;11069.778604428027;9318.720438386588;9453.291003174652;9616.51917404141;9742.123208911233;9952.353097048668;9330.626774928927;9491.952540237255;9604.75988100303;9754.609815607297;9994.950025249827;9067.410618309788;9137.451752894847;9336.626534938527;9459.337846350689;9780.608775648894;8378.371622128243;8414.957925210334;8510.276626486819;8593.484390936565;8613.526256055977;8086.474379165335;8102.351811854919;8143.5113893164225;8157.780796966233;8265.297449716842 05:48:54 INFO - PROCESS | 14829 | __end_tp_report 05:48:54 INFO - PROCESS | 14829 | __start_cc_report 05:48:54 INFO - PROCESS | 14829 | _x_x_mozilla_cycle_collect,927 05:48:54 INFO - PROCESS | 14829 | __end_cc_report 05:48:54 INFO - PROCESS | 14829 | __startTimestamp1451396934933__endTimestamp 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | ------- Summary: start ------- 05:48:54 INFO - PROCESS | 14829 | Number of tests: 6 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#0] dojo.html Cycles:165 Average:4628.40 Median:4773.05 stddev:477.94 (10.0%) stddev-sans-first:452.50 05:48:54 INFO - PROCESS | 14829 | Values: 2613.2 2703.3 2704.9 2715.4 2731.4 4450.0 4574.3 4621.2 4658.2 4670.7 4635.0 4673.0 4721.7 4725.2 4786.2 4291.9 4304.2 4322.1 4323.1 4337.1 4207.7 4396.3 4404.2 4450.7 4467.2 4298.6 4303.9 4319.7 4404.7 4414.6 4280.6 4281.6 4282.3 4298.8 4322.6 4260.7 4277.9 4278.9 4315.4 4330.7 4444.8 4540.0 4574.6 4634.4 4773.0 5056.4 5062.0 5063.0 5066.1 5066.4 5071.0 5083.5 5084.1 5087.1 5117.2 4502.5 4599.1 4601.1 4660.1 4694.4 5171.5 5176.5 5177.0 5178.8 5206.4 4953.9 4959.2 4960.0 4965.4 5002.1 4861.6 4978.5 4980.6 4993.7 5052.6 4968.0 4969.0 4972.9 4974.3 4982.6 4927.6 4933.9 4938.8 4940.4 4989.2 4097.6 4166.5 4169.4 4193.3 4266.0 3697.7 3703.2 3720.6 3728.7 3752.7 4295.1 4295.6 4304.8 4341.0 4345.0 4805.9 4913.3 4917.7 5026.8 5035.4 4255.4 4297.7 4335.5 4357.9 4376.1 4499.8 4509.1 4509.4 4519.7 4564.3 4578.7 4688.6 4694.8 4790.0 4792.2 4960.4 5022.1 5040.2 5042.1 5085.6 4822.0 4833.1 4836.9 4841.8 4884.2 4812.8 4919.9 4925.9 5016.1 5068.8 4980.7 5024.7 5043.3 5043.4 5089.9 4870.7 4877.9 4884.3 4885.8 4925.0 4691.3 4758.8 4810.7 4862.9 4908.5 4737.6 4784.1 4789.1 4805.2 4856.7 4902.0 4903.1 4903.7 4933.4 4942.5 4598.1 4716.5 4723.4 4788.9 4831.2 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#1] ext.html Cycles:180 Average:40039.36 Median:18367.64 stddev:65993.42 (359.3%) stddev-sans-first:66111.78 05:48:54 INFO - PROCESS | 14829 | Values: 503.6 509.0 521.3 524.7 545.8 25190.0 25650.5 25701.0 32477.8 32745.3 36586.5 36968.4 37087.4 37144.8 37159.6 7473.5 7613.4 7625.1 7638.2 7647.4 7029.2 7207.2 9707.4 9885.1 9897.5 9604.7 9729.5 9741.0 9743.0 9745.2 6882.9 7075.2 9601.1 9773.7 9778.7 6955.4 7105.2 7108.0 9699.6 9936.2 31957.0 32464.5 32534.2 32579.8 32691.5 2602.8 2674.6 2705.9 2962.0 3051.6 28375.1 28785.9 28849.3 28853.0 29232.9 3281.9 3293.6 3313.8 3320.8 3350.4 208910.0 209088.0 209158.0 209877.0 210101.0 46467.8 48874.8 49025.0 49040.5 49145.3 41518.6 58533.4 59981.7 60050.5 60265.0 11747.3 11758.9 11796.2 11823.3 11835.9 9357.1 9488.5 9494.7 9502.5 9505.1 18009.8 18905.4 19034.6 19097.6 19107.2 7259.7 7615.3 7759.5 7782.4 7808.0 831.5 831.7 857.6 920.5 1014.6 26649.9 28419.7 29954.3 30256.4 30558.0 914.4 923.0 942.8 1033.3 1073.8 12929.1 14311.4 14996.6 15234.3 15278.8 245508.0 253599.0 254143.0 254278.0 254601.0 38992.2 38992.8 39145.8 39409.6 39429.4 1111.9 1116.9 1117.9 1128.1 1160.9 24705.4 25713.1 26174.3 26177.6 26186.3 37126.4 37545.8 37597.0 37617.8 39405.2 143369.3 308208.0 314989.0 317393.0 319588.0 24645.9 25181.2 25185.0 25209.6 25309.0 38934.6 39217.6 39243.8 40016.6 40262.0 33137.3 33384.8 33806.5 34421.0 34842.5 32814.3 33875.5 33911.7 34100.5 34103.0 33220.7 33892.2 34027.7 34151.3 34155.5 28885.1 30819.0 30828.7 30916.0 31066.4 23872.0 24074.4 24095.9 24388.1 24502.0 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#2] jquery.html Cycles:180 Average:26376.37 Median:4442.56 stddev:86991.85 (1958.1%) stddev-sans-first:87213.91 05:48:54 INFO - PROCESS | 14829 | Values: 335.9 337.7 338.8 339.7 341.6 12385.0 12711.1 14585.8 14749.0 15148.5 12458.9 14177.6 14525.7 15068.6 15105.8 4432.6 4671.8 4788.6 4921.2 4929.6 4910.7 4964.0 4966.1 4966.5 4970.0 4798.5 4878.8 4898.1 4927.8 5013.4 4982.6 4994.5 5012.8 5027.2 5030.0 4452.5 4456.0 4461.4 4470.3 4472.7 10981.7 11137.6 16221.5 16553.1 16800.3 1643.7 1644.9 1645.0 1695.0 1769.5 8618.0 8786.9 10381.4 11393.5 11618.6 1614.5 1718.4 1722.6 1742.6 1749.0 52330.2 54160.2 54610.0 55128.0 55177.4 9674.3 9787.7 9788.8 9797.5 9872.4 10131.2 10917.1 11202.3 12439.0 12460.4 5635.4 5637.4 5640.6 5665.9 5844.5 5143.6 5172.5 5187.5 5221.2 5281.9 3392.0 3535.2 3555.5 3610.8 3685.8 1623.0 1678.9 1714.6 1737.5 1754.2 393.3 396.7 408.9 825.3 838.7 8855.5 9263.7 9371.3 9530.8 9578.5 380.6 382.2 385.2 390.9 391.8 4590.3 5058.6 5148.3 5378.2 5429.9 496203.0 515231.0 548042.0 548853.0 550797.0 52536.2 68562.0 69704.0 71638.3 72776.3 389.9 392.4 413.3 415.2 419.0 8778.0 8903.7 8911.1 9016.5 9082.9 31304.4 31862.4 31886.0 32257.7 33167.0 40570.0 42761.0 42901.8 43530.6 45530.8 8112.5 8232.5 8367.3 8390.1 8442.2 9751.7 9844.7 9902.8 9927.3 9968.2 10150.8 12157.9 12204.4 13503.3 13675.8 13387.8 13402.8 13485.6 13833.4 13850.9 12679.0 12695.1 12828.6 13327.5 13632.5 8467.1 8476.6 8510.3 8617.9 8774.4 11893.3 12852.7 12966.4 13359.0 13598.9 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#3] mootools.html Cycles:180 Average:4901.51 Median:6331.99 stddev:2559.75 (40.4%) stddev-sans-first:2551.33 05:48:54 INFO - PROCESS | 14829 | Values: 1142.1 1145.4 1166.4 1213.7 1661.3 5883.2 6947.3 7058.4 7069.3 7090.8 6672.6 6838.3 6853.8 6868.6 6868.8 1748.1 1761.8 1762.3 2050.2 2087.5 1764.6 1773.2 2074.5 2099.7 2107.4 2040.2 2044.4 2045.1 2045.9 2046.2 1994.2 2044.7 2048.6 2048.6 2053.2 2030.5 2032.8 2050.2 2061.4 2062.3 7155.0 7210.3 7221.9 7224.0 7228.1 4131.9 4195.0 4208.0 4209.3 4211.2 2707.4 2712.3 2714.7 2746.2 2790.8 868.9 870.2 896.3 914.2 914.7 9334.7 9357.5 9369.1 9373.3 9383.1 3764.6 3805.9 3842.2 3880.1 3889.8 7838.0 7838.2 7841.3 7864.7 7871.6 4153.7 4155.5 4173.4 4175.5 4190.2 3797.4 3827.5 3836.0 3841.2 3842.8 3349.4 3349.9 3368.5 3393.4 3397.3 944.3 965.9 1090.2 1101.7 1108.2 865.8 886.3 887.6 890.2 918.7 6656.2 6733.5 6741.7 6743.0 6747.6 989.6 1013.8 1023.9 1026.1 1028.4 5228.6 5257.8 5263.7 5266.5 5277.6 8450.5 8497.0 8650.7 8718.8 8749.3 8635.9 8689.6 8692.1 8712.0 8745.9 6600.0 6697.5 6744.5 6780.6 6783.3 6427.6 6435.2 6457.4 6467.5 6483.4 7142.0 7360.7 7404.1 7728.7 7845.4 7387.3 7498.8 7528.1 7987.2 8037.2 6365.8 6470.4 6478.5 6479.2 6479.4 5689.5 6464.7 6483.5 7000.7 7012.8 5469.1 6218.0 6249.1 6255.2 6346.8 6241.1 6267.1 6317.2 6356.6 6363.2 6381.1 6408.5 6412.9 6417.0 6424.2 5633.3 5707.8 5712.3 5725.9 5806.8 5986.8 5991.9 6006.0 6029.8 6031.3 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#4] prototype.html Cycles:180 Average:4699.58 Median:5312.10 stddev:1372.04 (25.8%) stddev-sans-first:1335.61 05:48:54 INFO - PROCESS | 14829 | Values: 302.4 309.1 313.5 322.6 326.0 5307.1 5381.1 5417.3 5419.8 5419.9 5317.1 5332.7 5334.8 5340.4 5349.2 3975.6 4065.8 4200.7 4212.5 4222.2 4090.1 4129.5 4157.1 4173.6 4175.7 4120.0 4120.2 4125.6 4130.6 4130.8 3946.2 4017.3 4042.8 4123.8 4132.1 3633.9 3653.2 3655.1 3660.8 3661.6 5082.3 5133.9 5135.6 5171.5 5171.7 4799.2 4811.4 4814.9 4817.8 4824.7 5484.0 5611.4 5630.2 5630.3 5630.5 4007.0 4010.7 4015.8 4019.1 4024.5 5913.0 5918.2 5924.2 5926.6 5930.7 4150.1 4156.1 4157.4 4160.8 4177.4 4121.6 4197.4 4210.6 4218.7 4242.1 4759.5 4769.6 4777.2 4782.8 4785.0 5624.6 5630.2 5631.4 5639.5 5651.3 1476.6 1497.5 1498.4 1500.1 1500.1 1013.1 1032.2 1037.4 1037.9 1062.7 4877.4 4881.0 4885.1 4888.7 4892.3 5837.5 5840.4 5853.0 5857.0 5865.7 4884.2 4885.3 4886.8 4889.3 4898.6 2912.2 2986.8 3032.6 3128.2 3160.7 5485.1 5579.8 5598.6 5600.7 5604.7 6034.7 6039.3 6044.9 6045.0 6049.2 5431.6 5575.7 5578.6 5579.9 5586.6 5841.7 5874.4 5879.5 5894.5 5894.9 5724.5 5729.8 5730.9 5733.9 5738.6 5571.9 5583.6 5585.1 5589.9 5590.7 4113.4 4177.6 4190.4 4209.7 4213.1 5846.3 5865.0 5870.3 5892.1 5896.7 5666.9 5667.2 5668.9 5676.7 5676.8 5477.2 5612.1 5613.7 5614.7 5635.0 5562.8 5573.5 5582.4 5584.2 5585.4 5714.4 5727.9 5749.3 5750.4 5755.7 5576.4 5585.8 5585.9 5588.5 5588.8 05:48:54 INFO - PROCESS | 14829 | 05:48:54 INFO - PROCESS | 14829 | [#5] yui.html Cycles:180 Average:11807.33 Median:543.16 stddev:13737.83 (2529.2%) stddev-sans-first:13750.73 05:48:54 INFO - PROCESS | 14829 | Values: 630.6 693.1 697.9 700.7 701.9 11038.7 11209.4 11218.3 11234.6 11250.5 11236.0 11347.0 11350.2 11362.5 11379.5 611.9 621.0 770.2 780.7 785.6 771.4 774.0 776.8 781.3 781.9 810.9 816.2 816.3 816.3 816.6 639.1 646.5 803.8 820.7 821.0 604.3 606.8 607.1 607.6 608.3 10884.1 10932.4 10937.9 11000.6 11030.0 10082.3 10715.6 10805.5 10905.6 10930.1 8798.6 8800.5 8877.4 8886.7 8910.1 3154.0 3164.4 3225.2 3252.4 3262.5 38415.2 39339.0 39427.6 39444.8 39504.0 8863.7 8878.2 8980.4 9086.6 9089.6 16046.3 16058.5 16062.9 16074.0 16076.9 5849.0 5893.5 5942.3 6015.4 6088.2 3309.3 3378.8 3404.5 3416.9 3502.2 2922.2 2990.1 2995.7 3001.0 3002.2 540.0 546.3 550.1 553.4 553.9 399.6 400.4 402.3 404.0 405.2 6125.5 6247.3 6440.7 6473.2 6567.5 417.7 438.6 450.7 462.5 534.1 3155.7 3298.4 3328.4 3341.3 3383.1 49553.0 49691.8 49790.8 49870.5 49936.0 45295.8 45446.0 45481.5 45654.5 46097.5 38416.6 39224.2 39523.4 40258.6 40345.2 6936.8 7200.5 7229.7 7312.4 7350.2 30288.0 30319.0 30629.7 30644.9 30847.5 36464.3 36516.3 36749.0 41181.0 41266.8 9186.0 9376.6 9672.9 9686.7 9938.8 10661.7 10761.7 10765.6 10988.9 11069.8 9318.7 9453.3 9616.5 9742.1 9952.4 9330.6 9492.0 9604.8 9754.6 9995.0 9067.4 9137.5 9336.6 9459.3 9780.6 8378.4 8415.0 8510.3 8593.5 8613.5 8086.5 8102.4 8143.5 8157.8 8265.3 05:48:54 INFO - PROCESS | 14829 | -------- Summary: end -------- 05:48:54 INFO - PROCESS | 14829 | 05:48:55 INFO - TEST-INFO | 14829: exit 0 05:48:55 INFO - TEST-OK | dromaeo_css | took 1116413ms 05:48:55 INFO - TEST-START | kraken 05:48:55 INFO - operating with platform_type : linux_ 05:48:55 INFO - Initialising browser for kraken test... 05:48:55 INFO - TEST-INFO | started process 15008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICiKSE/profile http://localhost:47320/getInfo.html) 05:48:59 INFO - PROCESS | 15008 | __metrics Screen width/height:1600/1200 05:48:59 INFO - PROCESS | 15008 | colorDepth:24 05:48:59 INFO - PROCESS | 15008 | Browser inner width/height: 1024/697 05:48:59 INFO - PROCESS | 15008 | __metrics 05:48:59 INFO - PROCESS | 15008 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:48:59 INFO - PROCESS | 15008 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:49:00 INFO - TEST-INFO | 15008: exit 0 05:49:00 INFO - Browser initialized. 05:49:00 INFO - Running cycle 1/1 for kraken test... 05:49:00 INFO - TEST-INFO | started process 15091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpICiKSE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:12 INFO - PROCESS | 15091 | RSS: Main: 149131264 05:49:12 INFO - PROCESS | 15091 | 05:49:15 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47320/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:15 INFO - PROCESS | 15091 | RSS: Main: 186032128 05:49:15 INFO - PROCESS | 15091 | 05:49:18 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47320/tests/kraken/driver.html?testName=audio-dft) 05:49:19 INFO - PROCESS | 15091 | RSS: Main: 173506560 05:49:19 INFO - PROCESS | 15091 | 05:49:22 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47320/tests/kraken/driver.html?testName=audio-fft) 05:49:22 INFO - PROCESS | 15091 | RSS: Main: 159776768 05:49:22 INFO - PROCESS | 15091 | 05:49:24 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47320/tests/kraken/driver.html?testName=audio-oscillator) 05:49:25 INFO - PROCESS | 15091 | RSS: Main: 161746944 05:49:25 INFO - PROCESS | 15091 | 05:49:27 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:28 INFO - PROCESS | 15091 | RSS: Main: 165036032 05:49:28 INFO - PROCESS | 15091 | 05:49:31 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47320/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:31 INFO - PROCESS | 15091 | RSS: Main: 166072320 05:49:31 INFO - PROCESS | 15091 | 05:49:34 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47320/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:35 INFO - PROCESS | 15091 | RSS: Main: 165634048 05:49:35 INFO - PROCESS | 15091 | 05:49:38 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47320/tests/kraken/driver.html?testName=json-parse-financial) 05:49:38 INFO - PROCESS | 15091 | RSS: Main: 164323328 05:49:38 INFO - PROCESS | 15091 | 05:49:40 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:49:41 INFO - PROCESS | 15091 | RSS: Main: 177377280 05:49:41 INFO - PROCESS | 15091 | 05:49:43 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:49:43 INFO - PROCESS | 15091 | RSS: Main: 176381952 05:49:43 INFO - PROCESS | 15091 | 05:49:45 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:49:46 INFO - PROCESS | 15091 | RSS: Main: 187224064 05:49:46 INFO - PROCESS | 15091 | 05:49:49 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:49:49 INFO - PROCESS | 15091 | RSS: Main: 191246336 05:49:49 INFO - PROCESS | 15091 | 05:49:52 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:49:52 INFO - PROCESS | 15091 | RSS: Main: 189435904 05:49:52 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | Cycle 1(1): loaded http://localhost:47320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47320/tests/kraken/driver.html?testName=ai-astar) 05:49:54 INFO - PROCESS | 15091 | RSS: Main: 247676928 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | __start_tp_report 05:49:54 INFO - PROCESS | 15091 | _x_x_mozilla_page_load 05:49:54 INFO - PROCESS | 15091 | _x_x_mozilla_page_load_details 05:49:54 INFO - PROCESS | 15091 | |i|pagename|runs| 05:49:54 INFO - PROCESS | 15091 | |0;ai-astar;112;112;107;111;113;114;100;112;110;104 05:49:54 INFO - PROCESS | 15091 | |1;audio-beat-detection;150;130;155;165;130;154;172;130;174;134 05:49:54 INFO - PROCESS | 15091 | |2;audio-dft;160;160;160;162;162;161;161;160;162;161 05:49:54 INFO - PROCESS | 15091 | |3;audio-fft;72;72;84;91;71;72;76;117;92;73 05:49:54 INFO - PROCESS | 15091 | |4;audio-oscillator;98;99;132;97;97;98;133;97;97;131 05:49:54 INFO - PROCESS | 15091 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;110 05:49:54 INFO - PROCESS | 15091 | |6;imaging-darkroom;146;147;147;147;147;147;148;146;146;146 05:49:54 INFO - PROCESS | 15091 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 05:49:54 INFO - PROCESS | 15091 | |8;json-parse-financial;70;70;70;69;70;70;69;80;68;67 05:49:54 INFO - PROCESS | 15091 | |9;json-stringify-tinderbox;70;69;69;70;70;70;68;68;74;69 05:49:54 INFO - PROCESS | 15091 | |10;stanford-crypto-aes;86;84;85;85;87;86;85;84;85;86 05:49:54 INFO - PROCESS | 15091 | |11;stanford-crypto-ccm;129;125;136;127;128;127;129;121;120;121 05:49:54 INFO - PROCESS | 15091 | |12;stanford-crypto-pbkdf2;137;140;142;140;149;148;147;147;145;135 05:49:54 INFO - PROCESS | 15091 | |13;stanford-crypto-sha256-iterative;71;70;70;70;70;71;70;70;69;69 05:49:54 INFO - PROCESS | 15091 | __end_tp_report 05:49:54 INFO - PROCESS | 15091 | __start_cc_report 05:49:54 INFO - PROCESS | 15091 | _x_x_mozilla_cycle_collect,974 05:49:54 INFO - PROCESS | 15091 | __end_cc_report 05:49:54 INFO - PROCESS | 15091 | __startTimestamp1451396994839__endTimestamp 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | ------- Summary: start ------- 05:49:54 INFO - PROCESS | 15091 | Number of tests: 14 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.48 (4.0%) stddev-sans-first:4.66 05:49:54 INFO - PROCESS | 15091 | Values: 112.0 112.0 107.0 111.0 113.0 114.0 100.0 112.0 110.0 104.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:154.50 stddev:17.57 (11.4%) stddev-sans-first:18.63 05:49:54 INFO - PROCESS | 15091 | Values: 150.0 130.0 155.0 165.0 130.0 154.0 172.0 130.0 174.0 134.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 05:49:54 INFO - PROCESS | 15091 | Values: 160.0 160.0 160.0 162.0 162.0 161.0 161.0 160.0 162.0 161.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.50 stddev:14.71 (19.7%) stddev-sans-first:15.15 05:49:54 INFO - PROCESS | 15091 | Values: 72.0 72.0 84.0 91.0 71.0 72.0 76.0 117.0 92.0 73.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:97.00 stddev:16.65 (17.2%) stddev-sans-first:17.27 05:49:54 INFO - PROCESS | 15091 | Values: 98.0 99.0 132.0 97.0 97.0 98.0 133.0 97.0 97.0 131.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:49:54 INFO - PROCESS | 15091 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:49:54 INFO - PROCESS | 15091 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 146.0 146.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:49:54 INFO - PROCESS | 15091 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:3.56 (5.1%) stddev-sans-first:3.77 05:49:54 INFO - PROCESS | 15091 | Values: 70.0 70.0 70.0 69.0 70.0 70.0 69.0 80.0 68.0 67.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.80 05:49:54 INFO - PROCESS | 15091 | Values: 70.0 69.0 69.0 70.0 70.0 70.0 68.0 68.0 74.0 69.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 05:49:54 INFO - PROCESS | 15091 | Values: 86.0 84.0 85.0 85.0 87.0 86.0 85.0 84.0 85.0 86.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.50 stddev:4.83 (3.8%) stddev-sans-first:5.02 05:49:54 INFO - PROCESS | 15091 | Values: 129.0 125.0 136.0 127.0 128.0 127.0 129.0 121.0 120.0 121.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:146.00 stddev:4.90 (3.4%) stddev-sans-first:4.69 05:49:54 INFO - PROCESS | 15091 | Values: 137.0 140.0 142.0 140.0 149.0 148.0 147.0 147.0 145.0 135.0 05:49:54 INFO - PROCESS | 15091 | 05:49:54 INFO - PROCESS | 15091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:49:54 INFO - PROCESS | 15091 | Values: 71.0 70.0 70.0 70.0 70.0 71.0 70.0 70.0 69.0 69.0 05:49:54 INFO - PROCESS | 15091 | -------- Summary: end -------- 05:49:54 INFO - PROCESS | 15091 | 05:49:55 INFO - TEST-INFO | 15091: exit 0 05:49:55 INFO - TEST-OK | kraken | took 60165ms 05:49:55 INFO - TEST-START | v8_7 05:49:55 INFO - operating with platform_type : linux_ 05:49:55 INFO - Initialising browser for v8_7 test... 05:49:55 INFO - TEST-INFO | started process 15338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZwc8FH/profile http://localhost:47320/getInfo.html) 05:49:59 INFO - PROCESS | 15338 | __metrics Screen width/height:1600/1200 05:49:59 INFO - PROCESS | 15338 | colorDepth:24 05:49:59 INFO - PROCESS | 15338 | Browser inner width/height: 1024/697 05:49:59 INFO - PROCESS | 15338 | __metrics 05:49:59 INFO - PROCESS | 15338 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:49:59 INFO - PROCESS | 15338 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:00 INFO - TEST-INFO | 15338: exit 0 05:50:00 INFO - Browser initialized. 05:50:00 INFO - Running cycle 1/1 for v8_7 test... 05:50:00 INFO - TEST-INFO | started process 15421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZwc8FH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:12 INFO - PROCESS | 15421 | RSS: Main: 148951040 05:50:12 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | Cycle 1(1): loaded http://localhost:47320/tests/v8_7/run.html (next: http://localhost:47320/tests/v8_7/run.html) 05:50:34 INFO - PROCESS | 15421 | RSS: Main: 450187264 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | __start_tp_report 05:50:34 INFO - PROCESS | 15421 | _x_x_mozilla_page_load 05:50:34 INFO - PROCESS | 15421 | _x_x_mozilla_page_load_details 05:50:34 INFO - PROCESS | 15421 | |i|pagename|runs| 05:50:34 INFO - PROCESS | 15421 | |0;Richards;167.7570877369569 05:50:34 INFO - PROCESS | 15421 | |1;DeltaBlue;188.64365214110546 05:50:34 INFO - PROCESS | 15421 | |2;Encrypt;278.8622420524261 05:50:34 INFO - PROCESS | 15421 | |3;Decrypt;5246.073298429319 05:50:34 INFO - PROCESS | 15421 | |4;RayTrace;2012.0724346076458 05:50:34 INFO - PROCESS | 15421 | |5;Earley;807.909604519774 05:50:34 INFO - PROCESS | 15421 | |6;Boyer;12512.5 05:50:34 INFO - PROCESS | 15421 | |7;RegExp;26394.736842105263 05:50:34 INFO - PROCESS | 15421 | |8;Splay;610.1281269066504 05:50:34 INFO - PROCESS | 15421 | |9;NavierStokes;4830.917874396136 05:50:34 INFO - PROCESS | 15421 | __end_tp_report 05:50:34 INFO - PROCESS | 15421 | __startTimestamp1451397034387__endTimestamp 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | ------- Summary: start ------- 05:50:34 INFO - PROCESS | 15421 | Number of tests: 10 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 167.8 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 188.6 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 278.9 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 5246.1 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#4] RayTrace Cycles:1 Average:2012.07 Median:2012.07 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 2012.1 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#5] Earley Cycles:1 Average:807.91 Median:807.91 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 807.9 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 12512.5 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 26394.7 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 610.1 05:50:34 INFO - PROCESS | 15421 | 05:50:34 INFO - PROCESS | 15421 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:50:34 INFO - PROCESS | 15421 | Values: 4830.9 05:50:34 INFO - PROCESS | 15421 | -------- Summary: end -------- 05:50:34 INFO - PROCESS | 15421 | 05:50:35 INFO - TEST-INFO | 15421: exit 0 05:50:35 INFO - TEST-OK | v8_7 | took 39561ms 05:50:35 INFO - SUITE-END | took 1216s 05:50:35 INFO - Completed test suite (00:20:16) 05:50:35 INFO - Working with test: dromaeo_css 05:50:35 INFO - Generating results file: dromaeo_css 05:50:35 INFO - Working with test: kraken 05:50:35 INFO - Generating results file: kraken 05:50:35 INFO - javascript benchmark 05:50:35 INFO - Working with test: v8_7 05:50:35 INFO - Generating results file: v8_7 05:50:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 05:50:35 INFO - process_Request line: dromaeo_css 6045.94 graph.html#tests=[[72,203,35]] 05:50:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:35 INFO - process_Request line: kraken 1525.30 graph.html#tests=[[232,203,35]] 05:50:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:50:35 INFO - process_Request line: v8_7 19631.07 graph.html#tests=[[230,203,35]] 05:50:35 INFO - RETURN: dromaeo_css: 6045.94 05:50:35 INFO - RETURN: kraken: 1525.30 05:50:35 INFO - RETURN: v8_7: 19631.07 05:50:35 INFO - javascript benchmark 05:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2613.163787587972, 2703.256604433779, 2704.891804327827, 2715.416185520114, 2731.399092199715, 4450.0, 4574.336721175428, 4621.168189725852, 4658.208104622214, 4670.743109128996, 4634.976825115869, 4672.97663511682, 4721.740304283263, 4725.196716558185, 4786.186348320785, 4291.914161716763, 4304.160688665712, 4322.07075478772, 4323.070539833935, 4337.1325734853, 4207.72649777765, 4396.318570621559, 4404.185225733234, 4450.688451808374, 4467.24056910326, 4298.570142985692, 4303.892402689927, 4319.719218250803, 4404.69167158299, 4414.624756895668, 4280.6361459275995, 4281.593248641405, 4282.272013757669, 4298.763568003758, 4322.610965013132, 4260.659147268211, 4277.935830962538, 4278.893027674302, 4315.43899293093, 4330.696851220416, 4444.799984000695, 4539.954600454019, 4574.588287054148, 4634.443866735979, 4773.0453909218295, 5056.367954005749, 5062.0, 5063.0380227756605, 5066.138756411419, 5066.392032956032, 5070.989889769719, 5083.491650834924, 5084.110280700863, 5087.058894104603, 5117.181250999859, 4502.549745025472, 4599.08018396322, 4601.102784956968, 4660.067986402733, 4694.43666759991, 5171.50870667286, 5176.456472070454, 5177.042247184283, 5178.81874134411, 5206.427292997767, 4953.925691114636, 4959.20652695567, 4959.950400496021, 4965.404151501771, 5002.149634562061, 4861.611071114373, 4978.502149784992, 4980.551750342414, 4993.725345106054, 5052.595792336604, 4968.031233909425, 4969.0310389474425, 4972.8508144755715, 4974.328465657162, 4982.551570358685, 4927.605791536668, 4933.901321973541, 4938.802447902115, 4940.382452193476, 4989.151844186497, 4097.569755175723, 4166.500019997619, 4169.374593810952, 4193.30810416284, 4265.97867010663, 3697.685696715809, 3703.203811180609, 3720.6465385788306, 3728.7203459740626, 3752.699784017272, 4295.119500502452, 4295.634871035934, 4304.763238021939, 4340.956590434118, 4344.978929951459, 4805.879853003633, 4913.31213630092, 4917.65576409655, 5026.773795179226, 5035.370578677665, 4255.4255175551525, 4297.742135471819, 4335.523092459827, 4357.934630980538, 4376.146651402946, 4499.842505512292, 4509.12072145935, 4509.413776209138, 4519.728816271035, 4564.338170965191, 4578.65660075489, 4688.624910007123, 4694.812207511662, 4790.0180463005, 4792.2092854678585, 4960.355153829979, 5022.070916880389, 5040.218766091261, 5042.09242336383, 5085.593152547861, 4821.951780482291, 4833.081714474239, 4836.879078023077, 4841.806327746992, 4884.169691152583, 4812.783424745825, 4919.926201107058, 4925.852224433273, 5016.122178618654, 5068.771905264198, 4980.701157930535, 5024.723640199824, 5043.2939388486375, 5043.44522102561, 5089.931114466003, 4870.683405578768, 4877.926831097608, 4884.267359896044, 4885.8045678172475, 4925.039617274597, 4691.296305554194, 4758.833440829693, 4810.7113573185725, 4862.92705609409, 4908.460069392436, 4737.644676649334, 4784.091022705675, 4789.114013907439, 4805.183118869731, 4856.732879691651, 4901.975490122527, 4903.141950158637, 4903.7302948336755, 4933.383327084114, 4942.505749425029, 4598.126355992351, 4716.504766999553, 4723.4331880174595, 4788.904221915473, 4831.154547954165], "unit": "score", "name": "dojo.html", "value": 4599.000875192162}, {"lowerIsBetter": false, "replicates": [503.60718639461214, 508.95928325733945, 521.3170746322315, 524.6930545630805, 545.7544105152682, 25190.0, 25650.486990260208, 25701.0, 32477.837610811912, 32745.34509309818, 36586.4512032319, 36968.44547331786, 37087.4436883447, 37144.814275928584, 37159.62840371596, 7473.476856620039, 7613.390928725717, 7625.084989801204, 7638.197989211136, 7647.426443016768, 7029.156501219861, 7207.171175314854, 9707.417554946725, 9885.060919212663, 9897.4556399398, 9604.711858644252, 9729.513524323791, 9741.0, 9742.951285243564, 9745.220382369393, 6882.8623427531165, 7075.2217256101785, 9601.087896649808, 9773.680553125309, 9778.706638800848, 6955.374016338554, 7105.182903966059, 7108.0, 9699.612015519371, 9936.205103591696, 31957.0, 32464.513032304534, 32534.18664533382, 32579.83710081458, 32691.50962735561, 2602.8047896407843, 2674.638923745289, 2705.9052933147245, 2961.978117549442, 3051.61854768154, 28375.109066391753, 28785.85607071972, 28849.278768030756, 28853.0, 29232.853835730686, 3281.868725250987, 3293.55537002504, 3313.801171929692, 3320.7509436792097, 3350.4471762159214, 208910.0, 209088.0, 209158.0, 209877.0, 210101.0, 46467.76766116148, 48874.75562622164, 49025.0, 49040.5095949036, 49145.26282105771, 41518.58481415208, 58533.41466585365, 59981.70009149926, 60050.49368828897, 60265.0, 11747.29516229029, 11758.94120529409, 11796.174267801343, 11823.349715765544, 11835.940820295844, 9357.064293570724, 9488.478133702574, 9494.667686630935, 9502.47736374506, 9505.144536991704, 18009.819901801075, 18905.432837014912, 19034.61930761377, 19097.61804763897, 19107.23571057142, 7259.745908893164, 7615.314621684075, 7759.495632783851, 7782.377409807202, 7808.0, 831.4553967151526, 831.7130589946458, 857.5840717252128, 920.5075284722775, 1014.5586669798661, 26649.866750666122, 28419.71580284212, 29954.25114372158, 30256.394872102435, 30558.0, 914.3964983111115, 922.9723108306762, 942.835003874333, 1033.302520798458, 1073.8281874900135, 12929.094963352663, 14311.427542898376, 14996.625084372978, 15234.314455849513, 15278.847211527966, 245508.0, 253599.0, 254143.0, 254278.0, 254601.0, 38992.220155596726, 38992.80503597464, 39145.804270978464, 39409.60590394117, 39429.40855887164, 1111.9499622517005, 1116.8548088748412, 1117.9273347232404, 1128.1313388690662, 1160.9071274298205, 24705.382365441008, 25713.100041499205, 26174.34564135912, 26177.607335889596, 26186.345341366618, 37126.44310335293, 37545.81227093847, 37597.0, 37617.81191094027, 39405.2118957625, 143369.28315358356, 308208.0, 314989.0, 317393.0, 319588.0, 24645.87677061675, 25181.24456266315, 25185.0, 25209.621855672547, 25309.0, 38934.6106538931, 39217.6078239214, 39243.80378098205, 40016.59983400245, 40262.0, 33137.33725325528, 33384.83307583447, 33806.49290260599, 34421.0, 34842.47736284009, 32814.34371312608, 33875.49186762151, 33911.66088339085, 34100.488492673125, 34103.0, 33220.667793322726, 33892.15269618181, 34027.65972340344, 34151.31697366088, 34155.4876676855, 28885.133445996653, 30819.0, 30828.69171308348, 30916.0, 31066.378672426876, 23872.0, 24074.39814004664, 24095.879520602284, 24388.146414875395, 24502.0], "unit": "score", "name": "ext.html", "value": 16472.40234764606}, {"lowerIsBetter": false, "replicates": [335.882441145599, 337.65390474763365, 338.7764075710032, 339.65355337555695, 341.55427167546344, 12385.0, 12711.110222284444, 14585.781213281809, 14749.041312314705, 15148.46980355689, 12458.937705311484, 14177.574672759834, 14525.709485810277, 15068.623284417896, 15105.848941510581, 4432.601065904068, 4671.766411679419, 4788.569028787409, 4921.18800397934, 4929.580985616209, 4910.705357678533, 4964.0, 4966.130927087764, 4966.528179822911, 4969.975150124263, 4798.496157903405, 4878.780454879539, 4898.14282500561, 4927.827526036589, 5013.448520662724, 4982.551570358667, 4994.525520075587, 5012.799488020475, 5027.220780778966, 5030.0, 4452.510223875371, 4455.977720111378, 4461.442319710036, 4470.284754439274, 4472.686911916167, 10981.670549883516, 11137.610183643614, 16221.513354599381, 16553.119328831115, 16800.32798688051, 1643.6959162554965, 1644.925978330966, 1645.0129922046797, 1694.9915250423792, 1769.539919620895, 8617.965844098748, 8786.912130878738, 10381.429021403896, 11393.54425822966, 11618.593349232737, 1614.5075751895668, 1718.4243278501717, 1722.5521364445335, 1742.634046850163, 1749.0380290839987, 52330.21504677433, 54160.18759718607, 54610.0, 55128.0384765369, 55177.44822551763, 9674.322797404115, 9787.706368808947, 9788.804223915482, 9797.510124493747, 9872.35829671069, 10131.240156988255, 10917.126629869592, 11202.319652052094, 12439.0, 12460.376981150906, 5635.380108188096, 5637.43625637433, 5640.576956728261, 5665.886682266414, 5844.47399734026, 5143.5627971622835, 5172.508611681884, 5187.546699875467, 5221.190715439113, 5281.867953301198, 3392.0, 3535.2399234164777, 3555.5022296878456, 3610.837512311952, 3685.8341374638208, 1623.0, 1678.932842686279, 1714.5597697933795, 1737.4961261234353, 1754.1843042985074, 393.3254468586388, 396.738152819138, 408.85485652593496, 825.2861274997084, 838.6938767349874, 8855.51294678786, 9263.722088337361, 9371.297152713574, 9530.809383812284, 9578.473183974947, 380.5718566612561, 382.2488809489311, 385.21608526648134, 390.9296326661228, 391.7531954868415, 4590.311453281967, 5058.595312375001, 5148.279240906276, 5378.220158077057, 5429.945700542944, 496203.0, 515231.0, 548042.0, 548853.0, 550797.0, 52536.211956820676, 68562.0, 69704.0, 71638.28361716316, 72776.27223727695, 389.8966773804944, 392.39766957719763, 413.2582015282575, 415.16551731020263, 419.02785537552586, 8778.0, 8903.688370906988, 8911.06433824465, 9016.504092274989, 9082.909170908206, 31304.373912521165, 31862.362752745277, 31886.0, 32257.67742322547, 33167.0, 40570.0, 42761.0, 42901.78549107235, 43530.56469435265, 45530.77234613806, 8112.472689275178, 8232.50604963704, 8367.28878045373, 8390.119037500974, 8442.240198382175, 9751.658691945748, 9844.655437059668, 9902.801943960936, 9927.305088644014, 9968.202543796333, 10150.847737283799, 12157.878421215675, 12204.38978051076, 13503.324833758077, 13675.79486307726, 13387.799183012068, 13402.798958015443, 13485.595432137052, 13833.446662133805, 13850.86149138536, 12679.0, 12695.111342206326, 12828.56257311108, 13327.533536326182, 13632.454701811816, 8467.110953350057, 8476.576171191538, 8510.276626486819, 8617.913820861711, 8774.429662071945, 11893.286402815858, 12852.678683032998, 12966.35168241603, 13359.0, 13598.86401135976], "unit": "score", "name": "jquery.html", "value": 7023.071819573877}, {"lowerIsBetter": false, "replicates": [1142.0535019649305, 1145.3700464744388, 1166.416791604198, 1213.696575856036, 1661.3022530537166, 5883.205767221424, 6947.30526947305, 7058.364747172754, 7069.293070692928, 7090.78727638171, 6672.633005184713, 6838.3161683831595, 6853.828654283633, 6868.62222577758, 6868.82827929302, 1748.0647853398434, 1761.779777527809, 1762.2510433065959, 2050.2311633137538, 2087.4781304673834, 1764.5765016396037, 1773.1754734048666, 2074.460640233535, 2099.748030236366, 2107.3677896631025, 2040.2043203150783, 2044.4071219346372, 2045.1103769860158, 2045.8772473651554, 2046.1610739596695, 1994.2023190723683, 2044.72396226509, 2048.5902819436096, 2048.6414877396546, 2053.219776484934, 2030.4720772599082, 2032.7763945965933, 2050.241410678059, 2061.391889392633, 2062.257587268582, 7155.0, 7210.2789721028, 7221.855562888765, 7224.0, 7228.096487939008, 4131.8967025824295, 4195.0, 4207.97896010518, 4209.2633789087095, 4211.220924129046, 2707.390837061665, 2712.2541301142146, 2714.7285271472892, 2746.1761471558652, 2790.8465034423098, 868.891388576428, 870.2124577257592, 896.3143195455482, 914.236612428623, 914.6965574056942, 9334.71995840126, 9357.532123393803, 9369.109934556207, 9373.343865929388, 9383.108604682544, 3764.642358975893, 3805.8667946621736, 3842.2315536892734, 3880.0881792778673, 3889.824957876846, 7838.0, 7838.176991415819, 7841.294283514511, 7864.685412583547, 7871.567063811431, 4153.709240353207, 4155.459790227251, 4173.4157217989505, 4175.498940127204, 4190.182914331676, 3797.4303854421505, 3827.483289755903, 3835.9808200959374, 3841.1741475582885, 3842.8078596070086, 3349.363620912019, 3349.916252093717, 3368.4778859276853, 3393.406153923103, 3397.3205358928312, 944.3483996042709, 965.9227261819037, 1090.220492347975, 1101.6805126513382, 1108.2187058124002, 865.7662431143556, 886.2821114896955, 887.6449420231959, 890.1543533642936, 918.6555041859302, 6656.201255849232, 6733.528652994341, 6741.7303307868115, 6743.0, 6747.561408508432, 989.618996686281, 1013.7871047080196, 1023.9078482936422, 1026.1175389165312, 1028.4292217819032, 5228.63399562027, 5257.7896884124975, 5263.7104959226845, 5266.499682530153, 5277.604179686462, 8450.535220562806, 8496.957515212385, 8650.653973841101, 8718.825623487495, 8749.300055995505, 8635.870461943075, 8689.56552172389, 8692.087330830298, 8712.0, 8745.91254087451, 6599.967000164968, 6697.531172817856, 6744.460443164535, 6780.593164410151, 6783.287754785676, 6427.58220715652, 6435.22777266731, 6457.354264573505, 6467.514936379885, 6483.4164925156965, 7141.9642901785155, 7360.742374016883, 7404.074490688664, 7728.652210650646, 7845.411594130577, 7387.261273872569, 7498.812529686801, 7528.096628404407, 7987.201279871966, 8037.196280371916, 6365.777197798055, 6470.352964703492, 6478.481721462366, 6479.2224933006455, 6479.352064793483, 5689.459501347365, 6464.741410343534, 6483.494174560101, 7000.719971201299, 7012.824679383056, 5469.070258056219, 6218.0, 6249.0626406039455, 6255.24937007562, 6346.809595712136, 6241.126242326169, 6267.091271765659, 6317.178766760292, 6356.618602883842, 6363.204599425072, 6381.074744162163, 6408.455281301141, 6412.871742565216, 6416.967915160394, 6424.229092508929, 5633.267675202197, 5707.828765137053, 5712.314522257356, 5725.8568535786935, 5806.767729290781, 5986.760529578943, 5991.88016239664, 6006.0, 6029.849253768515, 6031.276246850406], "unit": "score", "name": "mootools.html", "value": 3998.1425205487817}, {"lowerIsBetter": false, "replicates": [302.40577265672954, 309.14675495632054, 313.50153256322443, 322.5661485302269, 325.9771815972883, 5307.124324486455, 5381.058314794915, 5417.349918009834, 5419.75611097501, 5419.864503387413, 5317.069512835258, 5332.653377530468, 5334.773002209494, 5340.412554618999, 5349.170878513827, 3975.602439756016, 4065.8373665053364, 4200.663946884242, 4212.53662097169, 4222.218889505443, 4090.059286364123, 4129.463169787923, 4157.0646604513895, 4173.56177601352, 4175.686823488235, 4120.031792528754, 4120.217158739845, 4125.64931980782, 4130.607592278729, 4130.814113364906, 3946.151577410856, 4017.2568074905944, 4042.7776472294013, 4123.752574845519, 4132.070284186064, 3633.854645814164, 3653.2328211075705, 3655.122770535079, 3660.7803531788177, 3661.56061272649, 5082.3138876251605, 5133.948660513422, 5135.6148288878485, 5171.50870667286, 5171.689698618095, 4799.208130658437, 4811.398575178103, 4814.927776083362, 4817.78319975602, 4824.6863953842885, 5483.972580137113, 5611.410801865827, 5630.15547667849, 5630.268065151545, 5630.465105814941, 4006.959930400688, 4010.6590939770153, 4015.7992100394863, 4019.135885784541, 4024.5371782245124, 5912.970435147797, 5918.201042859202, 5924.229850119457, 5926.6444013358905, 5930.7034648267845, 4150.128473020639, 4156.147989662112, 4157.376393540993, 4160.791960402028, 4177.373393990925, 4121.5878412159145, 4197.391378250137, 4210.642095421862, 4218.704690671623, 4242.109157077049, 4759.547842954914, 4769.618430525549, 4777.187878060738, 4782.784774685148, 4784.976075119672, 5624.55003599711, 5630.183623374588, 5631.436856314336, 5639.520640745501, 5651.26533550644, 1476.6086986948467, 1497.475883440787, 1498.400639744111, 1500.0849481816083, 1500.0849481816083, 1013.133770626104, 1032.194887987371, 1037.3775734559204, 1037.9169666426667, 1062.7290041039485, 4877.365942427462, 4880.975595122072, 4885.096257192431, 4888.682235654671, 4892.315075889378, 5837.503812175928, 5840.445157710011, 5852.970735146297, 5856.970715146397, 5865.706714664249, 4884.218525035977, 4885.340479035356, 4886.755662216875, 4889.315495830587, 4898.608111351084, 2912.184588315275, 2986.8357240351556, 3032.5906002689353, 3128.1710346758127, 3160.683931606821, 5485.122380419114, 5579.776808927598, 5598.608097433222, 5600.719964001783, 5604.6917419542315, 6034.668093254825, 6039.305479869871, 6044.879102417927, 6044.969775151096, 6049.153118563317, 5431.646942948696, 5575.721213939287, 5578.63738856973, 5579.884023195377, 5586.636868603528, 5841.678707671119, 5874.412558744091, 5879.470847623735, 5894.528437725057, 5894.911576326273, 5724.4561766632105, 5729.796742684083, 5730.885382292247, 5733.942660573341, 5738.5696072795545, 5571.944280557304, 5583.55331573465, 5585.078462053716, 5589.944100559105, 5590.748416321357, 4113.362428823537, 4177.644900183518, 4190.392393103044, 4209.726367786084, 4213.136307056985, 5846.298444186725, 5865.032269675456, 5870.295564532284, 5892.145638882424, 5896.70516474166, 5666.858328541819, 5667.1782591524825, 5668.914966275427, 5676.68778217202, 5676.829695109153, 5477.233187353853, 5612.102063669957, 5613.663180209201, 5614.719264036864, 5635.0, 5562.777488900399, 5573.498385145356, 5582.358028826737, 5584.162375643686, 5585.441455854382, 5714.428557144252, 5727.914081288867, 5749.252597162342, 5750.396208398058, 5755.7409916553015, 5576.358718747234, 5585.832425027255, 5585.916211256916, 5588.469095435927, 5588.804391846428], "unit": "score", "name": "prototype.html", "value": 4264.726268683221}, {"lowerIsBetter": false, "replicates": [630.6153246519625, 693.0609024771435, 697.8743826111302, 700.6566782276686, 701.8982247574102, 11038.668839934804, 11209.439528023586, 11218.270812397188, 11234.550617975281, 11250.493727782248, 11236.0, 11347.0, 11350.20548561601, 11362.488688009038, 11379.544818207261, 611.8837420890039, 620.9689515524228, 770.1566784371119, 780.6955287437904, 785.5914924239393, 771.440705488522, 773.9690412383497, 776.8446310737846, 781.3007358414216, 781.9218078192192, 810.9391795615353, 816.2286639126029, 816.2694388522269, 816.2816721285261, 816.6161903905155, 639.0669622351372, 646.4505170604972, 803.8352137811735, 820.6963423533272, 820.9958950205271, 604.2959951656316, 606.8027890935464, 607.0651197156418, 607.5655906027167, 608.3369127650838, 10884.129269658408, 10932.398718070503, 10937.945310273397, 11000.614978475714, 11030.0, 10082.294239403245, 10715.62495312668, 10805.459727013696, 10905.618303359344, 10930.125589952784, 8798.560071996439, 8800.47197168172, 8877.378583499158, 8886.688965886227, 8910.108989101038, 3154.036651807826, 3164.430402527544, 3225.193701574606, 3252.36578867121, 3262.5106234064842, 38415.23169536594, 39339.0, 39427.605723942965, 39444.80277598622, 39504.0, 8863.689770857989, 8878.245349145265, 8980.416272942239, 9086.636534538544, 9089.636414543344, 16046.277917493508, 16058.518244452685, 16062.919685401499, 16074.0, 16076.919615402083, 5849.0, 5893.469587737124, 5942.346341902387, 6015.398460154037, 6088.178095957078, 3309.303740041701, 3378.847951842173, 3404.4893266010295, 3416.8974930752115, 3502.2120022994623, 2922.167182353019, 2990.088023152959, 2995.670476247611, 3000.9549856752164, 3002.23443022028, 540.0198639469351, 546.2980070609327, 550.1390324142703, 553.4465534465535, 553.9362973258127, 399.6283456385589, 400.44538314434135, 402.31003828434376, 403.9555648878621, 405.1532297498243, 6125.509959203253, 6247.312795592481, 6440.67796610177, 6473.190851143607, 6567.540272180901, 417.71386600178977, 438.57020120281663, 450.6538948308859, 462.54670422985663, 534.0920435260074, 3155.731762800188, 3298.3897978873983, 3328.3509715605223, 3341.281624450755, 3383.0696558446625, 49553.0, 49691.75154124206, 49790.751046244535, 49870.50129498731, 49936.0, 45295.773521132185, 45446.0, 45481.54518454773, 45654.54345456569, 46097.53902460999, 38416.61583384186, 39224.215515689524, 39523.40714889336, 40258.59741402607, 40345.19309613791, 6936.79189624312, 7200.495965282589, 7229.7469588564145, 7312.361893884932, 7350.191478937206, 30288.0, 30319.0, 30629.693703062683, 30644.92742753993, 30847.537286940264, 36464.27071458503, 36516.26967460583, 36749.03887975196, 41181.0, 41266.79366603148, 9185.954070229605, 9376.624935002796, 9672.85490717654, 9686.660966866126, 9938.801223975624, 10661.733456663334, 10761.730956726144, 10765.623203187852, 10988.945055274673, 11069.778604428027, 9318.720438386588, 9453.291003174652, 9616.51917404141, 9742.123208911233, 9952.353097048668, 9330.626774928927, 9491.952540237255, 9604.75988100303, 9754.609815607297, 9994.950025249827, 9067.410618309788, 9137.451752894847, 9336.626534938527, 9459.337846350689, 9780.608775648894, 8378.371622128243, 8414.957925210334, 8510.276626486819, 8593.484390936565, 8613.526256055977, 8086.474379165335, 8102.351811854919, 8143.5113893164225, 8157.780796966233, 8265.297449716842], "unit": "score", "name": "yui.html", "value": 5383.219829307262}], "name": "dromaeo_css", "value": 6045.9373439233495}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 111.0, 113.0, 114.0, 100.0, 112.0, 110.0, 104.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 155.0, 165.0, 130.0, 154.0, 172.0, 130.0, 174.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 91.0, 71.0, 72.0, 76.0, 117.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 132.0, 97.0, 97.0, 98.0, 133.0, 97.0, 97.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 69.0, 80.0, 68.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 70.0, 70.0, 68.0, 68.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 85.0, 87.0, 86.0, 85.0, 84.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 136.0, 127.0, 128.0, 127.0, 129.0, 121.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 142.0, 140.0, 149.0, 148.0, 147.0, 147.0, 145.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1525.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [2012.0724346076458], "unit": "score", "name": "RayTrace", "value": 367.77453300000013}, {"lowerIsBetter": false, "replicates": [807.909604519774], "unit": "score", "name": "Earley", "value": 824.9227342657342}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19631.065860676437}]} 05:50:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19631.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1525.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6045.94"}}} 05:50:35 INFO - Return code: 0 05:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:50:35 INFO - # TBPL SUCCESS # 05:50:35 INFO - Running post-action listener: _resource_record_post_action 05:50:35 INFO - Running post-run listener: _resource_record_post_run 05:50:36 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559382528; Read time: 8; Write time: 522972 05:50:36 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241553408; Read time: 0; Write time: 355292 05:50:36 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317829120; Read time: 8; Write time: 167680 05:50:36 INFO - Running post-run listener: _upload_blobber_files 05:50:36 INFO - Blob upload gear active. 05:50:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:50:36 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'] 05:50:36 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 05:50:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:37 INFO - (blobuploader) - INFO - Done attempting. 05:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:50:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:38 INFO - (blobuploader) - INFO - Done attempting. 05:50:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:38 INFO - Return code: 0 05:50:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/47416ae1b21e2ac638168378b0b9dd23ab94fedf3f69b6dac0a7bec9f05325987aacf5c30df96c608fb21fe61c652a5ec9dbc7a0eb49b86b090b82407d0b4b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f99c9c10e74106eacd151546e570c63a5037dec9f9e699af4cd16a8e2836e2acffca69cb1adcfe4602a7b699c660f1b43caaf45302f0a209f23c19e991b21c63"} 05:50:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:38 INFO - Contents: 05:50:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/47416ae1b21e2ac638168378b0b9dd23ab94fedf3f69b6dac0a7bec9f05325987aacf5c30df96c608fb21fe61c652a5ec9dbc7a0eb49b86b090b82407d0b4b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f99c9c10e74106eacd151546e570c63a5037dec9f9e699af4cd16a8e2836e2acffca69cb1adcfe4602a7b699c660f1b43caaf45302f0a209f23c19e991b21c63"} 05:50:38 INFO - Copying logs to upload dir... 05:50:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.387789 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-29 05:50:38.229344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 05:50:38.232376) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 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/47416ae1b21e2ac638168378b0b9dd23ab94fedf3f69b6dac0a7bec9f05325987aacf5c30df96c608fb21fe61c652a5ec9dbc7a0eb49b86b090b82407d0b4b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f99c9c10e74106eacd151546e570c63a5037dec9f9e699af4cd16a8e2836e2acffca69cb1adcfe4602a7b699c660f1b43caaf45302f0a209f23c19e991b21c63"} build_url:https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/uyPKyVnpT3afAfNuqZ_ejA/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/47416ae1b21e2ac638168378b0b9dd23ab94fedf3f69b6dac0a7bec9f05325987aacf5c30df96c608fb21fe61c652a5ec9dbc7a0eb49b86b090b82407d0b4b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/f99c9c10e74106eacd151546e570c63a5037dec9f9e699af4cd16a8e2836e2acffca69cb1adcfe4602a7b699c660f1b43caaf45302f0a209f23c19e991b21c63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 05:50:38.259286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:50:38.259624) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451395594.793340-1476273467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:50:38.345549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 05:50:38.346076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 05:50:38.346391) ========= ========= Total master_lag: 0.23 =========