builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1452600349.69 results: success (0) buildid: 20160112025356 builduid: 3c86c33ceeff423ea5050dab21198741 revision: 430d06869ac32ff855cdfb07d1c4518b091a0cff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.692317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.692904) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.693226) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.722075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.722380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.749756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.750050) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.816869) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.817187) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.817586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:49.817919) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 04:05:50-- 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% 224M=0s 2016-01-12 04:05:50 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:50.002139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:50.002513) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:50.052945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 04:05:50.053351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 430d06869ac32ff855cdfb07d1c4518b091a0cff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 430d06869ac32ff855cdfb07d1c4518b091a0cff --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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 04:05:50,963 truncating revision to first 12 chars 2016-01-12 04:05:50,963 Setting DEBUG logging. 2016-01-12 04:05:50,963 attempt 1/10 2016-01-12 04:05:50,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/430d06869ac3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 04:05:51,891 unpacking tar archive at: mozilla-central-430d06869ac3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 04:05:51.305738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:51.306110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:51.318412) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:51.321132) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 04:05:51.321718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-12 04:05:51.322064) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:52 INFO - MultiFileLogger online at 20160112 04:05:52 in /builds/slave/test 04:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:05:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:52 INFO - {'append_to_log': False, 04:05:52 INFO - 'base_work_dir': '/builds/slave/test', 04:05:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:52 INFO - 'branch': 'Firefox-Non-PGO', 04:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:52 INFO - 'config_files': ('talos/linux_config.py',), 04:05:52 INFO - 'default_actions': ('clobber', 04:05:52 INFO - 'read-buildbot-config', 04:05:52 INFO - 'download-and-extract', 04:05:52 INFO - 'populate-webroot', 04:05:52 INFO - 'create-virtualenv', 04:05:52 INFO - 'install', 04:05:52 INFO - 'run-tests'), 04:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:52 INFO - 'download_minidump_stackwalk': True, 04:05:52 INFO - 'download_symbols': 'ondemand', 04:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:52 INFO - 'installer_path': 'installer.exe', 04:05:52 INFO - 'log_level': 'info', 04:05:52 INFO - 'log_name': 'talos', 04:05:52 INFO - 'log_to_console': True, 04:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:52 INFO - 'opt_config_files': (), 04:05:52 INFO - 'pip_index': False, 04:05:52 INFO - 'sps_profile': False, 04:05:52 INFO - 'sps_profile_interval': 0, 04:05:52 INFO - 'suite': 'dromaeojs', 04:05:52 INFO - 'system_bits': '32', 04:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:52 INFO - 'title': 'talos-linux64-ix-009', 04:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:52 INFO - 'use_talos_json': True, 04:05:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:52 INFO - 'work_dir': 'build'} 04:05:52 INFO - ##### 04:05:52 INFO - ##### Running clobber step. 04:05:52 INFO - ##### 04:05:52 INFO - Running pre-action listener: _resource_record_pre_action 04:05:52 INFO - Running main action method: clobber 04:05:52 INFO - rmtree: /builds/slave/test/build 04:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:52 INFO - Running post-action listener: _resource_record_post_action 04:05:52 INFO - ##### 04:05:52 INFO - ##### Running read-buildbot-config step. 04:05:52 INFO - ##### 04:05:52 INFO - Running pre-action listener: _resource_record_pre_action 04:05:52 INFO - Running main action method: read_buildbot_config 04:05:52 INFO - Using buildbot properties: 04:05:52 INFO - { 04:05:52 INFO - "project": "", 04:05:52 INFO - "product": "firefox", 04:05:52 INFO - "script_repo_revision": "production", 04:05:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:05:52 INFO - "repository": "", 04:05:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:05:52 INFO - "buildid": "20160112025356", 04:05:52 INFO - "pgo_build": "False", 04:05:52 INFO - "basedir": "/builds/slave/test", 04:05:52 INFO - "buildnumber": 256, 04:05:52 INFO - "slavename": "talos-linux64-ix-009", 04:05:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:52 INFO - "platform": "ubuntu64_hw", 04:05:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:05:52 INFO - "branch": "mozilla-central", 04:05:52 INFO - "repo_path": "mozilla-central", 04:05:52 INFO - "revision": "430d06869ac32ff855cdfb07d1c4518b091a0cff", 04:05:52 INFO - "stage_platform": "linux64", 04:05:52 INFO - "builduid": "3c86c33ceeff423ea5050dab21198741", 04:05:52 INFO - "slavebuilddir": "test" 04:05:52 INFO - } 04:05:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:05:52 INFO - Running post-action listener: _resource_record_post_action 04:05:52 INFO - ##### 04:05:52 INFO - ##### Running download-and-extract step. 04:05:52 INFO - ##### 04:05:52 INFO - Running pre-action listener: _resource_record_pre_action 04:05:52 INFO - Running main action method: download_and_extract 04:05:52 INFO - mkdir: /builds/slave/test/build/tests 04:05:52 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')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/test_packages.json 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/test_packages.json 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:05:55 INFO - Downloaded 1302 bytes. 04:05:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:05:55 INFO - Using the following test package requirements: 04:05:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'jsshell-linux-x86_64.zip'], 04:05:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:55 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')]} 04:05:55 INFO - https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:05:58 INFO - Downloaded 22756673 bytes. 04:05:58 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 04:05:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:58 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 04:05:59 INFO - Return code: 0 04:05:59 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 04:05: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')]} 04:05:59 INFO - https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:06:06 INFO - Downloaded 22756673 bytes. 04:06:06 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 04:06:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:06:06 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 04:06:07 INFO - Return code: 0 04:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:07 INFO - https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:06:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:06:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:06:09 INFO - Downloaded 11132285 bytes. 04:06:09 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 04:06:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:09 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 04:06:09 INFO - Return code: 0 04:06:09 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')]} 04:06:09 INFO - https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SPadioCqTnin9qgrlYy_9g/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 04:06:12 INFO - Downloaded 53746697 bytes. 04:06:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:06:12 INFO - mkdir: /builds/slave/test/properties 04:06:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:12 INFO - Contents: 04:06:12 INFO - build_url:https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:06:12 INFO - Running post-action listener: _resource_record_post_action 04:06:12 INFO - Running post-action listener: set_extra_try_arguments 04:06:12 INFO - ##### 04:06:12 INFO - ##### Running populate-webroot step. 04:06:12 INFO - ##### 04:06:12 INFO - Running pre-action listener: _resource_record_pre_action 04:06:12 INFO - Running main action method: populate_webroot 04:06:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:12 INFO - '--tppagecycles', 04:06:12 INFO - '7'], 04:06:12 INFO - 'tests': ['tsvgm']}}, 04:06:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:06:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:06:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:06:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'tests': ['damp', 'tps']}, 04:06:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['damp', 'tps']}, 04:06:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:06:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:12 INFO - 'other': {'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'other_l64': {'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:06:12 INFO - 'ts_paint', 04:06:12 INFO - 'tpaint', 04:06:12 INFO - 'sessionrestore', 04:06:12 INFO - 'sessionrestore_no_auto_restore']}, 04:06:12 INFO - 'svgr': {'tests': ['tsvgx', 04:06:12 INFO - 'tsvgr_opacity', 04:06:12 INFO - 'tart', 04:06:12 INFO - 'tscrollx', 04:06:12 INFO - 'cart']}, 04:06:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['tsvgx', 04:06:12 INFO - 'tsvgr_opacity', 04:06:12 INFO - 'tart', 04:06:12 INFO - 'tscrollx', 04:06:12 INFO - 'cart']}, 04:06:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'tests': ['tp5o']}, 04:06:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'talos_options': ['--e10s'], 04:06:12 INFO - 'tests': ['tp5o']}, 04:06:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'talos_options': ['--xperf_path', 04:06:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:12 INFO - 'tests': ['tp5n']}, 04:06:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:12 INFO - 'talos_options': ['--e10s', 04:06:12 INFO - '--xperf_path', 04:06:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:12 INFO - 'tests': ['tp5n']}}, 04:06:12 INFO - 'talos.zip': {'path': '', 04:06:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:12 INFO - Running post-action listener: _resource_record_post_action 04:06:12 INFO - ##### 04:06:12 INFO - ##### Running create-virtualenv step. 04:06:12 INFO - ##### 04:06:12 INFO - Running pre-action listener: _resource_record_pre_action 04:06:12 INFO - Running main action method: create_virtualenv 04:06:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:12 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 04:06:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:12 INFO - Using real prefix '/usr' 04:06:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:15 INFO - Installing pip.................done. 04:06:15 INFO - Return code: 0 04:06:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:15 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')]} 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 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')]} 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:15 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 04:06:15 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 04:06:15 INFO - Using env: {'DISPLAY': ':0', 04:06:15 INFO - 'HOME': '/home/cltbld', 04:06:15 INFO - 'LANG': 'en_US.UTF-8', 04:06:15 INFO - 'LANGUAGE': 'en_US:en', 04:06:15 INFO - 'LOGNAME': 'cltbld', 04:06:15 INFO - 'MAIL': '/var/mail/cltbld', 04:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:15 INFO - 'MOZ_NO_REMOTE': '1', 04:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:15 INFO - 'NO_EM_RESTART': '1', 04:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:15 INFO - 'PWD': '/builds/slave/test', 04:06:15 INFO - 'SHELL': '/bin/bash', 04:06:15 INFO - 'SHLVL': '1', 04:06:15 INFO - 'TERM': 'linux', 04:06:15 INFO - 'TMOUT': '86400', 04:06:15 INFO - 'USER': 'cltbld', 04:06:15 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:15 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 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 04:06:15 INFO - Cleaning up... 04:06:15 INFO - Return code: 0 04:06:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:15 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')]} 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 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')]} 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:15 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 04:06:15 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 04:06:15 INFO - Using env: {'DISPLAY': ':0', 04:06:15 INFO - 'HOME': '/home/cltbld', 04:06:15 INFO - 'LANG': 'en_US.UTF-8', 04:06:15 INFO - 'LANGUAGE': 'en_US:en', 04:06:15 INFO - 'LOGNAME': 'cltbld', 04:06:15 INFO - 'MAIL': '/var/mail/cltbld', 04:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:15 INFO - 'MOZ_NO_REMOTE': '1', 04:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:15 INFO - 'NO_EM_RESTART': '1', 04:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:15 INFO - 'PWD': '/builds/slave/test', 04:06:15 INFO - 'SHELL': '/bin/bash', 04:06:15 INFO - 'SHLVL': '1', 04:06:15 INFO - 'TERM': 'linux', 04:06:15 INFO - 'TMOUT': '86400', 04:06:15 INFO - 'USER': 'cltbld', 04:06:15 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:15 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 INFO - Downloading/unpacking psutil>=0.7.1 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:06:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:17 INFO - Installing collected packages: psutil 04:06:17 INFO - Running setup.py install for psutil 04:06:17 INFO - building 'psutil._psutil_linux' extension 04:06:17 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 04:06:17 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 04:06:17 INFO - building 'psutil._psutil_posix' extension 04:06:17 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 04:06:17 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 04:06:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:17 INFO - Successfully installed psutil 04:06:17 INFO - Cleaning up... 04:06:17 INFO - Return code: 0 04:06:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:17 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')]} 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:17 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')]} 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:17 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:17 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 04:06:17 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 04:06:17 INFO - Using env: {'DISPLAY': ':0', 04:06:17 INFO - 'HOME': '/home/cltbld', 04:06:17 INFO - 'LANG': 'en_US.UTF-8', 04:06:17 INFO - 'LANGUAGE': 'en_US:en', 04:06:17 INFO - 'LOGNAME': 'cltbld', 04:06:17 INFO - 'MAIL': '/var/mail/cltbld', 04:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:17 INFO - 'MOZ_NO_REMOTE': '1', 04:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:17 INFO - 'NO_EM_RESTART': '1', 04:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:17 INFO - 'PWD': '/builds/slave/test', 04:06:17 INFO - 'SHELL': '/bin/bash', 04:06:17 INFO - 'SHLVL': '1', 04:06:17 INFO - 'TERM': 'linux', 04:06:17 INFO - 'TMOUT': '86400', 04:06:17 INFO - 'USER': 'cltbld', 04:06:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:17 INFO - '_': '/tools/buildbot/bin/python'} 04:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:18 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 04:06:18 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 04:06:18 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 04:06:18 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 04:06:18 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 04:06:18 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 04:06:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:19 INFO - Installing collected packages: mozsystemmonitor 04:06:19 INFO - Running setup.py install for mozsystemmonitor 04:06:20 INFO - Successfully installed mozsystemmonitor 04:06:20 INFO - Cleaning up... 04:06:20 INFO - Return code: 0 04:06:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:20 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')]} 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:20 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')]} 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:20 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:20 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 04:06:20 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 04:06:20 INFO - Using env: {'DISPLAY': ':0', 04:06:20 INFO - 'HOME': '/home/cltbld', 04:06:20 INFO - 'LANG': 'en_US.UTF-8', 04:06:20 INFO - 'LANGUAGE': 'en_US:en', 04:06:20 INFO - 'LOGNAME': 'cltbld', 04:06:20 INFO - 'MAIL': '/var/mail/cltbld', 04:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:20 INFO - 'MOZ_NO_REMOTE': '1', 04:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:20 INFO - 'NO_EM_RESTART': '1', 04:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:20 INFO - 'PWD': '/builds/slave/test', 04:06:20 INFO - 'SHELL': '/bin/bash', 04:06:20 INFO - 'SHLVL': '1', 04:06:20 INFO - 'TERM': 'linux', 04:06:20 INFO - 'TMOUT': '86400', 04:06:20 INFO - 'USER': 'cltbld', 04:06:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:20 INFO - '_': '/tools/buildbot/bin/python'} 04:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 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 04:06:22 INFO - Downloading docopt-0.6.1.tar.gz 04:06:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:22 INFO - Running setup.py install for blobuploader 04:06:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:22 INFO - Running setup.py install for requests 04:06:23 INFO - Running setup.py install for docopt 04:06:23 INFO - Successfully installed blobuploader requests docopt 04:06:23 INFO - Cleaning up... 04:06:23 INFO - Return code: 0 04:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:23 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:23 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 04:06:23 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 04:06:23 INFO - Using env: {'DISPLAY': ':0', 04:06:23 INFO - 'HOME': '/home/cltbld', 04:06:23 INFO - 'LANG': 'en_US.UTF-8', 04:06:23 INFO - 'LANGUAGE': 'en_US:en', 04:06:23 INFO - 'LOGNAME': 'cltbld', 04:06:23 INFO - 'MAIL': '/var/mail/cltbld', 04:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:23 INFO - 'MOZ_NO_REMOTE': '1', 04:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:23 INFO - 'NO_EM_RESTART': '1', 04:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:23 INFO - 'PWD': '/builds/slave/test', 04:06:23 INFO - 'SHELL': '/bin/bash', 04:06:23 INFO - 'SHLVL': '1', 04:06:23 INFO - 'TERM': 'linux', 04:06:23 INFO - 'TMOUT': '86400', 04:06:23 INFO - 'USER': 'cltbld', 04:06:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:23 INFO - '_': '/tools/buildbot/bin/python'} 04:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:23 INFO - Running setup.py (path:/tmp/pip-VwHddn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:23 INFO - Running setup.py (path:/tmp/pip-PiMa0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:23 INFO - Running setup.py (path:/tmp/pip-rtZ6ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:23 INFO - Running setup.py (path:/tmp/pip-c3QjSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:23 INFO - Running setup.py (path:/tmp/pip-kBv7FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:23 INFO - Running setup.py (path:/tmp/pip-pdYBaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:23 INFO - Running setup.py (path:/tmp/pip-jHeCjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:24 INFO - Running setup.py (path:/tmp/pip-ttULaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:24 INFO - Running setup.py (path:/tmp/pip-m38uOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:24 INFO - Running setup.py (path:/tmp/pip-knV373-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:24 INFO - Running setup.py (path:/tmp/pip-UOT3Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:24 INFO - Running setup.py (path:/tmp/pip-WMAwKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:24 INFO - Running setup.py (path:/tmp/pip-f42vD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:24 INFO - Running setup.py (path:/tmp/pip-A7znnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:24 INFO - Running setup.py (path:/tmp/pip-hYEu_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:24 INFO - Running setup.py (path:/tmp/pip-FDbuag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:24 INFO - Running setup.py (path:/tmp/pip-NVTobL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:24 INFO - Running setup.py install for manifestparser 04:06:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:24 INFO - Running setup.py install for mozcrash 04:06:24 INFO - Running setup.py install for mozdebug 04:06:25 INFO - Running setup.py install for mozdevice 04:06:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozfile 04:06:25 INFO - Running setup.py install for mozhttpd 04:06:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozinfo 04:06:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozInstall 04:06:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozleak 04:06:25 INFO - Running setup.py install for mozlog 04:06:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for moznetwork 04:06:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozprocess 04:06:25 INFO - Running setup.py install for mozprofile 04:06:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Running setup.py install for mozrunner 04:06:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Running setup.py install for mozscreenshot 04:06:26 INFO - Running setup.py install for moztest 04:06:26 INFO - Running setup.py install for mozversion 04:06:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:26 INFO - Cleaning up... 04:06:26 INFO - Return code: 0 04:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:26 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:26 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 04:06:26 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 04:06:26 INFO - Using env: {'DISPLAY': ':0', 04:06:26 INFO - 'HOME': '/home/cltbld', 04:06:26 INFO - 'LANG': 'en_US.UTF-8', 04:06:26 INFO - 'LANGUAGE': 'en_US:en', 04:06:26 INFO - 'LOGNAME': 'cltbld', 04:06:26 INFO - 'MAIL': '/var/mail/cltbld', 04:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:26 INFO - 'MOZ_NO_REMOTE': '1', 04:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:26 INFO - 'NO_EM_RESTART': '1', 04:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:26 INFO - 'PWD': '/builds/slave/test', 04:06:26 INFO - 'SHELL': '/bin/bash', 04:06:26 INFO - 'SHLVL': '1', 04:06:26 INFO - 'TERM': 'linux', 04:06:26 INFO - 'TMOUT': '86400', 04:06:26 INFO - 'USER': 'cltbld', 04:06:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:26 INFO - '_': '/tools/buildbot/bin/python'} 04:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:26 INFO - Running setup.py (path:/tmp/pip-xSldYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:26 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)) 04:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:26 INFO - Running setup.py (path:/tmp/pip-TG8ylS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:26 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)) 04:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:26 INFO - Running setup.py (path:/tmp/pip-1Bhtj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:26 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)) 04:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:26 INFO - Running setup.py (path:/tmp/pip-rl9kdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:27 INFO - Running setup.py (path:/tmp/pip-uKQMyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:27 INFO - Running setup.py (path:/tmp/pip-5PeU26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:27 INFO - Running setup.py (path:/tmp/pip-yNZTXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:27 INFO - Running setup.py (path:/tmp/pip-V9uIDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:27 INFO - Running setup.py (path:/tmp/pip-tKyKpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:27 INFO - Running setup.py (path:/tmp/pip-qWZHo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:27 INFO - Running setup.py (path:/tmp/pip-BF08P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:27 INFO - Running setup.py (path:/tmp/pip-_rsi7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:27 INFO - Running setup.py (path:/tmp/pip-XO9HIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:27 INFO - Running setup.py (path:/tmp/pip-DolNLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:27 INFO - Running setup.py (path:/tmp/pip-WXzAJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:27 INFO - Running setup.py (path:/tmp/pip-onPNSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:27 INFO - Running setup.py (path:/tmp/pip-mDjTdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:27 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)) 04:06:27 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)) 04:06:27 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)) 04:06:27 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)) 04:06:27 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)) 04:06:27 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)) 04:06:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:29 INFO - Downloading blessings-1.5.1.tar.gz 04:06:29 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 04:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:29 INFO - Installing collected packages: blessings 04:06:29 INFO - Running setup.py install for blessings 04:06:29 INFO - Successfully installed blessings 04:06:29 INFO - Cleaning up... 04:06:29 INFO - Return code: 0 04:06:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:30 INFO - Reading from file tmpfile_stdout 04:06:30 INFO - Current package versions: 04:06:30 INFO - argparse == 1.2.1 04:06:30 INFO - blessings == 1.5.1 04:06:30 INFO - blobuploader == 1.2.4 04:06:30 INFO - docopt == 0.6.1 04:06:30 INFO - manifestparser == 1.1 04:06:30 INFO - mozInstall == 1.12 04:06:30 INFO - mozcrash == 0.16 04:06:30 INFO - mozdebug == 0.1 04:06:30 INFO - mozdevice == 0.47 04:06:30 INFO - mozfile == 1.2 04:06:30 INFO - mozhttpd == 0.7 04:06:30 INFO - mozinfo == 0.9 04:06:30 INFO - mozleak == 0.1 04:06:30 INFO - mozlog == 3.1 04:06:30 INFO - moznetwork == 0.27 04:06:30 INFO - mozprocess == 0.22 04:06:30 INFO - mozprofile == 0.28 04:06:30 INFO - mozrunner == 6.11 04:06:30 INFO - mozscreenshot == 0.1 04:06:30 INFO - mozsystemmonitor == 0.0 04:06:30 INFO - moztest == 0.7 04:06:30 INFO - mozversion == 1.4 04:06:30 INFO - psutil == 3.1.1 04:06:30 INFO - requests == 1.2.3 04:06:30 INFO - wsgiref == 0.1.2 04:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:30 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:30 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 04:06:30 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 04:06:30 INFO - Using env: {'DISPLAY': ':0', 04:06:30 INFO - 'HOME': '/home/cltbld', 04:06:30 INFO - 'LANG': 'en_US.UTF-8', 04:06:30 INFO - 'LANGUAGE': 'en_US:en', 04:06:30 INFO - 'LOGNAME': 'cltbld', 04:06:30 INFO - 'MAIL': '/var/mail/cltbld', 04:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:30 INFO - 'MOZ_NO_REMOTE': '1', 04:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:30 INFO - 'NO_EM_RESTART': '1', 04:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:30 INFO - 'PWD': '/builds/slave/test', 04:06:30 INFO - 'SHELL': '/bin/bash', 04:06:30 INFO - 'SHLVL': '1', 04:06:30 INFO - 'TERM': 'linux', 04:06:30 INFO - 'TMOUT': '86400', 04:06:30 INFO - 'USER': 'cltbld', 04:06:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:30 INFO - '_': '/tools/buildbot/bin/python'} 04:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 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)) 04:06:30 INFO - Cleaning up... 04:06:30 INFO - Return code: 0 04:06:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:30 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:30 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 04:06:30 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 04:06:30 INFO - Using env: {'DISPLAY': ':0', 04:06:30 INFO - 'HOME': '/home/cltbld', 04:06:30 INFO - 'LANG': 'en_US.UTF-8', 04:06:30 INFO - 'LANGUAGE': 'en_US:en', 04:06:30 INFO - 'LOGNAME': 'cltbld', 04:06:30 INFO - 'MAIL': '/var/mail/cltbld', 04:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:30 INFO - 'MOZ_NO_REMOTE': '1', 04:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:30 INFO - 'NO_EM_RESTART': '1', 04:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:30 INFO - 'PWD': '/builds/slave/test', 04:06:30 INFO - 'SHELL': '/bin/bash', 04:06:30 INFO - 'SHLVL': '1', 04:06:30 INFO - 'TERM': 'linux', 04:06:30 INFO - 'TMOUT': '86400', 04:06:30 INFO - 'USER': 'cltbld', 04:06:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:30 INFO - '_': '/tools/buildbot/bin/python'} 04:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:30 INFO - Downloading/unpacking jsonschema 04:06:30 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 04:06:30 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 04:06:30 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 04:06:30 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 04:06:30 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 04:06:30 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 04:06:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:32 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 04:06:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:32 INFO - warning: no files found matching '*.txt' 04:06:32 INFO - no previously-included directories found matching 'build' 04:06:32 INFO - no previously-included directories found matching 'dist' 04:06:32 INFO - no previously-included directories found matching '.git*' 04:06:32 INFO - Installing collected packages: jsonschema, functools32 04:06:32 INFO - Running setup.py install for functools32 04:06:32 INFO - warning: no files found matching '*.txt' 04:06:32 INFO - no previously-included directories found matching 'build' 04:06:32 INFO - no previously-included directories found matching 'dist' 04:06:32 INFO - no previously-included directories found matching '.git*' 04:06:32 INFO - Successfully installed jsonschema functools32 04:06:32 INFO - Cleaning up... 04:06:32 INFO - Return code: 0 04:06:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:32 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')]} 04:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:32 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')]} 04:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:32 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 0x7f273f2b3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1676dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, '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': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', '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 04:06:32 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 04:06:32 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 04:06:32 INFO - Using env: {'DISPLAY': ':0', 04:06:32 INFO - 'HOME': '/home/cltbld', 04:06:32 INFO - 'LANG': 'en_US.UTF-8', 04:06:32 INFO - 'LANGUAGE': 'en_US:en', 04:06:32 INFO - 'LOGNAME': 'cltbld', 04:06:32 INFO - 'MAIL': '/var/mail/cltbld', 04:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:32 INFO - 'MOZ_NO_REMOTE': '1', 04:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:32 INFO - 'NO_EM_RESTART': '1', 04:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:32 INFO - 'PWD': '/builds/slave/test', 04:06:32 INFO - 'SHELL': '/bin/bash', 04:06:32 INFO - 'SHLVL': '1', 04:06:32 INFO - 'TERM': 'linux', 04:06:32 INFO - 'TMOUT': '86400', 04:06:32 INFO - 'USER': 'cltbld', 04:06:32 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:32 INFO - '_': '/tools/buildbot/bin/python'} 04:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:32 INFO - Downloading/unpacking flake8 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:34 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 04:06:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:34 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 04:06:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:35 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 04:06:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:35 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 04:06:35 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 04:06:35 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 04:06:35 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 04:06:35 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 04:06:35 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 04:06:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:35 INFO - no previously-included directories found matching 'docs/_build' 04:06:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:35 INFO - Running setup.py install for pep8 04:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:35 INFO - no previously-included directories found matching 'docs/_build' 04:06:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:35 INFO - Cleaning up... 04:06:35 INFO - Return code: 0 04:06:35 INFO - Running post-action listener: _resource_record_post_action 04:06:35 INFO - Running post-action listener: _start_resource_monitoring 04:06:35 INFO - Starting resource monitoring. 04:06:35 INFO - ##### 04:06:35 INFO - ##### Running install step. 04:06:35 INFO - ##### 04:06:35 INFO - Running pre-action listener: _resource_record_pre_action 04:06:35 INFO - Running main action method: install 04:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:35 INFO - Reading from file tmpfile_stdout 04:06:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:35 INFO - Reading from file tmpfile_stdout 04:06:35 INFO - Output received: 04:06:35 INFO - Usage: mozinstall [options] installer 04:06:35 INFO - Options: 04:06:35 INFO - -h, --help show this help message and exit 04:06:35 INFO - -d DEST, --destination=DEST 04:06:35 INFO - Directory to install application into. [default: 04:06:35 INFO - "/builds/slave/test"] 04:06:35 INFO - --app=APP Application being installed. [default: firefox] 04:06:35 INFO - mkdir: /builds/slave/test/build/application 04:06:35 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'] 04:06:35 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 04:06:51 INFO - Reading from file tmpfile_stdout 04:06:51 INFO - Output received: 04:06:51 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - ##### 04:06:51 INFO - ##### Running run-tests step. 04:06:51 INFO - ##### 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: run_tests 04:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:51 INFO - Python 2.7.3 04:06:51 INFO - Return code: 0 04:06:51 INFO - grabbing minidump binary from tooltool 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:51 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 0x17093d0>, '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 0x1674ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:51 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 04:06:51 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 04:06:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:51 INFO - Return code: 0 04:06:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:52 INFO - Return code: 0 04:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 04:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 04:06:52 INFO - Using env: {'DISPLAY': ':0', 04:06:52 INFO - 'HOME': '/home/cltbld', 04:06:52 INFO - 'LANG': 'en_US.UTF-8', 04:06:52 INFO - 'LANGUAGE': 'en_US:en', 04:06:52 INFO - 'LOGNAME': 'cltbld', 04:06:52 INFO - 'MAIL': '/var/mail/cltbld', 04:06:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:52 INFO - 'MOZ_NO_REMOTE': '1', 04:06:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:52 INFO - 'NO_EM_RESTART': '1', 04:06:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:52 INFO - 'PWD': '/builds/slave/test', 04:06:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:52 INFO - 'SHELL': '/bin/bash', 04:06:52 INFO - 'SHLVL': '1', 04:06:52 INFO - 'TERM': 'linux', 04:06:52 INFO - 'TMOUT': '86400', 04:06:52 INFO - 'USER': 'cltbld', 04:06:52 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355', 04:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:52 INFO - '_': '/tools/buildbot/bin/python'} 04:06:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 04:06:52 INFO - mozversion application_buildid: 20160112025356 04:06:52 INFO - mozversion application_changeset: 430d06869ac32ff855cdfb07d1c4518b091a0cff 04:06:52 INFO - mozversion application_display_name: Nightly 04:06:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:52 INFO - mozversion application_name: Firefox 04:06:52 INFO - mozversion application_remotingname: firefox 04:06:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:52 INFO - mozversion application_vendor: Mozilla 04:06:52 INFO - mozversion application_version: 46.0a1 04:06:52 INFO - mozversion platform_buildid: 20160112025356 04:06:52 INFO - mozversion platform_changeset: 430d06869ac32ff855cdfb07d1c4518b091a0cff 04:06:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:52 INFO - mozversion platform_version: 46.0a1 04:06:52 INFO - using testdate: 1452600412 04:06:52 INFO - actual date: 1452600412 04:06:52 INFO - starting webserver on 'localhost:56860' 04:06:52 INFO - SUITE-START | Running 3 tests 04:06:52 INFO - TEST-START | dromaeo_css 04:06:52 INFO - operating with platform_type : linux_ 04:06:52 INFO - Initialising browser for dromaeo_css test... 04:06:52 INFO - TEST-INFO | started process 8189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd35YEY/profile http://localhost:56860/getInfo.html) 04:06:56 INFO - PROCESS | 8189 | __metrics Screen width/height:1600/1200 04:06:56 INFO - PROCESS | 8189 | colorDepth:24 04:06:56 INFO - PROCESS | 8189 | Browser inner width/height: 1024/697 04:06:56 INFO - PROCESS | 8189 | __metrics 04:06:56 INFO - PROCESS | 8189 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:06:57 INFO - PROCESS | 8189 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:58 INFO - TEST-INFO | 8189: exit 0 04:06:58 INFO - Browser initialized. 04:06:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:58 INFO - TEST-INFO | started process 8282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd35YEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:10 INFO - PROCESS | 8282 | RSS: Main: 148148224 04:07:10 INFO - PROCESS | 8282 | 04:08:01 INFO - PROCESS | 8282 | 1452600481490 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] 04:10:13 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56860/tests/dromaeo/cssquery-ext.html) 04:10:14 INFO - PROCESS | 8282 | RSS: Main: 248545280 04:10:14 INFO - PROCESS | 8282 | 04:13:16 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-ext.html (next: http://localhost:56860/tests/dromaeo/cssquery-jquery.html) 04:13:17 INFO - PROCESS | 8282 | RSS: Main: 228020224 04:13:17 INFO - PROCESS | 8282 | 04:16:19 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56860/tests/dromaeo/cssquery-mootools.html) 04:16:20 INFO - PROCESS | 8282 | RSS: Main: 236253184 04:16:20 INFO - PROCESS | 8282 | 04:19:22 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56860/tests/dromaeo/cssquery-prototype.html) 04:19:22 INFO - PROCESS | 8282 | RSS: Main: 213811200 04:19:22 INFO - PROCESS | 8282 | 04:22:25 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56860/tests/dromaeo/cssquery-yui.html) 04:22:25 INFO - PROCESS | 8282 | RSS: Main: 218759168 04:22:25 INFO - PROCESS | 8282 | 04:25:28 INFO - PROCESS | 8282 | Cycle 1(1): loaded http://localhost:56860/tests/dromaeo/cssquery-yui.html (next: http://localhost:56860/tests/dromaeo/cssquery-dojo.html) 04:25:28 INFO - PROCESS | 8282 | RSS: Main: 290603008 04:25:28 INFO - PROCESS | 8282 | 04:25:28 INFO - PROCESS | 8282 | __start_tp_report 04:25:28 INFO - PROCESS | 8282 | _x_x_mozilla_page_load 04:25:28 INFO - PROCESS | 8282 | _x_x_mozilla_page_load_details 04:25:28 INFO - PROCESS | 8282 | |i|pagename|runs| 04:25:28 INFO - PROCESS | 8282 | |0;dojo.html;2569.486102779444;2674.491846549157;2674.8528830914306;2692.649955505784;2697.9730202697965;4348.782560871951;4488.461384633841;4517.683762136656;4536.024754677747;4555.043440877415;4505.549445055501;4538.0923815237;4592.150452166352;4602.6087782538525;4653.88365290867;4020.8592699255532;4155.66754659628;4170.874873753777;4238.660907127438;4316.330968699856;4234.91530169398;4258.7870606469705;4308.741475511463;4310.4611923509565;4354.042110735633;4032.9596704033024;4127.422160897477;4131.029208136086;4143.627073563363;4259.978700106511;4222.2611043067645;4253.255680255974;4258.87223383299;4260.382244574519;4297.441332626739;4211.957880421187;4220.810063547147;4223.944013996501;4236.915261694749;4263.381809637585;4298.78506074695;4415.558444155591;4423.977880110611;4429.490608580022;4539.455265368177;4858.441279252896;4897.3878265216845;4898.853034408973;4940.629452791055;4943.456219815817;4896.387951506062;4913.06651736169;4914.606831453475;4922.606191504671;4976.2784396262705;4387.298032314814;4444.444444444444;4492.842750503782;4500.302453119804;4552.362669226311;4958.107540642647;4995.325631039836;4997.500249975046;5003.3495645565845;5040.243963405518;4786.0667169902235;4790.125924445305;4791.976040119777;4793.736344501086;4830.130576496264;4681.859544213679;4797.992421591435;4799.208130658402;4838.371011768448;4938.8765280868265;4814.422269327703;4848.10310092634;4852.078105160008;4876.82931097417;4907.852764417074;4824.107540105092;4844.491328410537;4848.781804818792;4855.781489832966;4896;4000.9399859002137;4091.7135800494275;4096.508418989741;4097.282975479279;4101.692373072032;3676.7058635309113;3680.871169509054;3690.4464330350124;3703;3708.9072773180346;4257.6168144867115;4278.764667943231;4281.743095414286;4305.935410968838;4309.892252693708;4703.341532185496;4787.640926930494;4828.734419606955;4938.4320803107385;4943.134951383494;4151.647109995684;4183.079722461053;4211.284081706117;4241.34259189826;4249.298865687127;4362.476502819682;4379.080393117481;4386.035072284092;4387.714798538085;4431.7562534060935;4409.4488188976375;4509.23343031692;4514.7291162530355;4663.230566956414;4707.4821769606;4812.5668689818085;4879.121758083579;4906.215005599087;4909.3372394727685;4944.431390390007;4651.348811166507;4662.790174442226;4673.205555055581;4677.649176311722;4711.646626502958;4621.676482646317;4724.574788269072;4725.621950244041;4828.227483602606;4832.395950506187;4820.084184005028;4860.70835749842;4869.9026019480125;4886.169351210374;4925.335079764186;4733.053389322081;4735.881602959954;4736.147493451212;4757.381540399726;4778.402699662543;4491.438570178728;4601.838935637236;4610;4735.242361222188;4750.239961606127;4579.06129243511;4623.3758442609815;4624.1445332613575;4634.559716826896;4684.48470668233;4729.219678752967;4747.667663263538;4752.453467851103;4771.117343291502;4800.399950006249;4490.124425737081;4601.93097103537;4606.447226332862;4671.626269898332;4704.882377940579 04:25:29 INFO - PROCESS | 8282 | |1;ext.html;487.75612193903055;488.49928822956485;494.3005647009482;507.8984203159369;515.8890838469729;25456;26807.329816754565;31616.68383316169;32046.35907281853;32124.51813222798;34667.133321666974;35153;35157.2968540629;35222.94331170063;35257.11857203571;7489.4382921280985;7676.347510461617;7685.11621163565;7685.231476852326;7687.615619219045;7537.133229678602;7664.693412263503;7675.9232407676045;7683.731069412572;7686.1160966489015;7693.115291741437;7745.070591528996;7760.961195194016;7763.301302882739;7772.922270777276;7662.233776622349;7705.807354816118;7747.457677962545;7747.457677962545;7750.496217745828;7668.769936901846;7833.060032796044;7840.098388685317;7841.137474877759;7843.764687059397;36366.454503182475;36492.817535912414;36839.26321473582;36903.63096369029;36919.81540092309;3058.740007099399;3086.5370194470784;3171.6194056713343;3275.2958114005364;3392.6268110507826;27353.726462735318;27753;28061.158165255074;28230.435391292263;28301.433971320665;3384.746144039182;3392.4402473591826;3403.7957722536726;3451.3960056989927;3510.7542472026967;213111;213607;213913;214179;214352;45114.32328515075;52419;52808.47191528112;52840.471595284325;52844.47155528473;39602.207955841295;57430.138547921815;58838;58866.7056664714;58932.705336473045;13241.139325943783;13492.527761528496;13493.730125397436;13501;13508.527201548095;9442.77243958281;9700.660476883417;10299.639512617023;10313.329633573794;10354.326968747007;17024.914875425544;17264.96410215366;17299.481015569552;17460.476185714448;17839.46481605554;7123.074000380021;7272.709091636381;7293.927060729431;7329.74345897891;7358.926410735824;887.0242732993655;895.9104089591119;905.9547022648841;927.6335847340263;1042.9895701042892;25741.871290643427;25780.871095644776;25802.612960805604;25901.352466188495;26067.478650426885;929.8558723397884;936.686210119604;1007.1741172238841;1026.9127124194379;1111.9610813621484;11997.280163190237;12058.879411205951;12174.634760957186;12174.878251217551;12176.878231217752;256345;259675;259961;260480;260906;38231.808840955615;38240.42639360412;38373.61626383756;38412.8079359607;38452.615473845464;1235.5366737473448;1250.849898012226;1253.9122261441794;1257.2959142879834;1263.059021029339;22396.888015559816;22716.545669086856;23018.194363197206;23232;23339.416514587272;34717;35053.123671908405;35280.64719352876;35315.11712207215;35351;144131.2793436026;145456;243284;250328;250351;27151.506667133497;27242.863785680944;27370.589441158;27388.53503184723;27545.862270688518;36583.26833463369;37139.442908356934;37225.255494890494;37598.8120059398;38186.61813381831;31651.841740791147;31870;32584.185395365304;33058.33883322272;33175.33649327048;30476.837603421118;31817.5227371585;32857.17857053593;32918;33123.33753324968;30529.694703052686;30975.535366969063;31077.689223108384;31392.52911206288;31397.372052559276;27756.306092347044;28281.57577636378;28404;28410.289742756595;28502.57246141351;21904.342869713935;22004.88997555002;22183.889080554494;22422.551548969255;22703.318900433012 04:25:29 INFO - PROCESS | 8282 | |2;jquery.html;327.3714468221015;332.0470250381406;332.7138660751753;333.90817525180574;336;11649;12080.885844977116;14411.495597654084;14936.17851018195;15171.089734615916;14032.43870245189;14422.423103075864;14429.927850360733;14456.277186140704;15062;4046.534648515429;4913.213885778277;5096.108181068316;5106.157484015133;5118;5028.044671512419;5095.0319439306595;5100.923486147711;5101.056304583664;5110.463401342861;4849.151398505247;5053;5053.646244762868;5054.368203974504;5056.544910958013;4961.578265847407;5004.174311238659;5009.749512524396;5048.29323894655;5268.367795864482;4949.381327334083;4950.3069570260195;4952.7028378297055;4954.47977962316;4957.851264462072;16185.757213641804;17153.485395438158;17555.824441755674;17693.29226830925;18018.819811801844;1790.7851057873138;1802;1869.7288893110424;1911.350140952069;1912.8374088202381;8245.422820402575;8904.59929303183;11818.349990750592;12222.816657750142;12247.203931744409;1632.6081740382342;1792.57874399516;1801.9639607207914;1805.5576383785926;1815.5007372972407;47827.52172478265;48096.27855582169;48726.3037609594;48745.268820967714;48820.99999999964;9602.807943841084;9637.903620963842;9671.225944723034;9705.126538611417;9823.901760982442;10688.305260158066;11087;11339.886601134049;12193;12235.69410764738;6734.3602357775935;6784.3554862288;6809.285025072395;6823.215330236987;6893.620850853151;6352.7141278642575;6418.0372944057835;6422.6467544285515;6434.871302573923;6519.967400162969;4047.8988025299604;4059.4722686050623;4078.388241763759;4112.157007813391;4113.526944401372;1644.2354305248118;1670.0814551996352;1697.0920557501677;1707.8719096067596;1733.8526225270741;812.29736278119;838.8490071787015;926.1881692380367;935.8268720286769;949.7862980829397;14620.415183392544;14934.626634334012;15135.167565783768;15258.847411525965;15288;841.9073901870789;871.1984973824098;871.9084496127815;879.9780005499914;880.4893161966045;6891.483138764613;8177.9591102044105;8558.186972237627;8802.911970880337;8833.160849719266;404222;414924;423928;427039;428102;58332.7083364589;60135.398646013855;60598.69700651557;60723;61101.694491527254;931.3387494878576;959.2901253072675;1036.9118624916966;1089.0797276301512;1102.8125218712837;12599.811002835148;13025.609231723063;13215.537456188988;13549.458021679022;14094.788578171541;27262.454750905268;27456.313592160357;27474;28009.29976750516;28276.010339638015;31785;31870.203244918135;31872;32108.839455802572;33552.66447335593;6212.689365531795;6518.706658200297;6633.535652504278;6661.633610151488;6682.866342673216;8133.715319963773;9176.174144327042;9496.002919693332;9756.512174391393;9897.35667181631;8008.199180081945;8095.190480951857;8137.2269634387;8173.100958894398;8230.794230144294;8028.799280018046;8498.53258070812;8499.95750021246;8821.426607270507;8968.82062358736;2738.86305684711;2750.40866213765;8080.151584083586;8158.510489370657;8218.06915850485;6493;6508.479321654351;6667.899981500184;6684.866302673822;6762.729490820312;7882.487638303492;8333.333333333198;8374.581270936551;8392.580370981304;8471 04:25:29 INFO - PROCESS | 8282 | |3;mootools.html;1251.1054595963894;1384.038093525;1393.7282229965153;1536.9615759606008;1797.3349860551589;6494.577852439594;7252.927470725291;7374.594397308146;7385.889211661829;7392.482526223166;7250.492465527415;7454.254574542543;7474.252574742523;7518.473706840509;7526.661300241489;1767;1801.855851531881;2157.3959291398432;2185.093186327676;2223.7109175807122;2196.791304826047;2205.8676479411206;2206.459417442729;2208.8122509586706;2212.048819007834;2056.1672522628282;2157.094020511381;2173.3045425463856;2175.7824217578273;2179.3461961411513;2144.378130342199;2167.3389616167065;2170.8914554272224;2201.9119235230573;2207.0178770447155;2160.7731188225325;2166.6100101981638;2171.0881429799524;2181.4982554012668;2182.508935489518;7674.46278760487;7695.345895598881;7724.111727151337;7731;7756.844863102763;4403.163398954189;4494.865154045384;4508.233600287959;4530.79611417487;4531.342955271467;2817.1970988268245;2827.3921106962102;2870.641169853768;2877.784166187523;2953.4240823039518;892.205936716323;897.349421669291;901.6213190460022;924.0343840686498;949.9762505937338;10142.543585538668;10289.176865850714;10305.742356441075;10310;10328.225383096298;3938.665213456888;3963.7225394222705;4024.3158663027357;4030.5163380394542;4107.096438783463;8944.910550894409;8969.461832290084;8983.416077954913;8986.415882967585;8987.865182022275;4496.033352829158;4502.594766471033;4502.684812063124;4503.076869241798;4508.323751437245;4016.578259282733;4055.0673345130194;4060.127072679388;4066.1054567995584;4069.1658210066867;3168.2396224905856;3235.142687187897;3509.9122521937156;3522.894313170609;3610.6750392464805;1138.743782648914;1157.1494951210852;1168.2464810197546;1173.102576528956;1176.8117101263756;1200.663814132027;1212.8665846756849;1219.091776626419;1227.6623928419756;1235.184778046485;7156.713731450684;7273.418126549864;7303.488755787044;7327.340539351484;7346.889796653055;1025.5487585462372;1036.76154484469;1043.9425831579335;1059.6132411669685;1068.604616291977;5549.250851135045;5586.86032849182;5610.13042978339;5619.4099619540175;5627.12779519167;8293.460925039853;8440.902682651338;8675.609597568124;8713.477191368538;8714.041455439896;8612.913870861337;8639.611217495229;8650.480971141751;8780.736577902673;8820.8676869847;6842.4183944364295;7032.507724459341;7327.413806895435;7433.10802703679;7461.477696561297;7105.9289407107335;7156.463265255023;7176.4258859290085;7177.282271772781;7185.173705023989;7782.92217077822;8099.959500202462;8193.221643943816;8220.671173153007;8224.958875205586;8182.22268884455;8317.334613230805;8430.704925327584;8478.491290522588;8482.618282177193;6987.091678081817;7014.68433920485;7061.329173728487;7076.646167691491;7109.395701365442;6180.165677633462;6323.146375239284;6904.792856214322;7061.152661680631;7069.9646501767165;6488.578242414228;6579.934200657932;6603.042558829039;6658.434033107046;6775.898361524482;6368.108464814837;6648.301928297653;6767.221769496571;6773.729050837911;6836.897446538405;6836.48726345536;6870.862582748417;6887.862242755016;6890.31096890307;6899.862002759816;6199.690015499117;6223.190985171898;6247.406496382836;6263.655498947602;6288.245410550763;6420.036994450869;6472;6475.740970361133;6476.352364763486;6479.546431749733 04:25:29 INFO - PROCESS | 8282 | |4;prototype.html;313.629916698296;316.9572107765451;317.90145055032934;325.4386183832889;326.77289283947636;5110.284560161575;5216.713080780555;5252.1859111837675;5309.73451327434;5339.092354299769;5166.638335316529;5215.739213039343;5223.817166399177;5227.764750586223;5230.92153617696;3902.7853468059247;3977.1647953929564;4005.9799701001452;4068.572799856017;4076.612721791425;4028.234635419261;4053.5946405359523;4055.087605288816;4057.6550993165615;4071.7149799514045;4055.797210139496;4062.0860306431114;4066.877993660195;4067.3695577185435;4072.9592704072875;3827.0815004398883;3892.163184915257;3941.054147004727;4025.496812898388;4026.45642838216;3546.8935931922083;3554.129238336598;3554.1647712787476;3563.465480177968;3566.8216589170697;5011.949880501184;5030.094582975063;5031.119554078022;5033.345665063518;5033.647644664875;4638.5593368629925;4653.232216684243;4653.395058642389;4656.254999200111;4658.720476771371;5357.919631205535;5433.701146436944;5461.126219804852;5463.672179669233;5486.177073438977;3842.9231415371537;3843.404272337792;3843.5579908310624;3845.1732877431205;3845.6346647068485;5659.236003139565;5742.655440673573;5748.051571490699;5752.252207213036;5753.827385178452;3961.504811898513;3969.4839670842607;3970.06703424695;3970.305196590585;3975.926499845026;3874.9806250968563;4024.1146947671464;4024.839006439768;4035.757854528738;4038.3134867072667;4599.126166028444;4621.838235661736;4626.352310676508;4632.2819962905805;4636.026434448803;5471.50756431915;5484.945150548523;5493.395726470085;5495.626093476631;5495.642783219078;1375.40170026039;1424.658082060298;1430.106183635228;1430.1990885104374;1434.8278206615273;953.4755884263627;956.297121615612;972.4505654305295;993.4287784523783;997.1275134257525;4858.46556878743;4872.51274872517;4880.365552478226;4882.609391248691;4883.413990321184;5689.715514224272;5690.174924635905;5692.658440493584;5692.743826527816;5697.544196464273;4857.8299759508245;4860.8298709545;4869.829555965595;4872.707637541759;4875.756212189376;2825.2230636575105;2943.3818898031654;3020.6828283030404;3053.9389212215633;3093.7370323522755;5365.222042803772;5392.245085688007;5412.161115027177;5414.675119492765;5415.566754659618;5937.376575459514;5941.762329506858;5942.3166335871065;5943.5839491236065;5944.108383742387;5478.753456094485;5480.753366098615;5481.123020316731;5493;5493.285872836585;5631.549476041989;5744.827655170351;5761.2222349983895;5763.415060858298;5771.278590176228;5611.915821262766;5621.859453513532;5625.156226566048;5625.746841392065;5627.690477023803;5473.67157970523;5476.534494567847;5482.314710661168;5482.369527504388;5483.7258137092185;3979.3633018716864;3982.2433737589763;3982.3628219484744;3983.48214732083;3986.202759448064;5592.832215033555;5748.511376533042;5753.798617048383;5754.2519472469985;5759.539236861125;5542.307211598551;5544.0575102231915;5548.944510555004;5549.944500554942;5559.888802223852;5547.500724934614;5555.472230138131;5555.555555555465;5557.722113894209;5558.861028474321;5321.068812957795;5446.809361672323;5446.836594902159;5449.972750136224;5461.0716178248995;5575.498205161555;5582.162675598693;5583.050881350099;5585.106382978704;5588.804391846266;5452.7546260417585;5457.345118585637;5461.672299662033;5462.426445223353;5465.781368745205 04:25:29 INFO - PROCESS | 8282 | |5;yui.html;740.862940356034;757.0725860820496;797.1789057271013;806.491910096639;807.1323327423022;12892.22646641201;13117.212967221949;13126.803097953514;13129;13138.868611313885;12682.873171268284;12727.045471589621;12746.617601471948;12762.93618531906;12773.105882588223;615.0313256620818;623.7411474238186;780.3951937248621;794.9602519873984;795.347814791868;784.9568273744942;794.0907660728462;797.314309693663;799.1968072087544;800.2237829305565;819.2872201184978;820.4748960665179;823.3372135431006;825.0594322472386;825.5830805443243;634.5399585300643;642.9292777794439;643.0932385336653;644.9484041276734;820.5404973215019;475.83821500689584;598.9041753319448;607.401709316323;611.5566214494501;612.3294991983771;11594.826077608843;11651.184417090806;11664.708382290426;11688.941555292255;11708.882911170864;10532.894671053267;10561.683149505527;10872.67381978534;11217;11290.435478226138;9405.482698451651;9459.90540094597;9528;9581.520923953844;9605.615775369046;3179.268768183331;3213.260949981494;3237.7409807215367;3243.6107667079864;3280.327532855759;37624;38245.42631860524;38340.424893626616;38371.42442863387;38379.61620383788;9054.366194366463;9182.17360437564;9226.723198304062;9387.436753794795;9465.242780577537;15657.373705051898;15684.843151568566;15710.528684139494;15743.448979285899;15759.921200393925;6059.1820104286235;6234.906476402857;6337.429631333202;6490.4807615390655;6512.739490420425;3572.1069732566857;3649.9635003649623;3708.165662725865;3778.4899038629983;3794.2221844521805;2717.320669832542;2722.91831245063;2736.151792944154;2740.410811675499;2749.9962513682763;484.8327327072154;492.6132985606282;493.34631613112055;500.3095727895481;504.02219693794655;454.4092679516615;510.8978204359143;540.7701726766109;598.9011813050798;607.4502575169479;6840.418564421981;7066.470014748915;7302.306280903305;7321.560706357635;7342.4493163012985;443.67168295461124;465.8998315362213;481.4102724162872;494.6067876038558;519.2937604857391;3338.2989572190113;3480.4953281774;3624.4744512045604;3831.5976822433245;3896.688264938798;44371;45182.77408612936;45214.32178517325;50578.747106264236;53738.193927091124;39436.605633943866;39572.20855582872;39789.80105099456;42613.786931065144;42926.78536607359;35217.47173792395;38248.42627360592;38425;38650.22699545993;39472.40791388132;7491.700331986877;7747.806304842424;7781.610919454118;7857.646405911633;7926.643301051351;29321.12036638904;29530.704692953655;30189.245268867577;30288.69711302859;30320;34957.65042349646;37120.814395927846;37191.44212836864;37479;37856.810715946245;9875.963023882676;9949.502524873873;9989.450580217866;10047.547860346449;10132.34139780912;10482.475876206312;10862.185336099667;11074.944625277145;11473.82789258145;11549.364784936573;9482.95258523703;9694.951525242328;9728.319017668695;9751.171150452292;9825.557849896915;9728.854067188857;10405;10575.62985295511;10652.62715804943;10685.252032357661;9929.801403972024;10210.846837297595;10222.846657299997;10583.470826458492;10597.788044238918;8623.568821559022;8922.55387230649;8977.775555611162;9004.954975225082;9028.683996060106;8197.385196110195;8212.712555060543;8539.975202975682;8598.140185981352;8991.370604057653 04:25:29 INFO - PROCESS | 8282 | __end_tp_report 04:25:29 INFO - PROCESS | 8282 | __start_cc_report 04:25:29 INFO - PROCESS | 8282 | _x_x_mozilla_cycle_collect,886 04:25:29 INFO - PROCESS | 8282 | __end_cc_report 04:25:29 INFO - PROCESS | 8282 | __startTimestamp1452601528994__endTimestamp 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | ------- Summary: start ------- 04:25:29 INFO - PROCESS | 8282 | Number of tests: 6 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#0] dojo.html Cycles:165 Average:4500.39 Median:4606.45 stddev:448.11 (9.7%) stddev-sans-first:423.11 04:25:29 INFO - PROCESS | 8282 | Values: 2569.5 2674.5 2674.9 2692.6 2698.0 4348.8 4488.5 4517.7 4536.0 4555.0 4505.5 4538.1 4592.2 4602.6 4653.9 4020.9 4155.7 4170.9 4238.7 4316.3 4234.9 4258.8 4308.7 4310.5 4354.0 4033.0 4127.4 4131.0 4143.6 4260.0 4222.3 4253.3 4258.9 4260.4 4297.4 4212.0 4220.8 4223.9 4236.9 4263.4 4298.8 4415.6 4424.0 4429.5 4539.5 4858.4 4897.4 4898.9 4940.6 4943.5 4896.4 4913.1 4914.6 4922.6 4976.3 4387.3 4444.4 4492.8 4500.3 4552.4 4958.1 4995.3 4997.5 5003.3 5040.2 4786.1 4790.1 4792.0 4793.7 4830.1 4681.9 4798.0 4799.2 4838.4 4938.9 4814.4 4848.1 4852.1 4876.8 4907.9 4824.1 4844.5 4848.8 4855.8 4896.0 4000.9 4091.7 4096.5 4097.3 4101.7 3676.7 3680.9 3690.4 3703.0 3708.9 4257.6 4278.8 4281.7 4305.9 4309.9 4703.3 4787.6 4828.7 4938.4 4943.1 4151.6 4183.1 4211.3 4241.3 4249.3 4362.5 4379.1 4386.0 4387.7 4431.8 4409.4 4509.2 4514.7 4663.2 4707.5 4812.6 4879.1 4906.2 4909.3 4944.4 4651.3 4662.8 4673.2 4677.6 4711.6 4621.7 4724.6 4725.6 4828.2 4832.4 4820.1 4860.7 4869.9 4886.2 4925.3 4733.1 4735.9 4736.1 4757.4 4778.4 4491.4 4601.8 4610.0 4735.2 4750.2 4579.1 4623.4 4624.1 4634.6 4684.5 4729.2 4747.7 4752.5 4771.1 4800.4 4490.1 4601.9 4606.4 4671.6 4704.9 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#1] ext.html Cycles:180 Average:37713.57 Median:18066.24 stddev:59929.01 (331.7%) stddev-sans-first:60031.95 04:25:29 INFO - PROCESS | 8282 | Values: 487.8 488.5 494.3 507.9 515.9 25456.0 26807.3 31616.7 32046.4 32124.5 34667.1 35153.0 35157.3 35222.9 35257.1 7489.4 7676.3 7685.1 7685.2 7687.6 7537.1 7664.7 7675.9 7683.7 7686.1 7693.1 7745.1 7761.0 7763.3 7772.9 7662.2 7705.8 7747.5 7747.5 7750.5 7668.8 7833.1 7840.1 7841.1 7843.8 36366.5 36492.8 36839.3 36903.6 36919.8 3058.7 3086.5 3171.6 3275.3 3392.6 27353.7 27753.0 28061.2 28230.4 28301.4 3384.7 3392.4 3403.8 3451.4 3510.8 213111.0 213607.0 213913.0 214179.0 214352.0 45114.3 52419.0 52808.5 52840.5 52844.5 39602.2 57430.1 58838.0 58866.7 58932.7 13241.1 13492.5 13493.7 13501.0 13508.5 9442.8 9700.7 10299.6 10313.3 10354.3 17024.9 17265.0 17299.5 17460.5 17839.5 7123.1 7272.7 7293.9 7329.7 7358.9 887.0 895.9 906.0 927.6 1043.0 25741.9 25780.9 25802.6 25901.4 26067.5 929.9 936.7 1007.2 1026.9 1112.0 11997.3 12058.9 12174.6 12174.9 12176.9 256345.0 259675.0 259961.0 260480.0 260906.0 38231.8 38240.4 38373.6 38412.8 38452.6 1235.5 1250.8 1253.9 1257.3 1263.1 22396.9 22716.5 23018.2 23232.0 23339.4 34717.0 35053.1 35280.6 35315.1 35351.0 144131.3 145456.0 243284.0 250328.0 250351.0 27151.5 27242.9 27370.6 27388.5 27545.9 36583.3 37139.4 37225.3 37598.8 38186.6 31651.8 31870.0 32584.2 33058.3 33175.3 30476.8 31817.5 32857.2 32918.0 33123.3 30529.7 30975.5 31077.7 31392.5 31397.4 27756.3 28281.6 28404.0 28410.3 28502.6 21904.3 22004.9 22183.9 22422.6 22703.3 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#2] jquery.html Cycles:180 Average:22396.82 Median:4959.71 stddev:68519.89 (1381.5%) stddev-sans-first:68692.07 04:25:29 INFO - PROCESS | 8282 | Values: 327.4 332.0 332.7 333.9 336.0 11649.0 12080.9 14411.5 14936.2 15171.1 14032.4 14422.4 14429.9 14456.3 15062.0 4046.5 4913.2 5096.1 5106.2 5118.0 5028.0 5095.0 5100.9 5101.1 5110.5 4849.2 5053.0 5053.6 5054.4 5056.5 4961.6 5004.2 5009.7 5048.3 5268.4 4949.4 4950.3 4952.7 4954.5 4957.9 16185.8 17153.5 17555.8 17693.3 18018.8 1790.8 1802.0 1869.7 1911.4 1912.8 8245.4 8904.6 11818.3 12222.8 12247.2 1632.6 1792.6 1802.0 1805.6 1815.5 47827.5 48096.3 48726.3 48745.3 48821.0 9602.8 9637.9 9671.2 9705.1 9823.9 10688.3 11087.0 11339.9 12193.0 12235.7 6734.4 6784.4 6809.3 6823.2 6893.6 6352.7 6418.0 6422.6 6434.9 6520.0 4047.9 4059.5 4078.4 4112.2 4113.5 1644.2 1670.1 1697.1 1707.9 1733.9 812.3 838.8 926.2 935.8 949.8 14620.4 14934.6 15135.2 15258.8 15288.0 841.9 871.2 871.9 880.0 880.5 6891.5 8178.0 8558.2 8802.9 8833.2 404222.0 414924.0 423928.0 427039.0 428102.0 58332.7 60135.4 60598.7 60723.0 61101.7 931.3 959.3 1036.9 1089.1 1102.8 12599.8 13025.6 13215.5 13549.5 14094.8 27262.5 27456.3 27474.0 28009.3 28276.0 31785.0 31870.2 31872.0 32108.8 33552.7 6212.7 6518.7 6633.5 6661.6 6682.9 8133.7 9176.2 9496.0 9756.5 9897.4 8008.2 8095.2 8137.2 8173.1 8230.8 8028.8 8498.5 8500.0 8821.4 8968.8 2738.9 2750.4 8080.2 8158.5 8218.1 6493.0 6508.5 6667.9 6684.9 6762.7 7882.5 8333.3 8374.6 8392.6 8471.0 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#3] mootools.html Cycles:180 Average:5253.70 Median:6305.70 stddev:2727.76 (43.3%) stddev-sans-first:2718.82 04:25:29 INFO - PROCESS | 8282 | Values: 1251.1 1384.0 1393.7 1537.0 1797.3 6494.6 7252.9 7374.6 7385.9 7392.5 7250.5 7454.3 7474.3 7518.5 7526.7 1767.0 1801.9 2157.4 2185.1 2223.7 2196.8 2205.9 2206.5 2208.8 2212.0 2056.2 2157.1 2173.3 2175.8 2179.3 2144.4 2167.3 2170.9 2201.9 2207.0 2160.8 2166.6 2171.1 2181.5 2182.5 7674.5 7695.3 7724.1 7731.0 7756.8 4403.2 4494.9 4508.2 4530.8 4531.3 2817.2 2827.4 2870.6 2877.8 2953.4 892.2 897.3 901.6 924.0 950.0 10142.5 10289.2 10305.7 10310.0 10328.2 3938.7 3963.7 4024.3 4030.5 4107.1 8944.9 8969.5 8983.4 8986.4 8987.9 4496.0 4502.6 4502.7 4503.1 4508.3 4016.6 4055.1 4060.1 4066.1 4069.2 3168.2 3235.1 3509.9 3522.9 3610.7 1138.7 1157.1 1168.2 1173.1 1176.8 1200.7 1212.9 1219.1 1227.7 1235.2 7156.7 7273.4 7303.5 7327.3 7346.9 1025.5 1036.8 1043.9 1059.6 1068.6 5549.3 5586.9 5610.1 5619.4 5627.1 8293.5 8440.9 8675.6 8713.5 8714.0 8612.9 8639.6 8650.5 8780.7 8820.9 6842.4 7032.5 7327.4 7433.1 7461.5 7105.9 7156.5 7176.4 7177.3 7185.2 7782.9 8100.0 8193.2 8220.7 8225.0 8182.2 8317.3 8430.7 8478.5 8482.6 6987.1 7014.7 7061.3 7076.6 7109.4 6180.2 6323.1 6904.8 7061.2 7070.0 6488.6 6579.9 6603.0 6658.4 6775.9 6368.1 6648.3 6767.2 6773.7 6836.9 6836.5 6870.9 6887.9 6890.3 6899.9 6199.7 6223.2 6247.4 6263.7 6288.2 6420.0 6472.0 6475.7 6476.4 6479.5 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#4] prototype.html Cycles:180 Average:4581.56 Median:5229.34 stddev:1350.20 (25.8%) stddev-sans-first:1315.44 04:25:29 INFO - PROCESS | 8282 | Values: 313.6 317.0 317.9 325.4 326.8 5110.3 5216.7 5252.2 5309.7 5339.1 5166.6 5215.7 5223.8 5227.8 5230.9 3902.8 3977.2 4006.0 4068.6 4076.6 4028.2 4053.6 4055.1 4057.7 4071.7 4055.8 4062.1 4066.9 4067.4 4073.0 3827.1 3892.2 3941.1 4025.5 4026.5 3546.9 3554.1 3554.2 3563.5 3566.8 5011.9 5030.1 5031.1 5033.3 5033.6 4638.6 4653.2 4653.4 4656.3 4658.7 5357.9 5433.7 5461.1 5463.7 5486.2 3842.9 3843.4 3843.6 3845.2 3845.6 5659.2 5742.7 5748.1 5752.3 5753.8 3961.5 3969.5 3970.1 3970.3 3975.9 3875.0 4024.1 4024.8 4035.8 4038.3 4599.1 4621.8 4626.4 4632.3 4636.0 5471.5 5484.9 5493.4 5495.6 5495.6 1375.4 1424.7 1430.1 1430.2 1434.8 953.5 956.3 972.5 993.4 997.1 4858.5 4872.5 4880.4 4882.6 4883.4 5689.7 5690.2 5692.7 5692.7 5697.5 4857.8 4860.8 4869.8 4872.7 4875.8 2825.2 2943.4 3020.7 3053.9 3093.7 5365.2 5392.2 5412.2 5414.7 5415.6 5937.4 5941.8 5942.3 5943.6 5944.1 5478.8 5480.8 5481.1 5493.0 5493.3 5631.5 5744.8 5761.2 5763.4 5771.3 5611.9 5621.9 5625.2 5625.7 5627.7 5473.7 5476.5 5482.3 5482.4 5483.7 3979.4 3982.2 3982.4 3983.5 3986.2 5592.8 5748.5 5753.8 5754.3 5759.5 5542.3 5544.1 5548.9 5549.9 5559.9 5547.5 5555.5 5555.6 5557.7 5558.9 5321.1 5446.8 5446.8 5450.0 5461.1 5575.5 5582.2 5583.1 5585.1 5588.8 5452.8 5457.3 5461.7 5462.4 5465.8 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - PROCESS | 8282 | [#5] yui.html Cycles:180 Average:11777.21 Median:470.87 stddev:12989.76 (2758.7%) stddev-sans-first:12999.76 04:25:29 INFO - PROCESS | 8282 | Values: 740.9 757.1 797.2 806.5 807.1 12892.2 13117.2 13126.8 13129.0 13138.9 12682.9 12727.0 12746.6 12762.9 12773.1 615.0 623.7 780.4 795.0 795.3 785.0 794.1 797.3 799.2 800.2 819.3 820.5 823.3 825.1 825.6 634.5 642.9 643.1 644.9 820.5 475.8 598.9 607.4 611.6 612.3 11594.8 11651.2 11664.7 11688.9 11708.9 10532.9 10561.7 10872.7 11217.0 11290.4 9405.5 9459.9 9528.0 9581.5 9605.6 3179.3 3213.3 3237.7 3243.6 3280.3 37624.0 38245.4 38340.4 38371.4 38379.6 9054.4 9182.2 9226.7 9387.4 9465.2 15657.4 15684.8 15710.5 15743.4 15759.9 6059.2 6234.9 6337.4 6490.5 6512.7 3572.1 3650.0 3708.2 3778.5 3794.2 2717.3 2722.9 2736.2 2740.4 2750.0 484.8 492.6 493.3 500.3 504.0 454.4 510.9 540.8 598.9 607.5 6840.4 7066.5 7302.3 7321.6 7342.4 443.7 465.9 481.4 494.6 519.3 3338.3 3480.5 3624.5 3831.6 3896.7 44371.0 45182.8 45214.3 50578.7 53738.2 39436.6 39572.2 39789.8 42613.8 42926.8 35217.5 38248.4 38425.0 38650.2 39472.4 7491.7 7747.8 7781.6 7857.6 7926.6 29321.1 29530.7 30189.2 30288.7 30320.0 34957.7 37120.8 37191.4 37479.0 37856.8 9876.0 9949.5 9989.5 10047.5 10132.3 10482.5 10862.2 11074.9 11473.8 11549.4 9483.0 9695.0 9728.3 9751.2 9825.6 9728.9 10405.0 10575.6 10652.6 10685.3 9929.8 10210.8 10222.8 10583.5 10597.8 8623.6 8922.6 8977.8 9005.0 9028.7 8197.4 8212.7 8540.0 8598.1 8991.4 04:25:29 INFO - PROCESS | 8282 | -------- Summary: end -------- 04:25:29 INFO - PROCESS | 8282 | 04:25:29 INFO - TEST-INFO | 8282: exit 0 04:25:29 INFO - TEST-OK | dromaeo_css | took 1116886ms 04:25:29 INFO - TEST-START | kraken 04:25:29 INFO - operating with platform_type : linux_ 04:25:29 INFO - Initialising browser for kraken test... 04:25:29 INFO - TEST-INFO | started process 8467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TiPE7/profile http://localhost:56860/getInfo.html) 04:25:33 INFO - PROCESS | 8467 | __metrics Screen width/height:1600/1200 04:25:33 INFO - PROCESS | 8467 | colorDepth:24 04:25:33 INFO - PROCESS | 8467 | Browser inner width/height: 1024/697 04:25:33 INFO - PROCESS | 8467 | __metrics 04:25:34 INFO - PROCESS | 8467 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:34 INFO - PROCESS | 8467 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:34 INFO - TEST-INFO | 8467: exit 0 04:25:34 INFO - Browser initialized. 04:25:34 INFO - Running cycle 1/1 for kraken test... 04:25:34 INFO - TEST-INFO | started process 8546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TiPE7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:46 INFO - PROCESS | 8546 | RSS: Main: 148914176 04:25:46 INFO - PROCESS | 8546 | 04:25:49 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:50 INFO - PROCESS | 8546 | RSS: Main: 185753600 04:25:50 INFO - PROCESS | 8546 | 04:25:52 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-dft) 04:25:53 INFO - PROCESS | 8546 | RSS: Main: 176705536 04:25:53 INFO - PROCESS | 8546 | 04:25:56 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-fft) 04:25:57 INFO - PROCESS | 8546 | RSS: Main: 160464896 04:25:57 INFO - PROCESS | 8546 | 04:25:59 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56860/tests/kraken/driver.html?testName=audio-oscillator) 04:25:59 INFO - PROCESS | 8546 | RSS: Main: 163848192 04:25:59 INFO - PROCESS | 8546 | 04:26:01 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:02 INFO - PROCESS | 8546 | RSS: Main: 164524032 04:26:02 INFO - PROCESS | 8546 | 04:26:05 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:06 INFO - PROCESS | 8546 | RSS: Main: 163803136 04:26:06 INFO - PROCESS | 8546 | 04:26:09 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56860/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:10 INFO - PROCESS | 8546 | RSS: Main: 165883904 04:26:10 INFO - PROCESS | 8546 | 04:26:12 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56860/tests/kraken/driver.html?testName=json-parse-financial) 04:26:13 INFO - PROCESS | 8546 | RSS: Main: 164343808 04:26:13 INFO - PROCESS | 8546 | 04:26:15 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:15 INFO - PROCESS | 8546 | RSS: Main: 175693824 04:26:15 INFO - PROCESS | 8546 | 04:26:17 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:18 INFO - PROCESS | 8546 | RSS: Main: 174997504 04:26:18 INFO - PROCESS | 8546 | 04:26:20 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:20 INFO - PROCESS | 8546 | RSS: Main: 188338176 04:26:20 INFO - PROCESS | 8546 | 04:26:23 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:24 INFO - PROCESS | 8546 | RSS: Main: 189419520 04:26:24 INFO - PROCESS | 8546 | 04:26:26 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:27 INFO - PROCESS | 8546 | RSS: Main: 189493248 04:26:27 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | Cycle 1(1): loaded http://localhost:56860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56860/tests/kraken/driver.html?testName=ai-astar) 04:26:29 INFO - PROCESS | 8546 | RSS: Main: 246968320 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | __start_tp_report 04:26:29 INFO - PROCESS | 8546 | _x_x_mozilla_page_load 04:26:29 INFO - PROCESS | 8546 | _x_x_mozilla_page_load_details 04:26:29 INFO - PROCESS | 8546 | |i|pagename|runs| 04:26:29 INFO - PROCESS | 8546 | |0;ai-astar;110;112;107;113;113;114;102;112;114;118 04:26:29 INFO - PROCESS | 8546 | |1;audio-beat-detection;149;132;155;168;137;153;154;135;172;133 04:26:29 INFO - PROCESS | 8546 | |2;audio-dft;161;163;162;163;162;161;162;164;162;162 04:26:29 INFO - PROCESS | 8546 | |3;audio-fft;86;72;81;92;72;75;74;128;87;74 04:26:29 INFO - PROCESS | 8546 | |4;audio-oscillator;97;98;140;98;98;98;137;97;98;133 04:26:29 INFO - PROCESS | 8546 | |5;imaging-gaussian-blur;110;110;110;109;110;110;110;109;110;109 04:26:29 INFO - PROCESS | 8546 | |6;imaging-darkroom;147;146;147;147;147;147;146;147;146;146 04:26:29 INFO - PROCESS | 8546 | |7;imaging-desaturate;96;96;95;95;96;95;95;95;95;95 04:26:29 INFO - PROCESS | 8546 | |8;json-parse-financial;68;69;68;68;70;69;68;78;66;66 04:26:29 INFO - PROCESS | 8546 | |9;json-stringify-tinderbox;67;67;67;67;67;68;68;68;67;67 04:26:29 INFO - PROCESS | 8546 | |10;stanford-crypto-aes;83;82;84;84;82;83;84;85;84;83 04:26:29 INFO - PROCESS | 8546 | |11;stanford-crypto-ccm;125;122;121;120;126;138;121;131;121;131 04:26:29 INFO - PROCESS | 8546 | |12;stanford-crypto-pbkdf2;140;158;148;155;151;138;148;147;153;138 04:26:29 INFO - PROCESS | 8546 | |13;stanford-crypto-sha256-iterative;70;70;69;68;70;71;72;71;72;70 04:26:29 INFO - PROCESS | 8546 | __end_tp_report 04:26:29 INFO - PROCESS | 8546 | __start_cc_report 04:26:29 INFO - PROCESS | 8546 | _x_x_mozilla_cycle_collect,992 04:26:29 INFO - PROCESS | 8546 | __end_cc_report 04:26:29 INFO - PROCESS | 8546 | __startTimestamp1452601589331__endTimestamp 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | ------- Summary: start ------- 04:26:29 INFO - PROCESS | 8546 | Number of tests: 14 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:4.38 (3.9%) stddev-sans-first:4.61 04:26:29 INFO - PROCESS | 8546 | Values: 110.0 112.0 107.0 113.0 113.0 114.0 102.0 112.0 114.0 118.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:153.50 stddev:14.34 (9.3%) stddev-sans-first:15.21 04:26:29 INFO - PROCESS | 8546 | Values: 149.0 132.0 155.0 168.0 137.0 153.0 154.0 135.0 172.0 133.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:26:29 INFO - PROCESS | 8546 | Values: 161.0 163.0 162.0 163.0 162.0 161.0 162.0 164.0 162.0 162.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#3] audio-fft Cycles:10 Average:84.10 Median:78.00 stddev:16.97 (21.8%) stddev-sans-first:17.98 04:26:29 INFO - PROCESS | 8546 | Values: 86.0 72.0 81.0 92.0 72.0 75.0 74.0 128.0 87.0 74.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:98.00 stddev:18.89 (19.3%) stddev-sans-first:19.50 04:26:29 INFO - PROCESS | 8546 | Values: 97.0 98.0 140.0 98.0 98.0 98.0 137.0 97.0 98.0 133.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:26:29 INFO - PROCESS | 8546 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:26:29 INFO - PROCESS | 8546 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:26:29 INFO - PROCESS | 8546 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:68.50 stddev:3.40 (5.0%) stddev-sans-first:3.59 04:26:29 INFO - PROCESS | 8546 | Values: 68.0 69.0 68.0 68.0 70.0 69.0 68.0 78.0 66.0 66.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:26:29 INFO - PROCESS | 8546 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 04:26:29 INFO - PROCESS | 8546 | Values: 83.0 82.0 84.0 84.0 82.0 83.0 84.0 85.0 84.0 83.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:125.50 stddev:5.97 (4.8%) stddev-sans-first:6.32 04:26:29 INFO - PROCESS | 8546 | Values: 125.0 122.0 121.0 120.0 126.0 138.0 121.0 131.0 121.0 131.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:149.50 stddev:7.04 (4.7%) stddev-sans-first:6.91 04:26:29 INFO - PROCESS | 8546 | Values: 140.0 158.0 148.0 155.0 151.0 138.0 148.0 147.0 153.0 138.0 04:26:29 INFO - PROCESS | 8546 | 04:26:29 INFO - PROCESS | 8546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 04:26:29 INFO - PROCESS | 8546 | Values: 70.0 70.0 69.0 68.0 70.0 71.0 72.0 71.0 72.0 70.0 04:26:29 INFO - PROCESS | 8546 | -------- Summary: end -------- 04:26:29 INFO - PROCESS | 8546 | 04:26:30 INFO - TEST-INFO | 8546: exit 0 04:26:30 INFO - TEST-OK | kraken | took 60608ms 04:26:30 INFO - TEST-START | v8_7 04:26:30 INFO - operating with platform_type : linux_ 04:26:30 INFO - Initialising browser for v8_7 test... 04:26:30 INFO - TEST-INFO | started process 8795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmkpVr/profile http://localhost:56860/getInfo.html) 04:26:34 INFO - PROCESS | 8795 | __metrics Screen width/height:1600/1200 04:26:34 INFO - PROCESS | 8795 | colorDepth:24 04:26:34 INFO - PROCESS | 8795 | Browser inner width/height: 1024/697 04:26:34 INFO - PROCESS | 8795 | __metrics 04:26:34 INFO - PROCESS | 8795 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:26:34 INFO - PROCESS | 8795 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:35 INFO - TEST-INFO | 8795: exit 0 04:26:35 INFO - Browser initialized. 04:26:35 INFO - Running cycle 1/1 for v8_7 test... 04:26:35 INFO - TEST-INFO | started process 8876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmkpVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:47 INFO - PROCESS | 8876 | RSS: Main: 148541440 04:26:47 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:56860/tests/v8_7/run.html (next: http://localhost:56860/tests/v8_7/run.html) 04:27:10 INFO - PROCESS | 8876 | RSS: Main: 445464576 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | __start_tp_report 04:27:10 INFO - PROCESS | 8876 | _x_x_mozilla_page_load 04:27:10 INFO - PROCESS | 8876 | _x_x_mozilla_page_load_details 04:27:10 INFO - PROCESS | 8876 | |i|pagename|runs| 04:27:10 INFO - PROCESS | 8876 | |0;Richards;166.9449081803005 04:27:10 INFO - PROCESS | 8876 | |1;DeltaBlue;188.35938971557732 04:27:10 INFO - PROCESS | 8876 | |2;Encrypt;278.39643652561244 04:27:10 INFO - PROCESS | 8876 | |3;Decrypt;5170.103092783505 04:27:10 INFO - PROCESS | 8876 | |4;RayTrace;1960.7843137254902 04:27:10 INFO - PROCESS | 8876 | |5;Earley;798.7220447284345 04:27:10 INFO - PROCESS | 8876 | |6;Boyer;12696.20253164557 04:27:10 INFO - PROCESS | 8876 | |7;RegExp;45555.555555555555 04:27:10 INFO - PROCESS | 8876 | |8;Splay;599.1661703394877 04:27:10 INFO - PROCESS | 8876 | |9;NavierStokes;4840.579710144928 04:27:10 INFO - PROCESS | 8876 | __end_tp_report 04:27:10 INFO - PROCESS | 8876 | __startTimestamp1452601630483__endTimestamp 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | ------- Summary: start ------- 04:27:10 INFO - PROCESS | 8876 | Number of tests: 10 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 166.9 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#1] DeltaBlue Cycles:1 Average:188.36 Median:188.36 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 188.4 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 278.4 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 5170.1 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 1960.8 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 798.7 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#6] Boyer Cycles:1 Average:12696.20 Median:12696.20 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 12696.2 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#7] RegExp Cycles:1 Average:45555.56 Median:45555.56 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 45555.6 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#8] Splay Cycles:1 Average:599.17 Median:599.17 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 599.2 04:27:10 INFO - PROCESS | 8876 | 04:27:10 INFO - PROCESS | 8876 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:27:10 INFO - PROCESS | 8876 | Values: 4840.6 04:27:10 INFO - PROCESS | 8876 | -------- Summary: end -------- 04:27:10 INFO - PROCESS | 8876 | 04:27:11 INFO - TEST-INFO | 8876: exit 0 04:27:11 INFO - TEST-OK | v8_7 | took 41134ms 04:27:11 INFO - SUITE-END | took 1218s 04:27:11 INFO - Completed test suite (00:20:19) 04:27:11 INFO - Working with test: dromaeo_css 04:27:11 INFO - Generating results file: dromaeo_css 04:27:11 INFO - Working with test: kraken 04:27:11 INFO - Generating results file: kraken 04:27:11 INFO - javascript benchmark 04:27:11 INFO - Working with test: v8_7 04:27:11 INFO - Generating results file: v8_7 04:27:11 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:27:11 INFO - process_Request line: dromaeo_css 6096.50 graph.html#tests=[[72,94,35]] 04:27:11 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:12 INFO - process_Request line: kraken 1530.80 graph.html#tests=[[232,94,35]] 04:27:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:27:12 INFO - process_Request line: v8_7 18735.81 graph.html#tests=[[230,94,35]] 04:27:12 INFO - RETURN: dromaeo_css: 6096.50 04:27:12 INFO - RETURN: kraken: 1530.80 04:27:12 INFO - RETURN: v8_7: 18735.81 04:27:12 INFO - javascript benchmark 04:27:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2569.486102779444, 2674.491846549157, 2674.8528830914306, 2692.649955505784, 2697.9730202697965, 4348.782560871951, 4488.461384633841, 4517.683762136656, 4536.024754677747, 4555.043440877415, 4505.549445055501, 4538.0923815237, 4592.150452166352, 4602.6087782538525, 4653.88365290867, 4020.8592699255532, 4155.66754659628, 4170.874873753777, 4238.660907127438, 4316.330968699856, 4234.91530169398, 4258.7870606469705, 4308.741475511463, 4310.4611923509565, 4354.042110735633, 4032.9596704033024, 4127.422160897477, 4131.029208136086, 4143.627073563363, 4259.978700106511, 4222.2611043067645, 4253.255680255974, 4258.87223383299, 4260.382244574519, 4297.441332626739, 4211.957880421187, 4220.810063547147, 4223.944013996501, 4236.915261694749, 4263.381809637585, 4298.78506074695, 4415.558444155591, 4423.977880110611, 4429.490608580022, 4539.455265368177, 4858.441279252896, 4897.3878265216845, 4898.853034408973, 4940.629452791055, 4943.456219815817, 4896.387951506062, 4913.06651736169, 4914.606831453475, 4922.606191504671, 4976.2784396262705, 4387.298032314814, 4444.444444444444, 4492.842750503782, 4500.302453119804, 4552.362669226311, 4958.107540642647, 4995.325631039836, 4997.500249975046, 5003.3495645565845, 5040.243963405518, 4786.0667169902235, 4790.125924445305, 4791.976040119777, 4793.736344501086, 4830.130576496264, 4681.859544213679, 4797.992421591435, 4799.208130658402, 4838.371011768448, 4938.8765280868265, 4814.422269327703, 4848.10310092634, 4852.078105160008, 4876.82931097417, 4907.852764417074, 4824.107540105092, 4844.491328410537, 4848.781804818792, 4855.781489832966, 4896.0, 4000.9399859002137, 4091.7135800494275, 4096.508418989741, 4097.282975479279, 4101.692373072032, 3676.7058635309113, 3680.871169509054, 3690.4464330350124, 3703.0, 3708.9072773180346, 4257.6168144867115, 4278.764667943231, 4281.743095414286, 4305.935410968838, 4309.892252693708, 4703.341532185496, 4787.640926930494, 4828.734419606955, 4938.4320803107385, 4943.134951383494, 4151.647109995684, 4183.079722461053, 4211.284081706117, 4241.34259189826, 4249.298865687127, 4362.476502819682, 4379.080393117481, 4386.035072284092, 4387.714798538085, 4431.7562534060935, 4409.4488188976375, 4509.23343031692, 4514.7291162530355, 4663.230566956414, 4707.4821769606, 4812.5668689818085, 4879.121758083579, 4906.215005599087, 4909.3372394727685, 4944.431390390007, 4651.348811166507, 4662.790174442226, 4673.205555055581, 4677.649176311722, 4711.646626502958, 4621.676482646317, 4724.574788269072, 4725.621950244041, 4828.227483602606, 4832.395950506187, 4820.084184005028, 4860.70835749842, 4869.9026019480125, 4886.169351210374, 4925.335079764186, 4733.053389322081, 4735.881602959954, 4736.147493451212, 4757.381540399726, 4778.402699662543, 4491.438570178728, 4601.838935637236, 4610.0, 4735.242361222188, 4750.239961606127, 4579.06129243511, 4623.3758442609815, 4624.1445332613575, 4634.559716826896, 4684.48470668233, 4729.219678752967, 4747.667663263538, 4752.453467851103, 4771.117343291502, 4800.399950006249, 4490.124425737081, 4601.93097103537, 4606.447226332862, 4671.626269898332, 4704.882377940579], "unit": "score", "name": "dojo.html", "value": 4473.971337644778}, {"lowerIsBetter": false, "replicates": [487.75612193903055, 488.49928822956485, 494.3005647009482, 507.8984203159369, 515.8890838469729, 25456.0, 26807.329816754565, 31616.68383316169, 32046.35907281853, 32124.51813222798, 34667.133321666974, 35153.0, 35157.2968540629, 35222.94331170063, 35257.11857203571, 7489.4382921280985, 7676.347510461617, 7685.11621163565, 7685.231476852326, 7687.615619219045, 7537.133229678602, 7664.693412263503, 7675.9232407676045, 7683.731069412572, 7686.1160966489015, 7693.115291741437, 7745.070591528996, 7760.961195194016, 7763.301302882739, 7772.922270777276, 7662.233776622349, 7705.807354816118, 7747.457677962545, 7747.457677962545, 7750.496217745828, 7668.769936901846, 7833.060032796044, 7840.098388685317, 7841.137474877759, 7843.764687059397, 36366.454503182475, 36492.817535912414, 36839.26321473582, 36903.63096369029, 36919.81540092309, 3058.740007099399, 3086.5370194470784, 3171.6194056713343, 3275.2958114005364, 3392.6268110507826, 27353.726462735318, 27753.0, 28061.158165255074, 28230.435391292263, 28301.433971320665, 3384.746144039182, 3392.4402473591826, 3403.7957722536726, 3451.3960056989927, 3510.7542472026967, 213111.0, 213607.0, 213913.0, 214179.0, 214352.0, 45114.32328515075, 52419.0, 52808.47191528112, 52840.471595284325, 52844.47155528473, 39602.207955841295, 57430.138547921815, 58838.0, 58866.7056664714, 58932.705336473045, 13241.139325943783, 13492.527761528496, 13493.730125397436, 13501.0, 13508.527201548095, 9442.77243958281, 9700.660476883417, 10299.639512617023, 10313.329633573794, 10354.326968747007, 17024.914875425544, 17264.96410215366, 17299.481015569552, 17460.476185714448, 17839.46481605554, 7123.074000380021, 7272.709091636381, 7293.927060729431, 7329.74345897891, 7358.926410735824, 887.0242732993655, 895.9104089591119, 905.9547022648841, 927.6335847340263, 1042.9895701042892, 25741.871290643427, 25780.871095644776, 25802.612960805604, 25901.352466188495, 26067.478650426885, 929.8558723397884, 936.686210119604, 1007.1741172238841, 1026.9127124194379, 1111.9610813621484, 11997.280163190237, 12058.879411205951, 12174.634760957186, 12174.878251217551, 12176.878231217752, 256345.0, 259675.0, 259961.0, 260480.0, 260906.0, 38231.808840955615, 38240.42639360412, 38373.61626383756, 38412.8079359607, 38452.615473845464, 1235.5366737473448, 1250.849898012226, 1253.9122261441794, 1257.2959142879834, 1263.059021029339, 22396.888015559816, 22716.545669086856, 23018.194363197206, 23232.0, 23339.416514587272, 34717.0, 35053.123671908405, 35280.64719352876, 35315.11712207215, 35351.0, 144131.2793436026, 145456.0, 243284.0, 250328.0, 250351.0, 27151.506667133497, 27242.863785680944, 27370.589441158, 27388.53503184723, 27545.862270688518, 36583.26833463369, 37139.442908356934, 37225.255494890494, 37598.8120059398, 38186.61813381831, 31651.841740791147, 31870.0, 32584.185395365304, 33058.33883322272, 33175.33649327048, 30476.837603421118, 31817.5227371585, 32857.17857053593, 32918.0, 33123.33753324968, 30529.694703052686, 30975.535366969063, 31077.689223108384, 31392.52911206288, 31397.372052559276, 27756.306092347044, 28281.57577636378, 28404.0, 28410.289742756595, 28502.57246141351, 21904.342869713935, 22004.88997555002, 22183.889080554494, 22422.551548969255, 22703.318900433012], "unit": "score", "name": "ext.html", "value": 15967.439406374893}, {"lowerIsBetter": false, "replicates": [327.3714468221015, 332.0470250381406, 332.7138660751753, 333.90817525180574, 336.0, 11649.0, 12080.885844977116, 14411.495597654084, 14936.17851018195, 15171.089734615916, 14032.43870245189, 14422.423103075864, 14429.927850360733, 14456.277186140704, 15062.0, 4046.534648515429, 4913.213885778277, 5096.108181068316, 5106.157484015133, 5118.0, 5028.044671512419, 5095.0319439306595, 5100.923486147711, 5101.056304583664, 5110.463401342861, 4849.151398505247, 5053.0, 5053.646244762868, 5054.368203974504, 5056.544910958013, 4961.578265847407, 5004.174311238659, 5009.749512524396, 5048.29323894655, 5268.367795864482, 4949.381327334083, 4950.3069570260195, 4952.7028378297055, 4954.47977962316, 4957.851264462072, 16185.757213641804, 17153.485395438158, 17555.824441755674, 17693.29226830925, 18018.819811801844, 1790.7851057873138, 1802.0, 1869.7288893110424, 1911.350140952069, 1912.8374088202381, 8245.422820402575, 8904.59929303183, 11818.349990750592, 12222.816657750142, 12247.203931744409, 1632.6081740382342, 1792.57874399516, 1801.9639607207914, 1805.5576383785926, 1815.5007372972407, 47827.52172478265, 48096.27855582169, 48726.3037609594, 48745.268820967714, 48820.99999999964, 9602.807943841084, 9637.903620963842, 9671.225944723034, 9705.126538611417, 9823.901760982442, 10688.305260158066, 11087.0, 11339.886601134049, 12193.0, 12235.69410764738, 6734.3602357775935, 6784.3554862288, 6809.285025072395, 6823.215330236987, 6893.620850853151, 6352.7141278642575, 6418.0372944057835, 6422.6467544285515, 6434.871302573923, 6519.967400162969, 4047.8988025299604, 4059.4722686050623, 4078.388241763759, 4112.157007813391, 4113.526944401372, 1644.2354305248118, 1670.0814551996352, 1697.0920557501677, 1707.8719096067596, 1733.8526225270741, 812.29736278119, 838.8490071787015, 926.1881692380367, 935.8268720286769, 949.7862980829397, 14620.415183392544, 14934.626634334012, 15135.167565783768, 15258.847411525965, 15288.0, 841.9073901870789, 871.1984973824098, 871.9084496127815, 879.9780005499914, 880.4893161966045, 6891.483138764613, 8177.9591102044105, 8558.186972237627, 8802.911970880337, 8833.160849719266, 404222.0, 414924.0, 423928.0, 427039.0, 428102.0, 58332.7083364589, 60135.398646013855, 60598.69700651557, 60723.0, 61101.694491527254, 931.3387494878576, 959.2901253072675, 1036.9118624916966, 1089.0797276301512, 1102.8125218712837, 12599.811002835148, 13025.609231723063, 13215.537456188988, 13549.458021679022, 14094.788578171541, 27262.454750905268, 27456.313592160357, 27474.0, 28009.29976750516, 28276.010339638015, 31785.0, 31870.203244918135, 31872.0, 32108.839455802572, 33552.66447335593, 6212.689365531795, 6518.706658200297, 6633.535652504278, 6661.633610151488, 6682.866342673216, 8133.715319963773, 9176.174144327042, 9496.002919693332, 9756.512174391393, 9897.35667181631, 8008.199180081945, 8095.190480951857, 8137.2269634387, 8173.100958894398, 8230.794230144294, 8028.799280018046, 8498.53258070812, 8499.95750021246, 8821.426607270507, 8968.82062358736, 2738.86305684711, 2750.40866213765, 8080.151584083586, 8158.510489370657, 8218.06915850485, 6493.0, 6508.479321654351, 6667.899981500184, 6684.866302673822, 6762.729490820312, 7882.487638303492, 8333.333333333198, 8374.581270936551, 8392.580370981304, 8471.0], "unit": "score", "name": "jquery.html", "value": 7227.4519744926165}, {"lowerIsBetter": false, "replicates": [1251.1054595963894, 1384.038093525, 1393.7282229965153, 1536.9615759606008, 1797.3349860551589, 6494.577852439594, 7252.927470725291, 7374.594397308146, 7385.889211661829, 7392.482526223166, 7250.492465527415, 7454.254574542543, 7474.252574742523, 7518.473706840509, 7526.661300241489, 1767.0, 1801.855851531881, 2157.3959291398432, 2185.093186327676, 2223.7109175807122, 2196.791304826047, 2205.8676479411206, 2206.459417442729, 2208.8122509586706, 2212.048819007834, 2056.1672522628282, 2157.094020511381, 2173.3045425463856, 2175.7824217578273, 2179.3461961411513, 2144.378130342199, 2167.3389616167065, 2170.8914554272224, 2201.9119235230573, 2207.0178770447155, 2160.7731188225325, 2166.6100101981638, 2171.0881429799524, 2181.4982554012668, 2182.508935489518, 7674.46278760487, 7695.345895598881, 7724.111727151337, 7731.0, 7756.844863102763, 4403.163398954189, 4494.865154045384, 4508.233600287959, 4530.79611417487, 4531.342955271467, 2817.1970988268245, 2827.3921106962102, 2870.641169853768, 2877.784166187523, 2953.4240823039518, 892.205936716323, 897.349421669291, 901.6213190460022, 924.0343840686498, 949.9762505937338, 10142.543585538668, 10289.176865850714, 10305.742356441075, 10310.0, 10328.225383096298, 3938.665213456888, 3963.7225394222705, 4024.3158663027357, 4030.5163380394542, 4107.096438783463, 8944.910550894409, 8969.461832290084, 8983.416077954913, 8986.415882967585, 8987.865182022275, 4496.033352829158, 4502.594766471033, 4502.684812063124, 4503.076869241798, 4508.323751437245, 4016.578259282733, 4055.0673345130194, 4060.127072679388, 4066.1054567995584, 4069.1658210066867, 3168.2396224905856, 3235.142687187897, 3509.9122521937156, 3522.894313170609, 3610.6750392464805, 1138.743782648914, 1157.1494951210852, 1168.2464810197546, 1173.102576528956, 1176.8117101263756, 1200.663814132027, 1212.8665846756849, 1219.091776626419, 1227.6623928419756, 1235.184778046485, 7156.713731450684, 7273.418126549864, 7303.488755787044, 7327.340539351484, 7346.889796653055, 1025.5487585462372, 1036.76154484469, 1043.9425831579335, 1059.6132411669685, 1068.604616291977, 5549.250851135045, 5586.86032849182, 5610.13042978339, 5619.4099619540175, 5627.12779519167, 8293.460925039853, 8440.902682651338, 8675.609597568124, 8713.477191368538, 8714.041455439896, 8612.913870861337, 8639.611217495229, 8650.480971141751, 8780.736577902673, 8820.8676869847, 6842.4183944364295, 7032.507724459341, 7327.413806895435, 7433.10802703679, 7461.477696561297, 7105.9289407107335, 7156.463265255023, 7176.4258859290085, 7177.282271772781, 7185.173705023989, 7782.92217077822, 8099.959500202462, 8193.221643943816, 8220.671173153007, 8224.958875205586, 8182.22268884455, 8317.334613230805, 8430.704925327584, 8478.491290522588, 8482.618282177193, 6987.091678081817, 7014.68433920485, 7061.329173728487, 7076.646167691491, 7109.395701365442, 6180.165677633462, 6323.146375239284, 6904.792856214322, 7061.152661680631, 7069.9646501767165, 6488.578242414228, 6579.934200657932, 6603.042558829039, 6658.434033107046, 6775.898361524482, 6368.108464814837, 6648.301928297653, 6767.221769496571, 6773.729050837911, 6836.897446538405, 6836.48726345536, 6870.862582748417, 6887.862242755016, 6890.31096890307, 6899.862002759816, 6199.690015499117, 6223.190985171898, 6247.406496382836, 6263.655498947602, 6288.245410550763, 6420.036994450869, 6472.0, 6475.740970361133, 6476.352364763486, 6479.546431749733], "unit": "score", "name": "mootools.html", "value": 4309.312852438933}, {"lowerIsBetter": false, "replicates": [313.629916698296, 316.9572107765451, 317.90145055032934, 325.4386183832889, 326.77289283947636, 5110.284560161575, 5216.713080780555, 5252.1859111837675, 5309.73451327434, 5339.092354299769, 5166.638335316529, 5215.739213039343, 5223.817166399177, 5227.764750586223, 5230.92153617696, 3902.7853468059247, 3977.1647953929564, 4005.9799701001452, 4068.572799856017, 4076.612721791425, 4028.234635419261, 4053.5946405359523, 4055.087605288816, 4057.6550993165615, 4071.7149799514045, 4055.797210139496, 4062.0860306431114, 4066.877993660195, 4067.3695577185435, 4072.9592704072875, 3827.0815004398883, 3892.163184915257, 3941.054147004727, 4025.496812898388, 4026.45642838216, 3546.8935931922083, 3554.129238336598, 3554.1647712787476, 3563.465480177968, 3566.8216589170697, 5011.949880501184, 5030.094582975063, 5031.119554078022, 5033.345665063518, 5033.647644664875, 4638.5593368629925, 4653.232216684243, 4653.395058642389, 4656.254999200111, 4658.720476771371, 5357.919631205535, 5433.701146436944, 5461.126219804852, 5463.672179669233, 5486.177073438977, 3842.9231415371537, 3843.404272337792, 3843.5579908310624, 3845.1732877431205, 3845.6346647068485, 5659.236003139565, 5742.655440673573, 5748.051571490699, 5752.252207213036, 5753.827385178452, 3961.504811898513, 3969.4839670842607, 3970.06703424695, 3970.305196590585, 3975.926499845026, 3874.9806250968563, 4024.1146947671464, 4024.839006439768, 4035.757854528738, 4038.3134867072667, 4599.126166028444, 4621.838235661736, 4626.352310676508, 4632.2819962905805, 4636.026434448803, 5471.50756431915, 5484.945150548523, 5493.395726470085, 5495.626093476631, 5495.642783219078, 1375.40170026039, 1424.658082060298, 1430.106183635228, 1430.1990885104374, 1434.8278206615273, 953.4755884263627, 956.297121615612, 972.4505654305295, 993.4287784523783, 997.1275134257525, 4858.46556878743, 4872.51274872517, 4880.365552478226, 4882.609391248691, 4883.413990321184, 5689.715514224272, 5690.174924635905, 5692.658440493584, 5692.743826527816, 5697.544196464273, 4857.8299759508245, 4860.8298709545, 4869.829555965595, 4872.707637541759, 4875.756212189376, 2825.2230636575105, 2943.3818898031654, 3020.6828283030404, 3053.9389212215633, 3093.7370323522755, 5365.222042803772, 5392.245085688007, 5412.161115027177, 5414.675119492765, 5415.566754659618, 5937.376575459514, 5941.762329506858, 5942.3166335871065, 5943.5839491236065, 5944.108383742387, 5478.753456094485, 5480.753366098615, 5481.123020316731, 5493.0, 5493.285872836585, 5631.549476041989, 5744.827655170351, 5761.2222349983895, 5763.415060858298, 5771.278590176228, 5611.915821262766, 5621.859453513532, 5625.156226566048, 5625.746841392065, 5627.690477023803, 5473.67157970523, 5476.534494567847, 5482.314710661168, 5482.369527504388, 5483.7258137092185, 3979.3633018716864, 3982.2433737589763, 3982.3628219484744, 3983.48214732083, 3986.202759448064, 5592.832215033555, 5748.511376533042, 5753.798617048383, 5754.2519472469985, 5759.539236861125, 5542.307211598551, 5544.0575102231915, 5548.944510555004, 5549.944500554942, 5559.888802223852, 5547.500724934614, 5555.472230138131, 5555.555555555465, 5557.722113894209, 5558.861028474321, 5321.068812957795, 5446.809361672323, 5446.836594902159, 5449.972750136224, 5461.0716178248995, 5575.498205161555, 5582.162675598693, 5583.050881350099, 5585.106382978704, 5588.804391846266, 5452.7546260417585, 5457.345118585637, 5461.672299662033, 5462.426445223353, 5465.781368745205], "unit": "score", "name": "prototype.html", "value": 4154.683374670139}, {"lowerIsBetter": false, "replicates": [740.862940356034, 757.0725860820496, 797.1789057271013, 806.491910096639, 807.1323327423022, 12892.22646641201, 13117.212967221949, 13126.803097953514, 13129.0, 13138.868611313885, 12682.873171268284, 12727.045471589621, 12746.617601471948, 12762.93618531906, 12773.105882588223, 615.0313256620818, 623.7411474238186, 780.3951937248621, 794.9602519873984, 795.347814791868, 784.9568273744942, 794.0907660728462, 797.314309693663, 799.1968072087544, 800.2237829305565, 819.2872201184978, 820.4748960665179, 823.3372135431006, 825.0594322472386, 825.5830805443243, 634.5399585300643, 642.9292777794439, 643.0932385336653, 644.9484041276734, 820.5404973215019, 475.83821500689584, 598.9041753319448, 607.401709316323, 611.5566214494501, 612.3294991983771, 11594.826077608843, 11651.184417090806, 11664.708382290426, 11688.941555292255, 11708.882911170864, 10532.894671053267, 10561.683149505527, 10872.67381978534, 11217.0, 11290.435478226138, 9405.482698451651, 9459.90540094597, 9528.0, 9581.520923953844, 9605.615775369046, 3179.268768183331, 3213.260949981494, 3237.7409807215367, 3243.6107667079864, 3280.327532855759, 37624.0, 38245.42631860524, 38340.424893626616, 38371.42442863387, 38379.61620383788, 9054.366194366463, 9182.17360437564, 9226.723198304062, 9387.436753794795, 9465.242780577537, 15657.373705051898, 15684.843151568566, 15710.528684139494, 15743.448979285899, 15759.921200393925, 6059.1820104286235, 6234.906476402857, 6337.429631333202, 6490.4807615390655, 6512.739490420425, 3572.1069732566857, 3649.9635003649623, 3708.165662725865, 3778.4899038629983, 3794.2221844521805, 2717.320669832542, 2722.91831245063, 2736.151792944154, 2740.410811675499, 2749.9962513682763, 484.8327327072154, 492.6132985606282, 493.34631613112055, 500.3095727895481, 504.02219693794655, 454.4092679516615, 510.8978204359143, 540.7701726766109, 598.9011813050798, 607.4502575169479, 6840.418564421981, 7066.470014748915, 7302.306280903305, 7321.560706357635, 7342.4493163012985, 443.67168295461124, 465.8998315362213, 481.4102724162872, 494.6067876038558, 519.2937604857391, 3338.2989572190113, 3480.4953281774, 3624.4744512045604, 3831.5976822433245, 3896.688264938798, 44371.0, 45182.77408612936, 45214.32178517325, 50578.747106264236, 53738.193927091124, 39436.605633943866, 39572.20855582872, 39789.80105099456, 42613.786931065144, 42926.78536607359, 35217.47173792395, 38248.42627360592, 38425.0, 38650.22699545993, 39472.40791388132, 7491.700331986877, 7747.806304842424, 7781.610919454118, 7857.646405911633, 7926.643301051351, 29321.12036638904, 29530.704692953655, 30189.245268867577, 30288.69711302859, 30320.0, 34957.65042349646, 37120.814395927846, 37191.44212836864, 37479.0, 37856.810715946245, 9875.963023882676, 9949.502524873873, 9989.450580217866, 10047.547860346449, 10132.34139780912, 10482.475876206312, 10862.185336099667, 11074.944625277145, 11473.82789258145, 11549.364784936573, 9482.95258523703, 9694.951525242328, 9728.319017668695, 9751.171150452292, 9825.557849896915, 9728.854067188857, 10405.0, 10575.62985295511, 10652.62715804943, 10685.252032357661, 9929.801403972024, 10210.846837297595, 10222.846657299997, 10583.470826458492, 10597.788044238918, 8623.568821559022, 8922.55387230649, 8977.775555611162, 9004.954975225082, 9028.683996060106, 8197.385196110195, 8212.712555060543, 8539.975202975682, 8598.140185981352, 8991.370604057653], "unit": "score", "name": "yui.html", "value": 5553.707017491025}], "name": "dromaeo_css", "value": 6096.499017156585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 113.0, 113.0, 114.0, 102.0, 112.0, 114.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [149.0, 132.0, 155.0, 168.0, 137.0, 153.0, 154.0, 135.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 163.0, 162.0, 161.0, 162.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [86.0, 72.0, 81.0, 92.0, 72.0, 75.0, 74.0, 128.0, 87.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 140.0, 98.0, 98.0, 98.0, 137.0, 97.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0, 78.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 84.0, 82.0, 83.0, 84.0, 85.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 121.0, 120.0, 126.0, 138.0, 121.0, 131.0, 121.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [140.0, 158.0, 148.0, 155.0, 151.0, 138.0, 148.0, 147.0, 153.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 68.0, 70.0, 71.0, 72.0, 71.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1530.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [188.35938971557732], "unit": "score", "name": "DeltaBlue", "value": 351.0204619999999}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12696.20253164557], "unit": "score", "name": "Boyer", "value": 52.49309770687939}, {"lowerIsBetter": false, "replicates": [45555.555555555555], "unit": "score", "name": "RegExp", "value": 19.997231707317063}, {"lowerIsBetter": false, "replicates": [599.1661703394877], "unit": "score", "name": "Splay", "value": 136.00734493041756}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18735.8075582843}]} 04:27:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18735.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1530.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6096.50"}}} 04:27:12 INFO - Return code: 0 04:27:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:12 INFO - # TBPL SUCCESS # 04:27:12 INFO - Running post-action listener: _resource_record_post_action 04:27:12 INFO - Running post-run listener: _resource_record_post_run 04:27:13 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 541306880; Read time: 0; Write time: 647860 04:27:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231190528; Read time: 0; Write time: 335892 04:27:13 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 310116352; Read time: 0; Write time: 311968 04:27:13 INFO - Running post-run listener: _upload_blobber_files 04:27:13 INFO - Blob upload gear active. 04:27:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:13 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 04:27:13 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:27:13 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:27:13 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:14 INFO - (blobuploader) - INFO - Done attempting. 04:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:15 INFO - (blobuploader) - INFO - Done attempting. 04:27:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:15 INFO - Return code: 0 04:27:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34693b4ca746450c98f9f587c59014d1948c3fcdbb660779533883bfa16a9a43503f8915d60074598630f3f65cac5137cc3fd4db1b183875ac701c98d144dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f5075a1880b9995cbe953e61a8fb08d83ba2ec87eab3309446758c14445ba535e1163852baa08537ee75b20cefc909c8b04c4f0a38d4160f61c9db5956c9528"} 04:27:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:15 INFO - Contents: 04:27:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34693b4ca746450c98f9f587c59014d1948c3fcdbb660779533883bfa16a9a43503f8915d60074598630f3f65cac5137cc3fd4db1b183875ac701c98d144dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f5075a1880b9995cbe953e61a8fb08d83ba2ec87eab3309446758c14445ba535e1163852baa08537ee75b20cefc909c8b04c4f0a38d4160f61c9db5956c9528"} 04:27:15 INFO - Copying logs to upload dir... 04:27:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.538610 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-12 04:27:14.878181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 04:27:14.881386) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34693b4ca746450c98f9f587c59014d1948c3fcdbb660779533883bfa16a9a43503f8915d60074598630f3f65cac5137cc3fd4db1b183875ac701c98d144dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f5075a1880b9995cbe953e61a8fb08d83ba2ec87eab3309446758c14445ba535e1163852baa08537ee75b20cefc909c8b04c4f0a38d4160f61c9db5956c9528"} build_url:https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/SPadioCqTnin9qgrlYy_9g/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/Firefox-Non-PGO/sha512/5f34693b4ca746450c98f9f587c59014d1948c3fcdbb660779533883bfa16a9a43503f8915d60074598630f3f65cac5137cc3fd4db1b183875ac701c98d144dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f5075a1880b9995cbe953e61a8fb08d83ba2ec87eab3309446758c14445ba535e1163852baa08537ee75b20cefc909c8b04c4f0a38d4160f61c9db5956c9528"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 04:27:14.905856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:27:14.906183) ========= 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=aa52b8aba932b19cc50b5275000001de-1452591417.264357-1828380355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 04:27:14.992250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 04:27:14.992965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 04:27:14.993534) ========= ========= Total master_lag: 0.25 =========