builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1452770213.62 results: success (0) buildid: 20160114025031 builduid: b387ea04668a433a9e5b3ee2c71a9378 revision: 3bf9a89c8f11184eac7fb4b145999dd92f6b17c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.624097) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.624892) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.625250) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.656908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.657318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.679146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.679606) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.729388) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.729720) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.730113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.730395) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 03:16:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.1M=0s 2016-01-14 03:16:54 (37.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.906361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.906735) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017767 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.956508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:53.956873) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3bf9a89c8f11184eac7fb4b145999dd92f6b17c2 --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 3bf9a89c8f11184eac7fb4b145999dd92f6b17c2 --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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 03:16:54,375 truncating revision to first 12 chars 2016-01-14 03:16:54,375 Setting DEBUG logging. 2016-01-14 03:16:54,375 attempt 1/10 2016-01-14 03:16:54,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3bf9a89c8f11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 03:16:54,648 unpacking tar archive at: mozilla-central-3bf9a89c8f11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:54.558988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:54.559329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:54.568551) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:54.568906) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:16:54.569327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 03:16:54.569629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:55 INFO - MultiFileLogger online at 20160114 03:16:55 in /builds/slave/test 03:16:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 03:16:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:55 INFO - {'append_to_log': False, 03:16:55 INFO - 'base_work_dir': '/builds/slave/test', 03:16:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:55 INFO - 'branch': 'Firefox-Non-PGO', 03:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:55 INFO - 'config_files': ('talos/linux_config.py',), 03:16:55 INFO - 'default_actions': ('clobber', 03:16:55 INFO - 'read-buildbot-config', 03:16:55 INFO - 'download-and-extract', 03:16:55 INFO - 'populate-webroot', 03:16:55 INFO - 'create-virtualenv', 03:16:55 INFO - 'install', 03:16:55 INFO - 'run-tests'), 03:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:55 INFO - 'download_minidump_stackwalk': True, 03:16:55 INFO - 'download_symbols': 'ondemand', 03:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:55 INFO - 'installer_path': 'installer.exe', 03:16:55 INFO - 'log_level': 'info', 03:16:55 INFO - 'log_name': 'talos', 03:16:55 INFO - 'log_to_console': True, 03:16:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:55 INFO - 'opt_config_files': (), 03:16:55 INFO - 'pip_index': False, 03:16:55 INFO - 'sps_profile': False, 03:16:55 INFO - 'sps_profile_interval': 0, 03:16:55 INFO - 'suite': 'dromaeojs-e10s', 03:16:55 INFO - 'system_bits': '32', 03:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:55 INFO - 'title': 'talos-linux64-ix-015', 03:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:55 INFO - 'use_talos_json': True, 03:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:55 INFO - 'work_dir': 'build'} 03:16:55 INFO - ##### 03:16:55 INFO - ##### Running clobber step. 03:16:55 INFO - ##### 03:16:55 INFO - Running pre-action listener: _resource_record_pre_action 03:16:55 INFO - Running main action method: clobber 03:16:55 INFO - rmtree: /builds/slave/test/build 03:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - ##### 03:16:56 INFO - ##### Running read-buildbot-config step. 03:16:56 INFO - ##### 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: read_buildbot_config 03:16:56 INFO - Using buildbot properties: 03:16:56 INFO - { 03:16:56 INFO - "project": "", 03:16:56 INFO - "product": "firefox", 03:16:56 INFO - "script_repo_revision": "production", 03:16:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:16:56 INFO - "repository": "", 03:16:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:16:56 INFO - "buildid": "20160114025031", 03:16:56 INFO - "pgo_build": "False", 03:16:56 INFO - "basedir": "/builds/slave/test", 03:16:56 INFO - "buildnumber": 172, 03:16:56 INFO - "slavename": "talos-linux64-ix-015", 03:16:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:16:56 INFO - "platform": "ubuntu64_hw", 03:16:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:16:56 INFO - "branch": "mozilla-central", 03:16:56 INFO - "repo_path": "mozilla-central", 03:16:56 INFO - "revision": "3bf9a89c8f11184eac7fb4b145999dd92f6b17c2", 03:16:56 INFO - "stage_platform": "linux64", 03:16:56 INFO - "builduid": "b387ea04668a433a9e5b3ee2c71a9378", 03:16:56 INFO - "slavebuilddir": "test" 03:16:56 INFO - } 03:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:16:56 INFO - Running post-action listener: _resource_record_post_action 03:16:56 INFO - ##### 03:16:56 INFO - ##### Running download-and-extract step. 03:16:56 INFO - ##### 03:16:56 INFO - Running pre-action listener: _resource_record_pre_action 03:16:56 INFO - Running main action method: download_and_extract 03:16:56 INFO - mkdir: /builds/slave/test/build/tests 03:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:56 INFO - https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/test_packages.json 03:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/test_packages.json 03:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:16:58 INFO - Downloaded 1448 bytes. 03:16:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:16:58 INFO - Using the following test package requirements: 03:16:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:16:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:58 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:16:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'jsshell-linux-x86_64.zip'], 03:16:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:16:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:16:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:16:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:16:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:16:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:58 INFO - https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:03 INFO - Downloaded 22762442 bytes. 03:17:03 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 03:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:17:03 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 03:17:04 INFO - Return code: 0 03:17:04 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 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:04 INFO - https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:08 INFO - Downloaded 22762442 bytes. 03:17:08 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 03:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:17:08 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 03:17:09 INFO - Return code: 0 03:17: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')]} 03:17:09 INFO - https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:11 INFO - Downloaded 11132144 bytes. 03:17:11 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 03:17:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:11 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 03:17:11 INFO - Return code: 0 03:17:11 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')]} 03:17:11 INFO - https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1b0VBevR8e61VbP0WgBxg/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 03:17:16 INFO - Downloaded 53977665 bytes. 03:17:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:17:16 INFO - mkdir: /builds/slave/test/properties 03:17:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:16 INFO - Contents: 03:17:16 INFO - build_url:https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:17:16 INFO - Running post-action listener: _resource_record_post_action 03:17:16 INFO - Running post-action listener: set_extra_try_arguments 03:17:16 INFO - ##### 03:17:16 INFO - ##### Running populate-webroot step. 03:17:16 INFO - ##### 03:17:16 INFO - Running pre-action listener: _resource_record_pre_action 03:17:16 INFO - Running main action method: populate_webroot 03:17:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:16 INFO - '--tppagecycles', 03:17:16 INFO - '7'], 03:17:16 INFO - 'tests': ['tsvgm']}}, 03:17:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:17:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:17:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:17:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'tests': ['damp', 'tps']}, 03:17:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['damp', 'tps']}, 03:17:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:17:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:16 INFO - 'other': {'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'other_l64': {'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'other_nol64': {'tests': ['a11yr', 03:17:16 INFO - 'ts_paint', 03:17:16 INFO - 'tpaint', 03:17:16 INFO - 'sessionrestore', 03:17:16 INFO - 'sessionrestore_no_auto_restore']}, 03:17:16 INFO - 'svgr': {'tests': ['tsvgx', 03:17:16 INFO - 'tsvgr_opacity', 03:17:16 INFO - 'tart', 03:17:16 INFO - 'tscrollx', 03:17:16 INFO - 'cart']}, 03:17:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['tsvgx', 03:17:16 INFO - 'tsvgr_opacity', 03:17:16 INFO - 'tart', 03:17:16 INFO - 'tscrollx', 03:17:16 INFO - 'cart']}, 03:17:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'tests': ['tp5o']}, 03:17:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'talos_options': ['--e10s'], 03:17:16 INFO - 'tests': ['tp5o']}, 03:17:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'talos_options': ['--xperf_path', 03:17:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:16 INFO - 'tests': ['tp5n']}, 03:17:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:16 INFO - 'talos_options': ['--e10s', 03:17:16 INFO - '--xperf_path', 03:17:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:16 INFO - 'tests': ['tp5n']}}, 03:17:16 INFO - 'talos.zip': {'path': '', 03:17:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:16 INFO - Running post-action listener: _resource_record_post_action 03:17:16 INFO - ##### 03:17:16 INFO - ##### Running create-virtualenv step. 03:17:16 INFO - ##### 03:17:16 INFO - Running pre-action listener: _resource_record_pre_action 03:17:16 INFO - Running main action method: create_virtualenv 03:17:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:16 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 03:17:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:16 INFO - Using real prefix '/usr' 03:17:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:17 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:19 INFO - Installing pip.................done. 03:17:19 INFO - Return code: 0 03:17:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:19 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:19 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 03:17:19 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 03:17:19 INFO - Using env: {'DISPLAY': ':0', 03:17:19 INFO - 'HOME': '/home/cltbld', 03:17:19 INFO - 'LANG': 'en_US.UTF-8', 03:17:19 INFO - 'LANGUAGE': 'en_US:en', 03:17:19 INFO - 'LOGNAME': 'cltbld', 03:17:19 INFO - 'MAIL': '/var/mail/cltbld', 03:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:19 INFO - 'MOZ_NO_REMOTE': '1', 03:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:19 INFO - 'NO_EM_RESTART': '1', 03:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:19 INFO - 'PWD': '/builds/slave/test', 03:17:19 INFO - 'SHELL': '/bin/bash', 03:17:19 INFO - 'SHLVL': '1', 03:17:19 INFO - 'TERM': 'linux', 03:17:19 INFO - 'TMOUT': '86400', 03:17:19 INFO - 'USER': 'cltbld', 03:17:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:19 INFO - '_': '/tools/buildbot/bin/python'} 03:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:19 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 03:17:19 INFO - Cleaning up... 03:17:19 INFO - Return code: 0 03:17:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:19 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:19 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 03:17:19 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 03:17:19 INFO - Using env: {'DISPLAY': ':0', 03:17:19 INFO - 'HOME': '/home/cltbld', 03:17:19 INFO - 'LANG': 'en_US.UTF-8', 03:17:19 INFO - 'LANGUAGE': 'en_US:en', 03:17:19 INFO - 'LOGNAME': 'cltbld', 03:17:19 INFO - 'MAIL': '/var/mail/cltbld', 03:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:19 INFO - 'MOZ_NO_REMOTE': '1', 03:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:19 INFO - 'NO_EM_RESTART': '1', 03:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:19 INFO - 'PWD': '/builds/slave/test', 03:17:19 INFO - 'SHELL': '/bin/bash', 03:17:19 INFO - 'SHLVL': '1', 03:17:19 INFO - 'TERM': 'linux', 03:17:19 INFO - 'TMOUT': '86400', 03:17:19 INFO - 'USER': 'cltbld', 03:17:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:19 INFO - '_': '/tools/buildbot/bin/python'} 03:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:19 INFO - Downloading/unpacking psutil>=0.7.1 03:17:19 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 03:17:19 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 03:17:19 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 03:17:19 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 03:17:19 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 03:17:19 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 03:17:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:17:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:21 INFO - Installing collected packages: psutil 03:17:21 INFO - Running setup.py install for psutil 03:17:21 INFO - building 'psutil._psutil_linux' extension 03:17:21 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 03:17:21 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 03:17:21 INFO - building 'psutil._psutil_posix' extension 03:17:21 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 03:17:21 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 03:17:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:22 INFO - Successfully installed psutil 03:17:22 INFO - Cleaning up... 03:17:22 INFO - Return code: 0 03:17:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:17:22 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')]} 03:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 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')]} 03:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:22 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 03:17:22 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 03:17:22 INFO - Using env: {'DISPLAY': ':0', 03:17:22 INFO - 'HOME': '/home/cltbld', 03:17:22 INFO - 'LANG': 'en_US.UTF-8', 03:17:22 INFO - 'LANGUAGE': 'en_US:en', 03:17:22 INFO - 'LOGNAME': 'cltbld', 03:17:22 INFO - 'MAIL': '/var/mail/cltbld', 03:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:22 INFO - 'MOZ_NO_REMOTE': '1', 03:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:22 INFO - 'NO_EM_RESTART': '1', 03:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:22 INFO - 'PWD': '/builds/slave/test', 03:17:22 INFO - 'SHELL': '/bin/bash', 03:17:22 INFO - 'SHLVL': '1', 03:17:22 INFO - 'TERM': 'linux', 03:17:22 INFO - 'TMOUT': '86400', 03:17:22 INFO - 'USER': 'cltbld', 03:17:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:22 INFO - '_': '/tools/buildbot/bin/python'} 03:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:17:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:17:24 INFO - Installing collected packages: mozsystemmonitor 03:17:24 INFO - Running setup.py install for mozsystemmonitor 03:17:24 INFO - Successfully installed mozsystemmonitor 03:17:24 INFO - Cleaning up... 03:17:24 INFO - Return code: 0 03:17:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:24 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')]} 03:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:24 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')]} 03:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:24 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:24 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 03:17:24 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 03:17:24 INFO - Using env: {'DISPLAY': ':0', 03:17:24 INFO - 'HOME': '/home/cltbld', 03:17:24 INFO - 'LANG': 'en_US.UTF-8', 03:17:24 INFO - 'LANGUAGE': 'en_US:en', 03:17:24 INFO - 'LOGNAME': 'cltbld', 03:17:24 INFO - 'MAIL': '/var/mail/cltbld', 03:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:24 INFO - 'MOZ_NO_REMOTE': '1', 03:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:24 INFO - 'NO_EM_RESTART': '1', 03:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:24 INFO - 'PWD': '/builds/slave/test', 03:17:24 INFO - 'SHELL': '/bin/bash', 03:17:24 INFO - 'SHLVL': '1', 03:17:24 INFO - 'TERM': 'linux', 03:17:24 INFO - 'TMOUT': '86400', 03:17:24 INFO - 'USER': 'cltbld', 03:17:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:24 INFO - '_': '/tools/buildbot/bin/python'} 03:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 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 03:17:26 INFO - Downloading docopt-0.6.1.tar.gz 03:17:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:26 INFO - Running setup.py install for blobuploader 03:17:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:26 INFO - Running setup.py install for requests 03:17:27 INFO - Running setup.py install for docopt 03:17:27 INFO - Successfully installed blobuploader requests docopt 03:17:27 INFO - Cleaning up... 03:17:27 INFO - Return code: 0 03:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:27 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:27 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 03:17:27 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 03:17:27 INFO - Using env: {'DISPLAY': ':0', 03:17:27 INFO - 'HOME': '/home/cltbld', 03:17:27 INFO - 'LANG': 'en_US.UTF-8', 03:17:27 INFO - 'LANGUAGE': 'en_US:en', 03:17:27 INFO - 'LOGNAME': 'cltbld', 03:17:27 INFO - 'MAIL': '/var/mail/cltbld', 03:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:27 INFO - 'MOZ_NO_REMOTE': '1', 03:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:27 INFO - 'NO_EM_RESTART': '1', 03:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:27 INFO - 'PWD': '/builds/slave/test', 03:17:27 INFO - 'SHELL': '/bin/bash', 03:17:27 INFO - 'SHLVL': '1', 03:17:27 INFO - 'TERM': 'linux', 03:17:27 INFO - 'TMOUT': '86400', 03:17:27 INFO - 'USER': 'cltbld', 03:17:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:27 INFO - '_': '/tools/buildbot/bin/python'} 03:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:27 INFO - Running setup.py (path:/tmp/pip-gX1gjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:27 INFO - Running setup.py (path:/tmp/pip-1jCYBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:27 INFO - Running setup.py (path:/tmp/pip-v03CcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:27 INFO - Running setup.py (path:/tmp/pip-4sc2Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:27 INFO - Running setup.py (path:/tmp/pip-ND856V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:28 INFO - Running setup.py (path:/tmp/pip-bJo_Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:28 INFO - Running setup.py (path:/tmp/pip-YjjmEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:28 INFO - Running setup.py (path:/tmp/pip-pLnSxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:28 INFO - Running setup.py (path:/tmp/pip-AvUXII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:28 INFO - Running setup.py (path:/tmp/pip-izfqUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:28 INFO - Running setup.py (path:/tmp/pip-AAWG3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:28 INFO - Running setup.py (path:/tmp/pip-DpJmCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:28 INFO - Running setup.py (path:/tmp/pip-hQNz43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:28 INFO - Running setup.py (path:/tmp/pip-Fx7Ncx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:28 INFO - Running setup.py (path:/tmp/pip-fkdLCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:28 INFO - Running setup.py (path:/tmp/pip-G4XWfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:28 INFO - Running setup.py (path:/tmp/pip-OS69Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:28 INFO - Running setup.py install for manifestparser 03:17:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for mozcrash 03:17:29 INFO - Running setup.py install for mozdebug 03:17:29 INFO - Running setup.py install for mozdevice 03:17:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for mozfile 03:17:29 INFO - Running setup.py install for mozhttpd 03:17:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for mozinfo 03:17:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for mozInstall 03:17:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for mozleak 03:17:29 INFO - Running setup.py install for mozlog 03:17:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:29 INFO - Running setup.py install for moznetwork 03:17:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Running setup.py install for mozprocess 03:17:30 INFO - Running setup.py install for mozprofile 03:17:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Running setup.py install for mozrunner 03:17:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Running setup.py install for mozscreenshot 03:17:30 INFO - Running setup.py install for moztest 03:17:30 INFO - Running setup.py install for mozversion 03:17:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:30 INFO - Cleaning up... 03:17:30 INFO - Return code: 0 03:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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/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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17: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/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 03:17: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/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 03:17:30 INFO - Using env: {'DISPLAY': ':0', 03:17:30 INFO - 'HOME': '/home/cltbld', 03:17:30 INFO - 'LANG': 'en_US.UTF-8', 03:17:30 INFO - 'LANGUAGE': 'en_US:en', 03:17:30 INFO - 'LOGNAME': 'cltbld', 03:17:30 INFO - 'MAIL': '/var/mail/cltbld', 03:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:30 INFO - 'MOZ_NO_REMOTE': '1', 03:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:30 INFO - 'NO_EM_RESTART': '1', 03:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:30 INFO - 'PWD': '/builds/slave/test', 03:17:30 INFO - 'SHELL': '/bin/bash', 03:17:30 INFO - 'SHLVL': '1', 03:17:30 INFO - 'TERM': 'linux', 03:17:30 INFO - 'TMOUT': '86400', 03:17:30 INFO - 'USER': 'cltbld', 03:17:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:30 INFO - '_': '/tools/buildbot/bin/python'} 03:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:30 INFO - Running setup.py (path:/tmp/pip-9A4H1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:30 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)) 03:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:30 INFO - Running setup.py (path:/tmp/pip-nC1nG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:31 INFO - Running setup.py (path:/tmp/pip-bxrmWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:31 INFO - Running setup.py (path:/tmp/pip-QGBCqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:31 INFO - Running setup.py (path:/tmp/pip-CCFj1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:31 INFO - Running setup.py (path:/tmp/pip-SnrWp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:31 INFO - Running setup.py (path:/tmp/pip-Bd2aJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:31 INFO - Running setup.py (path:/tmp/pip-Kr32qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:31 INFO - Running setup.py (path:/tmp/pip-dAAmcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:31 INFO - Running setup.py (path:/tmp/pip-hJlUJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:31 INFO - Running setup.py (path:/tmp/pip-Iv4uF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:31 INFO - Running setup.py (path:/tmp/pip-j28jQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:31 INFO - Running setup.py (path:/tmp/pip-Ddp4vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:31 INFO - Running setup.py (path:/tmp/pip-pUjXIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:31 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)) 03:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:31 INFO - Running setup.py (path:/tmp/pip-3QN60A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:32 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)) 03:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:32 INFO - Running setup.py (path:/tmp/pip-MF7nhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:32 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)) 03:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:32 INFO - Running setup.py (path:/tmp/pip-K7GHHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:32 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)) 03:17:32 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)) 03:17:32 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)) 03:17:32 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)) 03:17:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:33 INFO - Downloading blessings-1.5.1.tar.gz 03:17:33 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 03:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:33 INFO - Installing collected packages: blessings 03:17:33 INFO - Running setup.py install for blessings 03:17:34 INFO - Successfully installed blessings 03:17:34 INFO - Cleaning up... 03:17:34 INFO - Return code: 0 03:17:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:34 INFO - Reading from file tmpfile_stdout 03:17:34 INFO - Current package versions: 03:17:34 INFO - argparse == 1.2.1 03:17:34 INFO - blessings == 1.5.1 03:17:34 INFO - blobuploader == 1.2.4 03:17:34 INFO - docopt == 0.6.1 03:17:34 INFO - manifestparser == 1.1 03:17:34 INFO - mozInstall == 1.12 03:17:34 INFO - mozcrash == 0.16 03:17:34 INFO - mozdebug == 0.1 03:17:34 INFO - mozdevice == 0.48 03:17:34 INFO - mozfile == 1.2 03:17:34 INFO - mozhttpd == 0.7 03:17:34 INFO - mozinfo == 0.9 03:17:34 INFO - mozleak == 0.1 03:17:34 INFO - mozlog == 3.1 03:17:34 INFO - moznetwork == 0.27 03:17:34 INFO - mozprocess == 0.22 03:17:34 INFO - mozprofile == 0.28 03:17:34 INFO - mozrunner == 6.11 03:17:34 INFO - mozscreenshot == 0.1 03:17:34 INFO - mozsystemmonitor == 0.0 03:17:34 INFO - moztest == 0.7 03:17:34 INFO - mozversion == 1.4 03:17:34 INFO - psutil == 3.1.1 03:17:34 INFO - requests == 1.2.3 03:17:34 INFO - wsgiref == 0.1.2 03:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:34 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 03:17:34 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 03:17:34 INFO - Using env: {'DISPLAY': ':0', 03:17:34 INFO - 'HOME': '/home/cltbld', 03:17:34 INFO - 'LANG': 'en_US.UTF-8', 03:17:34 INFO - 'LANGUAGE': 'en_US:en', 03:17:34 INFO - 'LOGNAME': 'cltbld', 03:17:34 INFO - 'MAIL': '/var/mail/cltbld', 03:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:34 INFO - 'MOZ_NO_REMOTE': '1', 03:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:34 INFO - 'NO_EM_RESTART': '1', 03:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:34 INFO - 'PWD': '/builds/slave/test', 03:17:34 INFO - 'SHELL': '/bin/bash', 03:17:34 INFO - 'SHLVL': '1', 03:17:34 INFO - 'TERM': 'linux', 03:17:34 INFO - 'TMOUT': '86400', 03:17:34 INFO - 'USER': 'cltbld', 03:17:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:34 INFO - '_': '/tools/buildbot/bin/python'} 03:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 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)) 03:17:35 INFO - Cleaning up... 03:17:35 INFO - Return code: 0 03:17:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:35 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:35 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 03:17:35 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 03:17:35 INFO - Using env: {'DISPLAY': ':0', 03:17:35 INFO - 'HOME': '/home/cltbld', 03:17:35 INFO - 'LANG': 'en_US.UTF-8', 03:17:35 INFO - 'LANGUAGE': 'en_US:en', 03:17:35 INFO - 'LOGNAME': 'cltbld', 03:17:35 INFO - 'MAIL': '/var/mail/cltbld', 03:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:35 INFO - 'MOZ_NO_REMOTE': '1', 03:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:35 INFO - 'NO_EM_RESTART': '1', 03:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:35 INFO - 'PWD': '/builds/slave/test', 03:17:35 INFO - 'SHELL': '/bin/bash', 03:17:35 INFO - 'SHLVL': '1', 03:17:35 INFO - 'TERM': 'linux', 03:17:35 INFO - 'TMOUT': '86400', 03:17:35 INFO - 'USER': 'cltbld', 03:17:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:35 INFO - '_': '/tools/buildbot/bin/python'} 03:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:35 INFO - Downloading/unpacking jsonschema 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:37 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 03:17:37 INFO - Downloading/unpacking functools32 (from jsonschema) 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:37 INFO - warning: no files found matching '*.txt' 03:17:37 INFO - no previously-included directories found matching 'build' 03:17:37 INFO - no previously-included directories found matching 'dist' 03:17:37 INFO - no previously-included directories found matching '.git*' 03:17:37 INFO - Installing collected packages: jsonschema, functools32 03:17:37 INFO - Running setup.py install for functools32 03:17:37 INFO - warning: no files found matching '*.txt' 03:17:37 INFO - no previously-included directories found matching 'build' 03:17:37 INFO - no previously-included directories found matching 'dist' 03:17:37 INFO - no previously-included directories found matching '.git*' 03:17:37 INFO - Successfully installed jsonschema functools32 03:17:37 INFO - Cleaning up... 03:17:37 INFO - Return code: 0 03:17:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:37 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 0x7fbfd9579f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', '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 03:17:37 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 03:17:37 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 03:17:37 INFO - Using env: {'DISPLAY': ':0', 03:17:37 INFO - 'HOME': '/home/cltbld', 03:17:37 INFO - 'LANG': 'en_US.UTF-8', 03:17:37 INFO - 'LANGUAGE': 'en_US:en', 03:17:37 INFO - 'LOGNAME': 'cltbld', 03:17:37 INFO - 'MAIL': '/var/mail/cltbld', 03:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:37 INFO - 'MOZ_NO_REMOTE': '1', 03:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:37 INFO - 'NO_EM_RESTART': '1', 03:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:37 INFO - 'PWD': '/builds/slave/test', 03:17:37 INFO - 'SHELL': '/bin/bash', 03:17:37 INFO - 'SHLVL': '1', 03:17:37 INFO - 'TERM': 'linux', 03:17:37 INFO - 'TMOUT': '86400', 03:17:37 INFO - 'USER': 'cltbld', 03:17:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:37 INFO - '_': '/tools/buildbot/bin/python'} 03:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:37 INFO - Downloading/unpacking flake8 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:37 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 03:17:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:17:39 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 03:17:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:17:39 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 03:17:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:39 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 03:17:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:17:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:40 INFO - no previously-included directories found matching 'docs/_build' 03:17:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:17:40 INFO - Running setup.py install for pep8 03:17:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:17:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:17:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:17:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:17:40 INFO - no previously-included directories found matching 'docs/_build' 03:17:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:17:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:17:40 INFO - Cleaning up... 03:17:40 INFO - Return code: 0 03:17:40 INFO - Running post-action listener: _resource_record_post_action 03:17:40 INFO - Running post-action listener: _start_resource_monitoring 03:17:40 INFO - Starting resource monitoring. 03:17:40 INFO - ##### 03:17:40 INFO - ##### Running install step. 03:17:40 INFO - ##### 03:17:40 INFO - Running pre-action listener: _resource_record_pre_action 03:17:40 INFO - Running main action method: install 03:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:40 INFO - Reading from file tmpfile_stdout 03:17:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:40 INFO - Reading from file tmpfile_stdout 03:17:40 INFO - Output received: 03:17:40 INFO - Usage: mozinstall [options] installer 03:17:40 INFO - Options: 03:17:40 INFO - -h, --help show this help message and exit 03:17:40 INFO - -d DEST, --destination=DEST 03:17:40 INFO - Directory to install application into. [default: 03:17:40 INFO - "/builds/slave/test"] 03:17:40 INFO - --app=APP Application being installed. [default: firefox] 03:17:40 INFO - mkdir: /builds/slave/test/build/application 03:17:40 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'] 03:17:40 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 03:17:56 INFO - Reading from file tmpfile_stdout 03:17:56 INFO - Output received: 03:17:56 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:56 INFO - Running post-action listener: _resource_record_post_action 03:17:56 INFO - ##### 03:17:56 INFO - ##### Running run-tests step. 03:17:56 INFO - ##### 03:17:56 INFO - Running pre-action listener: _resource_record_pre_action 03:17:56 INFO - Running main action method: run_tests 03:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:56 INFO - Python 2.7.3 03:17:56 INFO - Return code: 0 03:17:56 INFO - grabbing minidump binary from tooltool 03:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:56 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 0x27df3d0>, '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 0x274aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274b360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:56 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 03:17:56 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 03:17:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:56 INFO - Return code: 0 03:17:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:17:57 INFO - Return code: 0 03:17:57 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:17:57 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:17:57 INFO - Using env: {'DISPLAY': ':0', 03:17:57 INFO - 'HOME': '/home/cltbld', 03:17:57 INFO - 'LANG': 'en_US.UTF-8', 03:17:57 INFO - 'LANGUAGE': 'en_US:en', 03:17:57 INFO - 'LOGNAME': 'cltbld', 03:17:57 INFO - 'MAIL': '/var/mail/cltbld', 03:17:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:57 INFO - 'MOZ_NO_REMOTE': '1', 03:17:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:57 INFO - 'NO_EM_RESTART': '1', 03:17:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:57 INFO - 'PWD': '/builds/slave/test', 03:17:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:57 INFO - 'SHELL': '/bin/bash', 03:17:57 INFO - 'SHLVL': '1', 03:17:57 INFO - 'TERM': 'linux', 03:17:57 INFO - 'TMOUT': '86400', 03:17:57 INFO - 'USER': 'cltbld', 03:17:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793', 03:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:57 INFO - '_': '/tools/buildbot/bin/python'} 03:17:57 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:17:57 INFO - mozversion application_buildid: 20160114025031 03:17:57 INFO - mozversion application_changeset: 3bf9a89c8f11184eac7fb4b145999dd92f6b17c2 03:17:57 INFO - mozversion application_display_name: Nightly 03:17:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:57 INFO - mozversion application_name: Firefox 03:17:57 INFO - mozversion application_remotingname: firefox 03:17:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:17:57 INFO - mozversion application_vendor: Mozilla 03:17:57 INFO - mozversion application_version: 46.0a1 03:17:57 INFO - mozversion platform_buildid: 20160114025031 03:17:57 INFO - mozversion platform_changeset: 3bf9a89c8f11184eac7fb4b145999dd92f6b17c2 03:17:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:17:57 INFO - mozversion platform_version: 46.0a1 03:17:57 INFO - using testdate: 1452770277 03:17:57 INFO - actual date: 1452770277 03:17:57 INFO - starting webserver on 'localhost:54748' 03:17:57 INFO - SUITE-START | Running 3 tests 03:17:57 INFO - TEST-START | dromaeo_css 03:17:57 INFO - operating with platform_type : linux_ 03:17:57 INFO - Initialising browser for dromaeo_css test... 03:17:57 INFO - TEST-INFO | started process 24324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnm6GPd/profile http://localhost:54748/getInfo.html) 03:18:01 INFO - PROCESS | 24324 | 03:18:01 INFO - PROCESS | 24324 | (process:24407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:18:02 INFO - PROCESS | 24324 | __metrics Screen width/height:1600/1200 03:18:02 INFO - PROCESS | 24324 | colorDepth:24 03:18:02 INFO - PROCESS | 24324 | Browser inner width/height: 1024/697 03:18:02 INFO - PROCESS | 24324 | __metrics 03:18:02 INFO - PROCESS | 24324 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:18:03 INFO - TEST-INFO | 24324: exit 0 03:18:03 INFO - Browser initialized. 03:18:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:03 INFO - TEST-INFO | started process 24456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnm6GPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:04 INFO - PROCESS | 24456 | 03:18:04 INFO - PROCESS | 24456 | (process:24513): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:18:15 INFO - PROCESS | 24456 | RSS: Main: 150822912 03:18:15 INFO - PROCESS | 24456 | 03:19:04 INFO - PROCESS | 24456 | 1452770344893 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] 03:21:15 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54748/tests/dromaeo/cssquery-ext.html) 03:21:17 INFO - PROCESS | 24456 | RSS: Main: 153772032 03:21:17 INFO - PROCESS | 24456 | 03:24:19 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-ext.html (next: http://localhost:54748/tests/dromaeo/cssquery-jquery.html) 03:24:19 INFO - PROCESS | 24456 | RSS: Main: 154595328 03:24:19 INFO - PROCESS | 24456 | 03:27:21 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54748/tests/dromaeo/cssquery-mootools.html) 03:27:22 INFO - PROCESS | 24456 | RSS: Main: 152526848 03:27:22 INFO - PROCESS | 24456 | 03:30:24 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54748/tests/dromaeo/cssquery-prototype.html) 03:30:24 INFO - PROCESS | 24456 | RSS: Main: 151216128 03:30:24 INFO - PROCESS | 24456 | 03:33:27 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54748/tests/dromaeo/cssquery-yui.html) 03:33:27 INFO - PROCESS | 24456 | RSS: Main: 150597632 03:33:27 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | Cycle 1(1): loaded http://localhost:54748/tests/dromaeo/cssquery-yui.html (next: http://localhost:54748/tests/dromaeo/cssquery-dojo.html) 03:36:30 INFO - PROCESS | 24456 | RSS: Main: 152309760 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | __start_tp_report 03:36:30 INFO - PROCESS | 24456 | _x_x_mozilla_page_load 03:36:30 INFO - PROCESS | 24456 | _x_x_mozilla_page_load_details 03:36:30 INFO - PROCESS | 24456 | |i|pagename|runs| 03:36:30 INFO - PROCESS | 24456 | |0;dojo.html;2526.911558095467;2557.514072326258;2562.4234547226874;2568.6532318137047;2585.806064545159;4241.448611680477;4314.590113939174;4345.1526952244285;4385.12297540492;4394.472663280403;4330.155619654169;4358.433403657528;4388.714733542325;4447.444069491314;4476.462824461069;4059.959400405995;4102.425660407545;4143.813528391214;4159.188958153161;4186.434831297782;4058;4086.2440448516973;4100.323446631317;4220.704550681454;4245.660347172235;3970.2456533258587;4055.452513910614;4187.036981494243;4205.85279515217;4213.97893010533;4021.5174179098694;4022.4368588397647;4026.939595906064;4091.304478238677;4110.897227569335;4053.530830859663;4054.4729185205733;4055.71609987301;4094.324436467979;4107.178564287155;4155.542890282067;4324.459442569679;4336.154449882274;4366.214081465335;4388.824447022115;4586.678932474728;4625.699329543569;4629.675922685414;4657.115148121846;4738.076075165344;4620.445546534404;4636.884077898046;4643.6517261205545;4672.509386514401;4709.71741695496;4220.831166753357;4309.784510774449;4330.372096046119;4331;4384.276594361926;4786.473487916326;4803.903921921542;4822.348982887335;4829.541193586604;4866.902661946812;4636.605888499448;4640.095181439587;4659.370984917061;4688.437387513521;4721.976390118096;4588.655850811202;4654.115718013567;4666.393368862026;4761.95238047622;4773.164696178224;4677.6959497633225;4692.085043416501;4698.389209402756;4711.411073615798;4713.929291060636;4636.907261854812;4637.698549594333;4650.930236046462;4662.184117779443;4700.2949557566635;3859.7877116758286;3919.9608003919598;3923.5684074751753;3931.8820435386983;3949.822257998397;3485.024193225901;3488.598811136701;3515.261795023023;3517.577890653138;3529.0647978285774;4100.466939297872;4124.8143833527565;4126.133511962462;4144.896377590584;4152.854650087293;4556.430446194226;4643.048175124091;4682.719036857799;4777.522247775264;4797.976010119927;4081.714280000431;4088.4276201331836;4089.5501494835544;4090.5295890972325;4128.690348223895;4172.645325147397;4173.83304667816;4198.832046718158;4205.957940420557;4222.387753775685;4318.676099292566;4387.780610969438;4435.711678740807;4458.375827384234;4514.751688657156;4688.34363189147;4711.366545313346;4727.550882666142;4728.290756386569;4783.449903261169;4319.503257125471;4487.708298960557;4490.595846373842;4497.1905057088725;4542.909141817079;4547.499775024811;4612.884677882946;4671.229247174314;4676.158291507561;4726.291056341576;4712.670113092187;4764.737939413366;4768.594669453136;4775.904481910412;4784.258439941815;4441.977790111029;4516.977415112903;4583.908321833612;4633.166030114612;4639.420072490939;4599.264117741279;4649.395578574764;4650.3257027730115;4653.092646933816;4687.203175460112;4450.354698568754;4489.281714925596;4508.278675411918;4509.481409637933;4515.6678779760705;4448.110377924493;4527.343535187445;4561.566651168134;4587.7017993830295;4597.172508948422;4515.096980603958;4543.341215523797;4545.045540436413;4557.248054071174;4569.520200378913 03:36:30 INFO - PROCESS | 24456 | |1;ext.html;500.3695343866729;501.5310684509983;504.6643981752135;526.4367127173924;540.4298465119302;30833.691663083362;31586.526202106987;31643.20891977702;31786.36427271453;31791.205219869516;34994.650053499456;35644.10889727758;35666.2866742665;35695.64304356956;35712.82143589279;7484.139323977731;7779.222077792204;7789.376849852027;7791.532508049507;7805.102413222467;7425.443091768112;7555.811104722371;7615;7615.048118985127;7642.694292228304;7747.6513556889795;7765.611719414035;7826.334761545276;7832.765017049469;7838.882416763753;7734.1492435832015;7783.649735761847;7792.688292468294;7820.0224971878515;7839.96080019602;7583.81040473987;7665.310122088983;7708.961455192688;7715.459917805756;7732.3040926316335;35556.82221588901;35904;35928.820355898315;35977.82011089928;36016.27967440663;2908.520094184457;2943.396603696237;2954.4681957247685;3145.653978062411;3355.630880603156;26264.606030909552;26423.207303780917;26466.867665661743;26492.470150597073;26702;3319;3398.2014226656715;3426.554547908781;3454.9481757773656;3502;212341;213385;215372.99999999843;216575;216734;46097.30854037192;46786.8534461209;54208;54304;54324.45675543273;58328;59309;59518;59582.40417595769;59582.40417595855;13666.11170273929;13668.316584170752;13857.653558661113;13911;13914.095583787224;10430.42632655196;10451.634192803216;10640.840387394195;10675.519601617945;10739.570417183382;18265.817341826678;18537.165827537792;18718.251269949324;18738.531536711693;18767.624647506975;7530.962345188239;7605.885911711329;7741.690332386754;7759.107702614158;7828.882566761503;825.4923222218292;834.8914641096619;891.3270480786964;892.9821403571892;953.3469573342283;23813.642795358082;23906.7609323908;24029.51940961206;24034.87982560111;24111.397215069763;940.7836197674574;976.3263348289657;1013.3109485549896;1034.131329683055;1042.6402891002592;12709.3130302803;12893.93553032229;12987.28569928663;13051.869481305255;13060.804087938499;295946;300742;301543;302086;303011;45831.5416845834;45983.77008115005;46018.539814602096;46162;46455.535444645124;1195.5636192789743;1216.4221994552693;1232.969175770613;1233.8519377674556;1239.0335538280335;23650.408739781644;26125.73874261233;26972.86513567498;27456.862715686293;27547.449051018466;39631.2073758529;41095.58904411037;41176.794116029225;41216.1756764869;41248.587514124476;191830;193339;193461;193767;194345;33655.495167573;36946;37200;37261.81369093137;37639.43540846944;33791;36885;37047.62952370442;39311.80344098376;40280.798596008004;28827.577246173198;31346.21634459157;31916.68083319137;32543.837280813445;32985.50521742224;30645.54031689571;31714.841425793646;31928.6807131935;32177.678223217466;32226.83886580552;31464.68535314709;31738.36523269568;31987.200319992186;32168;32258.83870580632;28725;29134.12597622075;29157.271068222617;29167.416651667274;29472.443854165525;22919.541609168056;22964.655530167394;23273.883630582415;23399.649005264593;23403.53192936166 03:36:30 INFO - PROCESS | 24456 | |2;jquery.html;323.70603938752436;324.388527625426;325.277883099519;325.50523204728813;329.70491410187884;14560.999999999987;14749.852501474981;14909.478168264113;15372.84627153728;15592;9946.552405141769;10144.594216231342;11296.209265351428;15087.170205638686;15208.16355100469;4496.999999999992;4561.543845615429;4668.043051174518;4674.088552732219;5011.323471331379;5058.772355244005;5126.615813730291;5126.769295381717;5141.948580514203;5158.200478925773;4610.538946105379;4707.7881495332795;4708.670393072486;5053.848384548451;5094.770735316901;4642.396488456496;4651.837185698484;4661.510541393156;4673;4686;4300.505441874193;4468.798904049326;4483.641308695329;4486.528914463967;4515.796789144463;11347.602833900857;11448.084153267719;11500.482478288413;16555;17958.371456998942;1723.8965662060316;1780.6972814621545;1826.6529359421668;1926.8940208288539;1964.7642282925997;8769.605367758466;8968.730938071869;9718.028197180296;9919.702408927744;12199.14605977582;1689.3749312754237;1695.6523912597888;1717.098523275278;1735.1844633022458;1761.8502427293695;45915;47497.28754068692;47657.76171119122;48224.51775482235;49141.017179656206;9136.862947055799;9219.953900230455;9418.152366287068;9527.142557169887;9537.332386733;10695.304805187794;11089.27919685218;12053.879461205452;12109.455074521491;12120.939395303143;6317.305096439388;6642;6653.933460665428;6670.4997125215805;6699.062131301622;6307.05394190875;6327.557071004985;6332.398422149889;6379.5215358847345;6390.616563006234;4106.193274959068;4110.876673699794;4122.113745544722;4147.3986271991;4181.874543763631;1694.1698567701737;1713.0492576620095;1754.2018381636324;1765.3291749135503;1788.6601545706535;782.2451334462271;821.9958900205461;826.9049059358131;954.0888451528773;971.5433746139303;14506.419743210365;14907.92546037263;15042.17268050246;15092.924535377253;15256.694866102838;370.0286747288368;377.8545260074836;381.3117323231538;388.65798097673866;402.6255582308423;4760.119377915097;4801.207800712913;4877.195262781673;5152.896942061137;8689.608967596474;440678;441728;444821;456015;479835;62865;64652.35347646463;64667;64791.35208647853;65647;442.2415557319213;446.88157638225897;451.2982312504088;451.8463722334422;452.07550559106704;9572.090651388107;9592.136707696342;9632.373895696757;9685.951570242103;9751.51242437861;23181.76818231796;23765.881170594035;28684.85657571699;30124.397512050076;30703.2324191897;35299;36987.81948881767;38382.23235535218;38458.61541384662;40383.79808100941;6205.782797602063;6305.716242769178;6505.251896032017;6718.361755633207;6882.311768823078;7369.8157546061775;9559.761005974628;9611.925723311018;9867.753306167404;9951.751206219902;7808;7998.560079195468;8089.47418417801;8145.633446494803;8631.6978905738;8409.495430274203;8418;8542.316614670686;8673.34949878749;8956.596953136994;8281.461704989157;8432.45189062709;8562.400631955703;8674.696385626472;8741.256993155654;6302.495800335871;6723;6997;7013.193482749549;7077.964610176916;8168.305694015838;8368.41421100517;8494.617742201492;8596.441231319945;8677.783055423664 03:36:30 INFO - PROCESS | 24456 | |3;mootools.html;1359.9864001359986;1371.0402718097334;1478.3051965576183;1674.2298542670371;1682.3775203174828;6036.517078633709;6134.325224225332;6776.695048722807;6907.4128699060575;6913.204981427138;6503.544751867371;6615.4376877965315;6622.768203112892;6635.336466353362;6657.234418041927;2043.9386818395471;2052.6305265052283;2071.730675012246;2073.813356797888;2077.2833372486543;2038.6534289170802;2056.2494689438395;2071.2129390831537;2108.1251280718484;2112.366290112968;2043.4789128772143;2066.2354928676336;2077.366403247009;2080.9063592138314;2088.6553718636405;2051.2820512820467;2054.5171884607107;2058.197303051811;2061.2785525066183;2067.462459760473;1989.3733473955658;2031.8577699561038;2069.2550681754556;2091.8117369436673;2093.926712565068;7248.166460857016;7284.380827629605;7323.157836848777;7343.926560734378;7347.118345798538;3887.358585833334;3983.601639836022;3988.823297127354;3994.580569040238;4003.559608443069;2534.518441496128;2549.8342607730438;2552.6553915221393;2609.178108895692;2620.646212761291;788.1881661888265;808.6159074439594;811.0551207842856;811.6996711216888;820.0733171516149;9596.136347728738;9610.711678649652;9633.08485693858;9633.662821801203;9642.566084526143;3603.351396748558;3618.149734812317;3650.7444478886755;3653.6163702811355;3659.5608526976935;8435.915640843636;8441.240288374076;8467.407281490237;8488;8491.320694344438;3986.202759448064;3997.360422332471;4002.3796311571755;4003.339448990942;4007.479027726435;3166.208447888028;3263.3147039121577;3527.065327688165;3584.9283014339567;3646.5988741238443;3240.9837950810097;3313.966860331414;3336.1659585103725;3394.3381040697323;3408.16499957512;965.7054598347431;1020.9795804083876;1025.8153532364097;1027.5838285494387;1031.2729525684374;1057.735566108473;1061.3790932304535;1070.539667942792;1072.7371793910386;1081.6646839479786;6645.534812563171;6693.732250709917;6697.832554186087;6700.329967003261;6746.730130794714;996.1184351848666;1028.3572767020612;1033.5142483033112;1035.9689209323733;1043.6242952537082;5015.448300686921;5054.115529782273;5066.873328166826;5070.884405430799;5072;8190.385721070944;8528.147185281423;8544.530050847263;8592.828143437222;8955.328350373748;8708.08565100668;8724.43291186071;8737.563121843883;8742.431741936754;8795.164459376478;6593.835154121185;6797.28628494001;6873.037774711544;6905.516613836983;6920.169579650374;6361.8727625448155;6407.935920640921;6431.742730290736;6463.57986730861;6465.321141280286;7188.460865435218;7523.887141692989;7577.583232922242;7715.652795624323;7733.574653394117;7493.175750667531;7613.238676132342;7621.847563048819;7662.923370766221;7714.305712485903;5255.527002569787;5354.250404943233;6202.317745048132;6347.714352854225;6356.5232607555545;6238.220222472191;6367.458766004941;6389.073584330339;6398.0402939559435;6401.967990160019;5967.37342579023;6155.753769849335;6162.815115546541;6283.434490895841;6552.148220731275;6101.816945491642;6372.394622510854;6424.967875160594;6454.709538070704;6487.578307410004;6294.874102517832;6320.336364681642;6321.431071203614;6337.588056776295;6348.619082855043;5883.764649413975;5898.144769008384;5912.172295878667;5916.053431450947;5920.644761314335;6009.909851352146;6012.729427175875;6029.306629737461;6029.457348838626;6045.395460453919 03:36:30 INFO - PROCESS | 24456 | |4;prototype.html;306.0558178020805;311.32442599558954;314.2285688634403;315.32048435621243;315.7710659771664;5454.645448045874;5578.63738856975;5581.49766521013;5596.664200147994;5601.607887447875;5488.588355873306;5489.1217405215175;5491.807786727465;5492.313460817398;5499.862503437416;4072.8370865165357;4163.167366526692;4241.0669652676515;4241.321388577828;4253.276942919696;4135.214309281227;4155.605217504332;4163.50037995441;4164.854230101947;4175.4363160973335;4126.195391898581;4133.379993001059;4137.81379837908;4156.085661154541;4159.3968874513175;4139.958600414003;4141.213169497786;4145.7719825409595;4158.958410415902;4172.332426811726;3550.55618047744;3606.1165014571334;3607.062163837395;3612.0789198754414;3625.782453052825;5150.253213284052;5229.215617657382;5246.265522826808;5316.973415132899;5321.733913304358;4794.544518270794;4802.807887684488;4806.375171227753;4821.63837712173;4832.565069143794;5719.542436605062;5767.452092051249;5774.82675519735;5787.565932555075;5788.5369170466265;3878.340682084024;3966.424868394067;3969.106950936045;3970.007498125469;3972.801359931992;5903.380145084747;5969.731362088716;5974.581779275452;6020.2775666919815;6026.54800889935;4051.655609273245;4056.634902858698;4061.7969101544804;4072.9389059164137;4076.8369265229653;4101.159262351211;4129.669626429878;4131.215069136854;4135.110951145518;4141.233871733679;4621.09888571732;4720.268358404453;4726.432828060655;4738.289256611536;4739.786709598076;5681.829545113653;5787.392323806024;5787.681677507778;5793.073108302651;5793.739281732248;1456.2354763749117;1478.9260536973109;1479.1273148842236;1480.5558332500207;1484.3394689363129;929.9814003720023;984.6799790068256;989.8713167288206;1007.5214273220162;1017.0947856407803;5032.245163225545;5033.823816166417;5050.292958985745;5054.721990290569;5054.949450505448;5990.580659353804;5996;5996.850078747979;5999.790007349722;6029.668368239789;4998.275250088789;5008.799648014112;5041.798328066836;5052.166392545262;5056.115179843586;3165.0504848545343;3216.5818443602648;3255.235019770352;3258.7067163955358;3271.656476070026;5719.313682358061;5720;5721.370649228582;5723.570732195102;5726.055200891807;6143.109249158936;6146.385361463817;6168.475679567287;6178.165947597017;6205.627662340274;5542.695151766691;5654.264945557051;5694.857628559319;5708.543316534668;5720.799772008043;5998;6006.729697163551;6007.549433792396;6009.338972712911;6015.849603759941;5857.209276747584;5860.29676438813;5869.559783016376;5884.08796636522;5888.617239879394;5649.887002260014;5652.745626446737;5667.574931880043;5715.799682066646;5719.083267533505;4019.397090436458;4065.3698676705158;4117.91764164709;4122.093139509303;4135.7932103394105;5893.351731309467;6006.909896351471;6014.518838492822;6017.879642407215;6018.428249316308;5831.650100993954;5862;5864.618799778001;5866.032104702676;5874.060150375919;5807.506361959112;5819.79630712923;5842.357340692605;5855.38518455556;5856.150858125633;5587.636803607915;5684.261046063985;5726.627769194989;5726.74229659658;5734.05388110957;5858.970705146447;5865.237519122486;5877.0302900022725;5877.794277200277;5878.470937615635;5689.431056894277;5715.799417224482;5720.971395142998;5734.569907257056;5741.110127930177 03:36:30 INFO - PROCESS | 24456 | |5;yui.html;735.9264073592641;736.0137415862743;762.5958242131669;770.6570576093637;775.7672698190541;11120.221584489089;11246.606368777095;11279.830802537968;11293.774124517515;11329.376884271362;11171.16216283778;11190;11208.15938804591;11232.32606043638;11248.662540123789;582.0657844160104;584.2463222443043;737.8524295140967;754.0348354106738;756.2210922749576;761.980950476237;762.4015148108736;765.678415065671;767.8886561448587;768.9807754806119;788.8816677498393;796.4146352430959;800.6637212370789;800.7037396163428;801.8676918308472;785.3363907498155;789.1556035042507;789.5144486141011;790.2650535002446;790.5967956342278;589.9262592175978;590.0294016343091;592.62960649594;592.9051351783737;594.6610432053731;11922.642320730392;12027.21823081497;12040.879591204151;12054.758904821854;12086;11006.614768483145;11225.494852731565;11631.127665425043;11961.282323060645;12099.637010889599;10407.531661075194;10506.632267870587;10663.680089597325;10693.732656683567;11037.0618497427;3169.41365847319;3178.4596618574665;3199.1842080269616;3264.951025734616;3265.1673823175174;39911.401328980086;40660.186796264206;40906.18187636261;40915.386269205985;40949.18101637951;8489.023762267294;8735.868961965576;8752.824943501222;8772.649094036167;8896.777580560409;15704;15711.057336559843;15738;15746.291416886268;15759.133247671489;6118.632882027093;6326.620402775849;6349.460295874902;6359.872802543923;6710.597364158166;3461.7057550108525;3515.05093624725;3551.4317709166407;3560.537130173061;3567.4113771227458;2509.560826855293;2549.847009179418;2550.145701190122;2552.0174732727664;2555.6933168019955;431.96328312093823;447.894744734987;450.9301058335963;451.80798160781535;471.27659043368266;537.3095572189717;571.3001573072952;610.8045425463808;619.5013014523352;637.7225906730587;7900.683972641145;7942.920570794218;8020.959895200486;8021.558814265155;8032.1164671886045;453.1865301783307;521.2546059135396;523.3405908555247;588.5821067042448;591.6331874238;3487.2676737885326;3495.7378196635354;3536.398812201932;3674.0998455378067;3911.8239679214503;40743.7962810184;41013.1797364051;41286.79356603198;41348.37977430341;41359.793201033805;37246;37920.0519986997;38166.42750358747;38228.80885595554;38406;34102.65897341044;34129.65870341265;34800.825995870364;35242.64757352394;35643.82178089145;7747.418943579141;8055.552803890916;8451.746447606582;8539.573021349031;8694.34792390586;30751.53872691956;31009.844950775103;31347.529787052757;31481;31558.368832623677;34686;35245.82377088098;38630.22739545249;38810.417843731804;38856.80571597124;10114.241431892491;10174.8473772892;10218.1825453965;10239.129673977795;10386.688399348031;11348;11523.250988685708;11569.132315076235;11765.470553824927;12232.816507752214;10869.51087201062;10888.346699198073;10927.508262128382;11049.558017679203;11485.885141148481;10572.376524814314;10598.650590865711;10801;10929.18031147683;11370.54517819311;9524.761880953032;9855.162311203629;10756.731081723019;11083.113350932068;11532.654020379403;8217;8411.70559030431;8555.272801811916;8591.6992905248;8735.956320218358;9045.728628141167;9263.16631503168;9386.249100072115;9442.858357124785;9459.95270023673 03:36:30 INFO - PROCESS | 24456 | __end_tp_report 03:36:30 INFO - PROCESS | 24456 | __start_cc_report 03:36:30 INFO - PROCESS | 24456 | _x_x_mozilla_cycle_collect,322 03:36:30 INFO - PROCESS | 24456 | __end_cc_report 03:36:30 INFO - PROCESS | 24456 | __startTimestamp1452771390681__endTimestamp 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | ------- Summary: start ------- 03:36:30 INFO - PROCESS | 24456 | Number of tests: 6 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#0] dojo.html Cycles:165 Average:4353.08 Median:4476.46 stddev:436.02 (9.7%) stddev-sans-first:413.15 03:36:30 INFO - PROCESS | 24456 | Values: 2526.9 2557.5 2562.4 2568.7 2585.8 4241.4 4314.6 4345.2 4385.1 4394.5 4330.2 4358.4 4388.7 4447.4 4476.5 4060.0 4102.4 4143.8 4159.2 4186.4 4058.0 4086.2 4100.3 4220.7 4245.7 3970.2 4055.5 4187.0 4205.9 4214.0 4021.5 4022.4 4026.9 4091.3 4110.9 4053.5 4054.5 4055.7 4094.3 4107.2 4155.5 4324.5 4336.2 4366.2 4388.8 4586.7 4625.7 4629.7 4657.1 4738.1 4620.4 4636.9 4643.7 4672.5 4709.7 4220.8 4309.8 4330.4 4331.0 4384.3 4786.5 4803.9 4822.3 4829.5 4866.9 4636.6 4640.1 4659.4 4688.4 4722.0 4588.7 4654.1 4666.4 4762.0 4773.2 4677.7 4692.1 4698.4 4711.4 4713.9 4636.9 4637.7 4650.9 4662.2 4700.3 3859.8 3920.0 3923.6 3931.9 3949.8 3485.0 3488.6 3515.3 3517.6 3529.1 4100.5 4124.8 4126.1 4144.9 4152.9 4556.4 4643.0 4682.7 4777.5 4798.0 4081.7 4088.4 4089.6 4090.5 4128.7 4172.6 4173.8 4198.8 4206.0 4222.4 4318.7 4387.8 4435.7 4458.4 4514.8 4688.3 4711.4 4727.6 4728.3 4783.4 4319.5 4487.7 4490.6 4497.2 4542.9 4547.5 4612.9 4671.2 4676.2 4726.3 4712.7 4764.7 4768.6 4775.9 4784.3 4442.0 4517.0 4583.9 4633.2 4639.4 4599.3 4649.4 4650.3 4653.1 4687.2 4450.4 4489.3 4508.3 4509.5 4515.7 4448.1 4527.3 4561.6 4587.7 4597.2 4515.1 4543.3 4545.0 4557.2 4569.5 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#1] ext.html Cycles:180 Average:39439.95 Median:32764.67 stddev:62930.61 (192.1%) stddev-sans-first:63039.23 03:36:30 INFO - PROCESS | 24456 | Values: 500.4 501.5 504.7 526.4 540.4 30833.7 31586.5 31643.2 31786.4 31791.2 34994.7 35644.1 35666.3 35695.6 35712.8 7484.1 7779.2 7789.4 7791.5 7805.1 7425.4 7555.8 7615.0 7615.0 7642.7 7747.7 7765.6 7826.3 7832.8 7838.9 7734.1 7783.6 7792.7 7820.0 7840.0 7583.8 7665.3 7709.0 7715.5 7732.3 35556.8 35904.0 35928.8 35977.8 36016.3 2908.5 2943.4 2954.5 3145.7 3355.6 26264.6 26423.2 26466.9 26492.5 26702.0 3319.0 3398.2 3426.6 3454.9 3502.0 212341.0 213385.0 215373.0 216575.0 216734.0 46097.3 46786.9 54208.0 54304.0 54324.5 58328.0 59309.0 59518.0 59582.4 59582.4 13666.1 13668.3 13857.7 13911.0 13914.1 10430.4 10451.6 10640.8 10675.5 10739.6 18265.8 18537.2 18718.3 18738.5 18767.6 7531.0 7605.9 7741.7 7759.1 7828.9 825.5 834.9 891.3 893.0 953.3 23813.6 23906.8 24029.5 24034.9 24111.4 940.8 976.3 1013.3 1034.1 1042.6 12709.3 12893.9 12987.3 13051.9 13060.8 295946.0 300742.0 301543.0 302086.0 303011.0 45831.5 45983.8 46018.5 46162.0 46455.5 1195.6 1216.4 1233.0 1233.9 1239.0 23650.4 26125.7 26972.9 27456.9 27547.4 39631.2 41095.6 41176.8 41216.2 41248.6 191830.0 193339.0 193461.0 193767.0 194345.0 33655.5 36946.0 37200.0 37261.8 37639.4 33791.0 36885.0 37047.6 39311.8 40280.8 28827.6 31346.2 31916.7 32543.8 32985.5 30645.5 31714.8 31928.7 32177.7 32226.8 31464.7 31738.4 31987.2 32168.0 32258.8 28725.0 29134.1 29157.3 29167.4 29472.4 22919.5 22964.7 23273.9 23399.6 23403.5 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#2] jquery.html Cycles:180 Average:23245.54 Median:4708.23 stddev:74029.68 (1572.3%) stddev-sans-first:74217.35 03:36:30 INFO - PROCESS | 24456 | Values: 323.7 324.4 325.3 325.5 329.7 14561.0 14749.9 14909.5 15372.8 15592.0 9946.6 10144.6 11296.2 15087.2 15208.2 4497.0 4561.5 4668.0 4674.1 5011.3 5058.8 5126.6 5126.8 5141.9 5158.2 4610.5 4707.8 4708.7 5053.8 5094.8 4642.4 4651.8 4661.5 4673.0 4686.0 4300.5 4468.8 4483.6 4486.5 4515.8 11347.6 11448.1 11500.5 16555.0 17958.4 1723.9 1780.7 1826.7 1926.9 1964.8 8769.6 8968.7 9718.0 9919.7 12199.1 1689.4 1695.7 1717.1 1735.2 1761.9 45915.0 47497.3 47657.8 48224.5 49141.0 9136.9 9220.0 9418.2 9527.1 9537.3 10695.3 11089.3 12053.9 12109.5 12120.9 6317.3 6642.0 6653.9 6670.5 6699.1 6307.1 6327.6 6332.4 6379.5 6390.6 4106.2 4110.9 4122.1 4147.4 4181.9 1694.2 1713.0 1754.2 1765.3 1788.7 782.2 822.0 826.9 954.1 971.5 14506.4 14907.9 15042.2 15092.9 15256.7 370.0 377.9 381.3 388.7 402.6 4760.1 4801.2 4877.2 5152.9 8689.6 440678.0 441728.0 444821.0 456015.0 479835.0 62865.0 64652.4 64667.0 64791.4 65647.0 442.2 446.9 451.3 451.8 452.1 9572.1 9592.1 9632.4 9686.0 9751.5 23181.8 23765.9 28684.9 30124.4 30703.2 35299.0 36987.8 38382.2 38458.6 40383.8 6205.8 6305.7 6505.3 6718.4 6882.3 7369.8 9559.8 9611.9 9867.8 9951.8 7808.0 7998.6 8089.5 8145.6 8631.7 8409.5 8418.0 8542.3 8673.3 8956.6 8281.5 8432.5 8562.4 8674.7 8741.3 6302.5 6723.0 6997.0 7013.2 7078.0 8168.3 8368.4 8494.6 8596.4 8677.8 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#3] mootools.html Cycles:180 Average:4884.83 Median:6040.96 stddev:2571.49 (42.6%) stddev-sans-first:2565.06 03:36:30 INFO - PROCESS | 24456 | Values: 1360.0 1371.0 1478.3 1674.2 1682.4 6036.5 6134.3 6776.7 6907.4 6913.2 6503.5 6615.4 6622.8 6635.3 6657.2 2043.9 2052.6 2071.7 2073.8 2077.3 2038.7 2056.2 2071.2 2108.1 2112.4 2043.5 2066.2 2077.4 2080.9 2088.7 2051.3 2054.5 2058.2 2061.3 2067.5 1989.4 2031.9 2069.3 2091.8 2093.9 7248.2 7284.4 7323.2 7343.9 7347.1 3887.4 3983.6 3988.8 3994.6 4003.6 2534.5 2549.8 2552.7 2609.2 2620.6 788.2 808.6 811.1 811.7 820.1 9596.1 9610.7 9633.1 9633.7 9642.6 3603.4 3618.1 3650.7 3653.6 3659.6 8435.9 8441.2 8467.4 8488.0 8491.3 3986.2 3997.4 4002.4 4003.3 4007.5 3166.2 3263.3 3527.1 3584.9 3646.6 3241.0 3314.0 3336.2 3394.3 3408.2 965.7 1021.0 1025.8 1027.6 1031.3 1057.7 1061.4 1070.5 1072.7 1081.7 6645.5 6693.7 6697.8 6700.3 6746.7 996.1 1028.4 1033.5 1036.0 1043.6 5015.4 5054.1 5066.9 5070.9 5072.0 8190.4 8528.1 8544.5 8592.8 8955.3 8708.1 8724.4 8737.6 8742.4 8795.2 6593.8 6797.3 6873.0 6905.5 6920.2 6361.9 6407.9 6431.7 6463.6 6465.3 7188.5 7523.9 7577.6 7715.7 7733.6 7493.2 7613.2 7621.8 7662.9 7714.3 5255.5 5354.3 6202.3 6347.7 6356.5 6238.2 6367.5 6389.1 6398.0 6402.0 5967.4 6155.8 6162.8 6283.4 6552.1 6101.8 6372.4 6425.0 6454.7 6487.6 6294.9 6320.3 6321.4 6337.6 6348.6 5883.8 5898.1 5912.2 5916.1 5920.6 6009.9 6012.7 6029.3 6029.5 6045.4 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#4] prototype.html Cycles:180 Average:4777.74 Median:5492.06 stddev:1426.51 (26.0%) stddev-sans-first:1390.47 03:36:30 INFO - PROCESS | 24456 | Values: 306.1 311.3 314.2 315.3 315.8 5454.6 5578.6 5581.5 5596.7 5601.6 5488.6 5489.1 5491.8 5492.3 5499.9 4072.8 4163.2 4241.1 4241.3 4253.3 4135.2 4155.6 4163.5 4164.9 4175.4 4126.2 4133.4 4137.8 4156.1 4159.4 4140.0 4141.2 4145.8 4159.0 4172.3 3550.6 3606.1 3607.1 3612.1 3625.8 5150.3 5229.2 5246.3 5317.0 5321.7 4794.5 4802.8 4806.4 4821.6 4832.6 5719.5 5767.5 5774.8 5787.6 5788.5 3878.3 3966.4 3969.1 3970.0 3972.8 5903.4 5969.7 5974.6 6020.3 6026.5 4051.7 4056.6 4061.8 4072.9 4076.8 4101.2 4129.7 4131.2 4135.1 4141.2 4621.1 4720.3 4726.4 4738.3 4739.8 5681.8 5787.4 5787.7 5793.1 5793.7 1456.2 1478.9 1479.1 1480.6 1484.3 930.0 984.7 989.9 1007.5 1017.1 5032.2 5033.8 5050.3 5054.7 5054.9 5990.6 5996.0 5996.9 5999.8 6029.7 4998.3 5008.8 5041.8 5052.2 5056.1 3165.1 3216.6 3255.2 3258.7 3271.7 5719.3 5720.0 5721.4 5723.6 5726.1 6143.1 6146.4 6168.5 6178.2 6205.6 5542.7 5654.3 5694.9 5708.5 5720.8 5998.0 6006.7 6007.5 6009.3 6015.8 5857.2 5860.3 5869.6 5884.1 5888.6 5649.9 5652.7 5667.6 5715.8 5719.1 4019.4 4065.4 4117.9 4122.1 4135.8 5893.4 6006.9 6014.5 6017.9 6018.4 5831.7 5862.0 5864.6 5866.0 5874.1 5807.5 5819.8 5842.4 5855.4 5856.2 5587.6 5684.3 5726.6 5726.7 5734.1 5859.0 5865.2 5877.0 5877.8 5878.5 5689.4 5715.8 5721.0 5734.6 5741.1 03:36:30 INFO - PROCESS | 24456 | 03:36:30 INFO - PROCESS | 24456 | [#5] yui.html Cycles:180 Average:11610.71 Median:38833.61 stddev:12344.46 (31.8%) stddev-sans-first:12352.08 03:36:30 INFO - PROCESS | 24456 | Values: 735.9 736.0 762.6 770.7 775.8 11120.2 11246.6 11279.8 11293.8 11329.4 11171.2 11190.0 11208.2 11232.3 11248.7 582.1 584.2 737.9 754.0 756.2 762.0 762.4 765.7 767.9 769.0 788.9 796.4 800.7 800.7 801.9 785.3 789.2 789.5 790.3 790.6 589.9 590.0 592.6 592.9 594.7 11922.6 12027.2 12040.9 12054.8 12086.0 11006.6 11225.5 11631.1 11961.3 12099.6 10407.5 10506.6 10663.7 10693.7 11037.1 3169.4 3178.5 3199.2 3265.0 3265.2 39911.4 40660.2 40906.2 40915.4 40949.2 8489.0 8735.9 8752.8 8772.6 8896.8 15704.0 15711.1 15738.0 15746.3 15759.1 6118.6 6326.6 6349.5 6359.9 6710.6 3461.7 3515.1 3551.4 3560.5 3567.4 2509.6 2549.8 2550.1 2552.0 2555.7 432.0 447.9 450.9 451.8 471.3 537.3 571.3 610.8 619.5 637.7 7900.7 7942.9 8021.0 8021.6 8032.1 453.2 521.3 523.3 588.6 591.6 3487.3 3495.7 3536.4 3674.1 3911.8 40743.8 41013.2 41286.8 41348.4 41359.8 37246.0 37920.1 38166.4 38228.8 38406.0 34102.7 34129.7 34800.8 35242.6 35643.8 7747.4 8055.6 8451.7 8539.6 8694.3 30751.5 31009.8 31347.5 31481.0 31558.4 34686.0 35245.8 38630.2 38810.4 38856.8 10114.2 10174.8 10218.2 10239.1 10386.7 11348.0 11523.3 11569.1 11765.5 12232.8 10869.5 10888.3 10927.5 11049.6 11485.9 10572.4 10598.7 10801.0 10929.2 11370.5 9524.8 9855.2 10756.7 11083.1 11532.7 8217.0 8411.7 8555.3 8591.7 8736.0 9045.7 9263.2 9386.2 9442.9 9460.0 03:36:30 INFO - PROCESS | 24456 | -------- Summary: end -------- 03:36:30 INFO - PROCESS | 24456 | 03:36:31 INFO - TEST-INFO | 24456: exit 0 03:36:31 INFO - TEST-OK | dromaeo_css | took 1113854ms 03:36:31 INFO - TEST-START | kraken 03:36:31 INFO - operating with platform_type : linux_ 03:36:31 INFO - Initialising browser for kraken test... 03:36:31 INFO - TEST-INFO | started process 24691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCHzBR5/profile http://localhost:54748/getInfo.html) 03:36:35 INFO - PROCESS | 24691 | 03:36:35 INFO - PROCESS | 24691 | (process:24762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:36:35 INFO - PROCESS | 24691 | __metrics Screen width/height:1600/1200 03:36:35 INFO - PROCESS | 24691 | colorDepth:24 03:36:35 INFO - PROCESS | 24691 | Browser inner width/height: 1024/697 03:36:35 INFO - PROCESS | 24691 | __metrics 03:36:36 INFO - PROCESS | 24691 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:36:36 INFO - TEST-INFO | 24691: exit 0 03:36:36 INFO - Browser initialized. 03:36:36 INFO - Running cycle 1/1 for kraken test... 03:36:36 INFO - TEST-INFO | started process 24811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCHzBR5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:38 INFO - PROCESS | 24811 | 03:36:38 INFO - PROCESS | 24811 | (process:24870): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:36:48 INFO - PROCESS | 24811 | RSS: Main: 151552000 03:36:48 INFO - PROCESS | 24811 | 03:36:51 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54748/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:52 INFO - PROCESS | 24811 | RSS: Main: 150347776 03:36:52 INFO - PROCESS | 24811 | 03:36:54 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54748/tests/kraken/driver.html?testName=audio-dft) 03:36:55 INFO - PROCESS | 24811 | RSS: Main: 154185728 03:36:55 INFO - PROCESS | 24811 | 03:36:58 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54748/tests/kraken/driver.html?testName=audio-fft) 03:36:59 INFO - PROCESS | 24811 | RSS: Main: 147591168 03:36:59 INFO - PROCESS | 24811 | 03:37:01 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54748/tests/kraken/driver.html?testName=audio-oscillator) 03:37:01 INFO - PROCESS | 24811 | RSS: Main: 148168704 03:37:01 INFO - PROCESS | 24811 | 03:37:04 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:04 INFO - PROCESS | 24811 | RSS: Main: 148590592 03:37:04 INFO - PROCESS | 24811 | 03:37:07 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54748/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:08 INFO - PROCESS | 24811 | RSS: Main: 149188608 03:37:08 INFO - PROCESS | 24811 | 03:37:11 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54748/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:12 INFO - PROCESS | 24811 | RSS: Main: 149225472 03:37:12 INFO - PROCESS | 24811 | 03:37:15 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54748/tests/kraken/driver.html?testName=json-parse-financial) 03:37:15 INFO - PROCESS | 24811 | RSS: Main: 151609344 03:37:15 INFO - PROCESS | 24811 | 03:37:17 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:18 INFO - PROCESS | 24811 | RSS: Main: 152117248 03:37:18 INFO - PROCESS | 24811 | 03:37:20 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:20 INFO - PROCESS | 24811 | RSS: Main: 151539712 03:37:20 INFO - PROCESS | 24811 | 03:37:22 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:23 INFO - PROCESS | 24811 | RSS: Main: 151584768 03:37:23 INFO - PROCESS | 24811 | 03:37:26 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:26 INFO - PROCESS | 24811 | RSS: Main: 151846912 03:37:26 INFO - PROCESS | 24811 | 03:37:29 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:29 INFO - PROCESS | 24811 | RSS: Main: 152436736 03:37:29 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | Cycle 1(1): loaded http://localhost:54748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54748/tests/kraken/driver.html?testName=ai-astar) 03:37:31 INFO - PROCESS | 24811 | RSS: Main: 150974464 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | __start_tp_report 03:37:31 INFO - PROCESS | 24811 | _x_x_mozilla_page_load 03:37:31 INFO - PROCESS | 24811 | _x_x_mozilla_page_load_details 03:37:31 INFO - PROCESS | 24811 | |i|pagename|runs| 03:37:31 INFO - PROCESS | 24811 | |0;ai-astar;114;108;116;115;116;127;114;114;118;113 03:37:31 INFO - PROCESS | 24811 | |1;audio-beat-detection;153;133;156;166;138;160;159;135;165;136 03:37:31 INFO - PROCESS | 24811 | |2;audio-dft;163;162;165;168;164;171;168;164;168;164 03:37:31 INFO - PROCESS | 24811 | |3;audio-fft;75;74;75;77;146;74;72;73;73;147 03:37:31 INFO - PROCESS | 24811 | |4;audio-oscillator;98;98;142;97;99;97;135;99;98;131 03:37:31 INFO - PROCESS | 24811 | |5;imaging-gaussian-blur;110;110;110;110;110;111;110;110;109;110 03:37:31 INFO - PROCESS | 24811 | |6;imaging-darkroom;148;150;147;150;148;149;148;147;150;148 03:37:31 INFO - PROCESS | 24811 | |7;imaging-desaturate;95;96;97;96;96;96;96;96;96;96 03:37:31 INFO - PROCESS | 24811 | |8;json-parse-financial;71;71;71;71;71;71;71;79;71;70 03:37:31 INFO - PROCESS | 24811 | |9;json-stringify-tinderbox;66;66;69;66;70;66;67;67;66;65 03:37:31 INFO - PROCESS | 24811 | |10;stanford-crypto-aes;85;92;87;85;93;84;87;86;85;84 03:37:31 INFO - PROCESS | 24811 | |11;stanford-crypto-ccm;123;125;124;129;124;123;122;124;124;122 03:37:31 INFO - PROCESS | 24811 | |12;stanford-crypto-pbkdf2;144;152;149;153;149;142;147;145;164;135 03:37:31 INFO - PROCESS | 24811 | |13;stanford-crypto-sha256-iterative;73;76;74;74;74;70;72;70;71;72 03:37:31 INFO - PROCESS | 24811 | __end_tp_report 03:37:31 INFO - PROCESS | 24811 | __start_cc_report 03:37:31 INFO - PROCESS | 24811 | _x_x_mozilla_cycle_collect,800 03:37:31 INFO - PROCESS | 24811 | __end_cc_report 03:37:31 INFO - PROCESS | 24811 | __startTimestamp1452771451910__endTimestamp 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | ------- Summary: start ------- 03:37:31 INFO - PROCESS | 24811 | Number of tests: 14 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.81 (4.2%) stddev-sans-first:5.07 03:37:31 INFO - PROCESS | 24811 | Values: 114.0 108.0 116.0 115.0 116.0 127.0 114.0 114.0 118.0 113.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.50 stddev:13.17 (8.4%) stddev-sans-first:13.93 03:37:31 INFO - PROCESS | 24811 | Values: 153.0 133.0 156.0 166.0 138.0 160.0 159.0 135.0 165.0 136.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.50 stddev:2.87 (1.7%) stddev-sans-first:2.87 03:37:31 INFO - PROCESS | 24811 | Values: 163.0 162.0 165.0 168.0 164.0 171.0 168.0 164.0 168.0 164.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#3] audio-fft Cycles:10 Average:88.60 Median:74.00 stddev:30.55 (41.3%) stddev-sans-first:32.00 03:37:31 INFO - PROCESS | 24811 | Values: 75.0 74.0 75.0 77.0 146.0 74.0 72.0 73.0 73.0 147.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:98.00 stddev:18.55 (18.9%) stddev-sans-first:19.22 03:37:31 INFO - PROCESS | 24811 | Values: 98.0 98.0 142.0 97.0 99.0 97.0 135.0 99.0 98.0 131.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:37:31 INFO - PROCESS | 24811 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.18 (0.8%) stddev-sans-first:1.24 03:37:31 INFO - PROCESS | 24811 | Values: 148.0 150.0 147.0 150.0 148.0 149.0 148.0 147.0 150.0 148.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 03:37:31 INFO - PROCESS | 24811 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:2.73 03:37:31 INFO - PROCESS | 24811 | Values: 71.0 71.0 71.0 71.0 71.0 71.0 71.0 79.0 71.0 70.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 03:37:31 INFO - PROCESS | 24811 | Values: 66.0 66.0 69.0 66.0 70.0 66.0 67.0 67.0 66.0 65.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.19 (3.7%) stddev-sans-first:3.32 03:37:31 INFO - PROCESS | 24811 | Values: 85.0 92.0 87.0 85.0 93.0 84.0 87.0 86.0 85.0 84.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:124.00 stddev:2.00 (1.6%) stddev-sans-first:2.09 03:37:31 INFO - PROCESS | 24811 | Values: 123.0 125.0 124.0 129.0 124.0 123.0 122.0 124.0 124.0 122.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.00 stddev:7.67 (5.2%) stddev-sans-first:8.00 03:37:31 INFO - PROCESS | 24811 | Values: 144.0 152.0 149.0 153.0 149.0 142.0 147.0 145.0 164.0 135.0 03:37:31 INFO - PROCESS | 24811 | 03:37:31 INFO - PROCESS | 24811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.50 stddev:1.96 (2.7%) stddev-sans-first:2.07 03:37:31 INFO - PROCESS | 24811 | Values: 73.0 76.0 74.0 74.0 74.0 70.0 72.0 70.0 71.0 72.0 03:37:31 INFO - PROCESS | 24811 | -------- Summary: end -------- 03:37:31 INFO - PROCESS | 24811 | 03:37:32 INFO - TEST-INFO | 24811: exit 0 03:37:32 INFO - TEST-OK | kraken | took 61461ms 03:37:32 INFO - TEST-START | v8_7 03:37:32 INFO - operating with platform_type : linux_ 03:37:32 INFO - Initialising browser for v8_7 test... 03:37:32 INFO - TEST-INFO | started process 25098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPWONvn/profile http://localhost:54748/getInfo.html) 03:37:36 INFO - PROCESS | 25098 | 03:37:36 INFO - PROCESS | 25098 | (process:25169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:37 INFO - PROCESS | 25098 | __metrics Screen width/height:1600/1200 03:37:37 INFO - PROCESS | 25098 | colorDepth:24 03:37:37 INFO - PROCESS | 25098 | Browser inner width/height: 1024/697 03:37:37 INFO - PROCESS | 25098 | __metrics 03:37:37 INFO - PROCESS | 25098 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:37:38 INFO - TEST-INFO | 25098: exit 0 03:37:38 INFO - Browser initialized. 03:37:38 INFO - Running cycle 1/1 for v8_7 test... 03:37:38 INFO - TEST-INFO | started process 25218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPWONvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:40 INFO - PROCESS | 25218 | 03:37:40 INFO - PROCESS | 25218 | (process:25274): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:37:50 INFO - PROCESS | 25218 | RSS: Main: 150151168 03:37:50 INFO - PROCESS | 25218 | 03:38:12 INFO - PROCESS | 25218 | Cycle 1(1): loaded http://localhost:54748/tests/v8_7/run.html (next: http://localhost:54748/tests/v8_7/run.html) 03:38:13 INFO - PROCESS | 25218 | RSS: Main: 145498112 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | __start_tp_report 03:38:13 INFO - PROCESS | 25218 | _x_x_mozilla_page_load 03:38:13 INFO - PROCESS | 25218 | _x_x_mozilla_page_load_details 03:38:13 INFO - PROCESS | 25218 | |i|pagename|runs| 03:38:13 INFO - PROCESS | 25218 | |0;Richards;169.34801016088062 03:38:13 INFO - PROCESS | 25218 | |1;DeltaBlue;187.79342723004694 03:38:13 INFO - PROCESS | 25218 | |2;Encrypt;277.1618625277162 03:38:13 INFO - PROCESS | 25218 | |3;Decrypt;5240.837696335078 03:38:13 INFO - PROCESS | 25218 | |4;RayTrace;1074.1138560687432 03:38:13 INFO - PROCESS | 25218 | |5;Earley;707.2135785007072 03:38:13 INFO - PROCESS | 25218 | |6;Boyer;12525 03:38:13 INFO - PROCESS | 25218 | |7;RegExp;42829.78723404255 03:38:13 INFO - PROCESS | 25218 | |8;Splay;658.3278472679394 03:38:13 INFO - PROCESS | 25218 | |9;NavierStokes;4840.579710144928 03:38:13 INFO - PROCESS | 25218 | __end_tp_report 03:38:13 INFO - PROCESS | 25218 | __startTimestamp1452771493148__endTimestamp 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | ------- Summary: start ------- 03:38:13 INFO - PROCESS | 25218 | Number of tests: 10 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#0] Richards Cycles:1 Average:169.35 Median:169.35 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 169.3 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 187.8 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#2] Encrypt Cycles:1 Average:277.16 Median:277.16 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 277.2 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 5240.8 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 1074.1 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#5] Earley Cycles:1 Average:707.21 Median:707.21 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 707.2 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 12525.0 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#7] RegExp Cycles:1 Average:42829.79 Median:42829.79 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 42829.8 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#8] Splay Cycles:1 Average:658.33 Median:658.33 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 658.3 03:38:13 INFO - PROCESS | 25218 | 03:38:13 INFO - PROCESS | 25218 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:38:13 INFO - PROCESS | 25218 | Values: 4840.6 03:38:13 INFO - PROCESS | 25218 | -------- Summary: end -------- 03:38:13 INFO - PROCESS | 25218 | 03:38:14 INFO - TEST-INFO | 25218: exit 0 03:38:14 INFO - TEST-OK | v8_7 | took 41207ms 03:38:14 INFO - SUITE-END | took 1216s 03:38:14 INFO - Completed test suite (00:20:16) 03:38:14 INFO - Working with test: dromaeo_css 03:38:14 INFO - Generating results file: dromaeo_css 03:38:14 INFO - Working with test: kraken 03:38:14 INFO - Generating results file: kraken 03:38:14 INFO - javascript benchmark 03:38:14 INFO - Working with test: v8_7 03:38:14 INFO - Generating results file: v8_7 03:38:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 03:38:14 INFO - process_Request line: dromaeo_css 5995.39 graph.html#tests=[[72,94,43]] 03:38:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:14 INFO - process_Request line: kraken 1553.70 graph.html#tests=[[232,94,43]] 03:38:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:14 INFO - process_Request line: v8_7 20062.83 graph.html#tests=[[230,94,43]] 03:38:14 INFO - RETURN: dromaeo_css: 5995.39 03:38:14 INFO - RETURN: kraken: 1553.70 03:38:14 INFO - RETURN: v8_7: 20062.83 03:38:14 INFO - javascript benchmark 03:38:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2526.911558095467, 2557.514072326258, 2562.4234547226874, 2568.6532318137047, 2585.806064545159, 4241.448611680477, 4314.590113939174, 4345.1526952244285, 4385.12297540492, 4394.472663280403, 4330.155619654169, 4358.433403657528, 4388.714733542325, 4447.444069491314, 4476.462824461069, 4059.959400405995, 4102.425660407545, 4143.813528391214, 4159.188958153161, 4186.434831297782, 4058.0, 4086.2440448516973, 4100.323446631317, 4220.704550681454, 4245.660347172235, 3970.2456533258587, 4055.452513910614, 4187.036981494243, 4205.85279515217, 4213.97893010533, 4021.5174179098694, 4022.4368588397647, 4026.939595906064, 4091.304478238677, 4110.897227569335, 4053.530830859663, 4054.4729185205733, 4055.71609987301, 4094.324436467979, 4107.178564287155, 4155.542890282067, 4324.459442569679, 4336.154449882274, 4366.214081465335, 4388.824447022115, 4586.678932474728, 4625.699329543569, 4629.675922685414, 4657.115148121846, 4738.076075165344, 4620.445546534404, 4636.884077898046, 4643.6517261205545, 4672.509386514401, 4709.71741695496, 4220.831166753357, 4309.784510774449, 4330.372096046119, 4331.0, 4384.276594361926, 4786.473487916326, 4803.903921921542, 4822.348982887335, 4829.541193586604, 4866.902661946812, 4636.605888499448, 4640.095181439587, 4659.370984917061, 4688.437387513521, 4721.976390118096, 4588.655850811202, 4654.115718013567, 4666.393368862026, 4761.95238047622, 4773.164696178224, 4677.6959497633225, 4692.085043416501, 4698.389209402756, 4711.411073615798, 4713.929291060636, 4636.907261854812, 4637.698549594333, 4650.930236046462, 4662.184117779443, 4700.2949557566635, 3859.7877116758286, 3919.9608003919598, 3923.5684074751753, 3931.8820435386983, 3949.822257998397, 3485.024193225901, 3488.598811136701, 3515.261795023023, 3517.577890653138, 3529.0647978285774, 4100.466939297872, 4124.8143833527565, 4126.133511962462, 4144.896377590584, 4152.854650087293, 4556.430446194226, 4643.048175124091, 4682.719036857799, 4777.522247775264, 4797.976010119927, 4081.714280000431, 4088.4276201331836, 4089.5501494835544, 4090.5295890972325, 4128.690348223895, 4172.645325147397, 4173.83304667816, 4198.832046718158, 4205.957940420557, 4222.387753775685, 4318.676099292566, 4387.780610969438, 4435.711678740807, 4458.375827384234, 4514.751688657156, 4688.34363189147, 4711.366545313346, 4727.550882666142, 4728.290756386569, 4783.449903261169, 4319.503257125471, 4487.708298960557, 4490.595846373842, 4497.1905057088725, 4542.909141817079, 4547.499775024811, 4612.884677882946, 4671.229247174314, 4676.158291507561, 4726.291056341576, 4712.670113092187, 4764.737939413366, 4768.594669453136, 4775.904481910412, 4784.258439941815, 4441.977790111029, 4516.977415112903, 4583.908321833612, 4633.166030114612, 4639.420072490939, 4599.264117741279, 4649.395578574764, 4650.3257027730115, 4653.092646933816, 4687.203175460112, 4450.354698568754, 4489.281714925596, 4508.278675411918, 4509.481409637933, 4515.6678779760705, 4448.110377924493, 4527.343535187445, 4561.566651168134, 4587.7017993830295, 4597.172508948422, 4515.096980603958, 4543.341215523797, 4545.045540436413, 4557.248054071174, 4569.520200378913], "unit": "score", "name": "dojo.html", "value": 4327.029109161229}, {"lowerIsBetter": false, "replicates": [500.3695343866729, 501.5310684509983, 504.6643981752135, 526.4367127173924, 540.4298465119302, 30833.691663083362, 31586.526202106987, 31643.20891977702, 31786.36427271453, 31791.205219869516, 34994.650053499456, 35644.10889727758, 35666.2866742665, 35695.64304356956, 35712.82143589279, 7484.139323977731, 7779.222077792204, 7789.376849852027, 7791.532508049507, 7805.102413222467, 7425.443091768112, 7555.811104722371, 7615.0, 7615.048118985127, 7642.694292228304, 7747.6513556889795, 7765.611719414035, 7826.334761545276, 7832.765017049469, 7838.882416763753, 7734.1492435832015, 7783.649735761847, 7792.688292468294, 7820.0224971878515, 7839.96080019602, 7583.81040473987, 7665.310122088983, 7708.961455192688, 7715.459917805756, 7732.3040926316335, 35556.82221588901, 35904.0, 35928.820355898315, 35977.82011089928, 36016.27967440663, 2908.520094184457, 2943.396603696237, 2954.4681957247685, 3145.653978062411, 3355.630880603156, 26264.606030909552, 26423.207303780917, 26466.867665661743, 26492.470150597073, 26702.0, 3319.0, 3398.2014226656715, 3426.554547908781, 3454.9481757773656, 3502.0, 212341.0, 213385.0, 215372.99999999843, 216575.0, 216734.0, 46097.30854037192, 46786.8534461209, 54208.0, 54304.0, 54324.45675543273, 58328.0, 59309.0, 59518.0, 59582.40417595769, 59582.40417595855, 13666.11170273929, 13668.316584170752, 13857.653558661113, 13911.0, 13914.095583787224, 10430.42632655196, 10451.634192803216, 10640.840387394195, 10675.519601617945, 10739.570417183382, 18265.817341826678, 18537.165827537792, 18718.251269949324, 18738.531536711693, 18767.624647506975, 7530.962345188239, 7605.885911711329, 7741.690332386754, 7759.107702614158, 7828.882566761503, 825.4923222218292, 834.8914641096619, 891.3270480786964, 892.9821403571892, 953.3469573342283, 23813.642795358082, 23906.7609323908, 24029.51940961206, 24034.87982560111, 24111.397215069763, 940.7836197674574, 976.3263348289657, 1013.3109485549896, 1034.131329683055, 1042.6402891002592, 12709.3130302803, 12893.93553032229, 12987.28569928663, 13051.869481305255, 13060.804087938499, 295946.0, 300742.0, 301543.0, 302086.0, 303011.0, 45831.5416845834, 45983.77008115005, 46018.539814602096, 46162.0, 46455.535444645124, 1195.5636192789743, 1216.4221994552693, 1232.969175770613, 1233.8519377674556, 1239.0335538280335, 23650.408739781644, 26125.73874261233, 26972.86513567498, 27456.862715686293, 27547.449051018466, 39631.2073758529, 41095.58904411037, 41176.794116029225, 41216.1756764869, 41248.587514124476, 191830.0, 193339.0, 193461.0, 193767.0, 194345.0, 33655.495167573, 36946.0, 37200.0, 37261.81369093137, 37639.43540846944, 33791.0, 36885.0, 37047.62952370442, 39311.80344098376, 40280.798596008004, 28827.577246173198, 31346.21634459157, 31916.68083319137, 32543.837280813445, 32985.50521742224, 30645.54031689571, 31714.841425793646, 31928.6807131935, 32177.678223217466, 32226.83886580552, 31464.68535314709, 31738.36523269568, 31987.200319992186, 32168.0, 32258.83870580632, 28725.0, 29134.12597622075, 29157.271068222617, 29167.416651667274, 29472.443854165525, 22919.541609168056, 22964.655530167394, 23273.883630582415, 23399.649005264593, 23403.53192936166], "unit": "score", "name": "ext.html", "value": 16455.031557932776}, {"lowerIsBetter": false, "replicates": [323.70603938752436, 324.388527625426, 325.277883099519, 325.50523204728813, 329.70491410187884, 14560.999999999987, 14749.852501474981, 14909.478168264113, 15372.84627153728, 15592.0, 9946.552405141769, 10144.594216231342, 11296.209265351428, 15087.170205638686, 15208.16355100469, 4496.999999999992, 4561.543845615429, 4668.043051174518, 4674.088552732219, 5011.323471331379, 5058.772355244005, 5126.615813730291, 5126.769295381717, 5141.948580514203, 5158.200478925773, 4610.538946105379, 4707.7881495332795, 4708.670393072486, 5053.848384548451, 5094.770735316901, 4642.396488456496, 4651.837185698484, 4661.510541393156, 4673.0, 4686.0, 4300.505441874193, 4468.798904049326, 4483.641308695329, 4486.528914463967, 4515.796789144463, 11347.602833900857, 11448.084153267719, 11500.482478288413, 16555.0, 17958.371456998942, 1723.8965662060316, 1780.6972814621545, 1826.6529359421668, 1926.8940208288539, 1964.7642282925997, 8769.605367758466, 8968.730938071869, 9718.028197180296, 9919.702408927744, 12199.14605977582, 1689.3749312754237, 1695.6523912597888, 1717.098523275278, 1735.1844633022458, 1761.8502427293695, 45915.0, 47497.28754068692, 47657.76171119122, 48224.51775482235, 49141.017179656206, 9136.862947055799, 9219.953900230455, 9418.152366287068, 9527.142557169887, 9537.332386733, 10695.304805187794, 11089.27919685218, 12053.879461205452, 12109.455074521491, 12120.939395303143, 6317.305096439388, 6642.0, 6653.933460665428, 6670.4997125215805, 6699.062131301622, 6307.05394190875, 6327.557071004985, 6332.398422149889, 6379.5215358847345, 6390.616563006234, 4106.193274959068, 4110.876673699794, 4122.113745544722, 4147.3986271991, 4181.874543763631, 1694.1698567701737, 1713.0492576620095, 1754.2018381636324, 1765.3291749135503, 1788.6601545706535, 782.2451334462271, 821.9958900205461, 826.9049059358131, 954.0888451528773, 971.5433746139303, 14506.419743210365, 14907.92546037263, 15042.17268050246, 15092.924535377253, 15256.694866102838, 370.0286747288368, 377.8545260074836, 381.3117323231538, 388.65798097673866, 402.6255582308423, 4760.119377915097, 4801.207800712913, 4877.195262781673, 5152.896942061137, 8689.608967596474, 440678.0, 441728.0, 444821.0, 456015.0, 479835.0, 62865.0, 64652.35347646463, 64667.0, 64791.35208647853, 65647.0, 442.2415557319213, 446.88157638225897, 451.2982312504088, 451.8463722334422, 452.07550559106704, 9572.090651388107, 9592.136707696342, 9632.373895696757, 9685.951570242103, 9751.51242437861, 23181.76818231796, 23765.881170594035, 28684.85657571699, 30124.397512050076, 30703.2324191897, 35299.0, 36987.81948881767, 38382.23235535218, 38458.61541384662, 40383.79808100941, 6205.782797602063, 6305.716242769178, 6505.251896032017, 6718.361755633207, 6882.311768823078, 7369.8157546061775, 9559.761005974628, 9611.925723311018, 9867.753306167404, 9951.751206219902, 7808.0, 7998.560079195468, 8089.47418417801, 8145.633446494803, 8631.6978905738, 8409.495430274203, 8418.0, 8542.316614670686, 8673.34949878749, 8956.596953136994, 8281.461704989157, 8432.45189062709, 8562.400631955703, 8674.696385626472, 8741.256993155654, 6302.495800335871, 6723.0, 6997.0, 7013.193482749549, 7077.964610176916, 8168.305694015838, 8368.41421100517, 8494.617742201492, 8596.441231319945, 8677.783055423664], "unit": "score", "name": "jquery.html", "value": 6763.215694015387}, {"lowerIsBetter": false, "replicates": [1359.9864001359986, 1371.0402718097334, 1478.3051965576183, 1674.2298542670371, 1682.3775203174828, 6036.517078633709, 6134.325224225332, 6776.695048722807, 6907.4128699060575, 6913.204981427138, 6503.544751867371, 6615.4376877965315, 6622.768203112892, 6635.336466353362, 6657.234418041927, 2043.9386818395471, 2052.6305265052283, 2071.730675012246, 2073.813356797888, 2077.2833372486543, 2038.6534289170802, 2056.2494689438395, 2071.2129390831537, 2108.1251280718484, 2112.366290112968, 2043.4789128772143, 2066.2354928676336, 2077.366403247009, 2080.9063592138314, 2088.6553718636405, 2051.2820512820467, 2054.5171884607107, 2058.197303051811, 2061.2785525066183, 2067.462459760473, 1989.3733473955658, 2031.8577699561038, 2069.2550681754556, 2091.8117369436673, 2093.926712565068, 7248.166460857016, 7284.380827629605, 7323.157836848777, 7343.926560734378, 7347.118345798538, 3887.358585833334, 3983.601639836022, 3988.823297127354, 3994.580569040238, 4003.559608443069, 2534.518441496128, 2549.8342607730438, 2552.6553915221393, 2609.178108895692, 2620.646212761291, 788.1881661888265, 808.6159074439594, 811.0551207842856, 811.6996711216888, 820.0733171516149, 9596.136347728738, 9610.711678649652, 9633.08485693858, 9633.662821801203, 9642.566084526143, 3603.351396748558, 3618.149734812317, 3650.7444478886755, 3653.6163702811355, 3659.5608526976935, 8435.915640843636, 8441.240288374076, 8467.407281490237, 8488.0, 8491.320694344438, 3986.202759448064, 3997.360422332471, 4002.3796311571755, 4003.339448990942, 4007.479027726435, 3166.208447888028, 3263.3147039121577, 3527.065327688165, 3584.9283014339567, 3646.5988741238443, 3240.9837950810097, 3313.966860331414, 3336.1659585103725, 3394.3381040697323, 3408.16499957512, 965.7054598347431, 1020.9795804083876, 1025.8153532364097, 1027.5838285494387, 1031.2729525684374, 1057.735566108473, 1061.3790932304535, 1070.539667942792, 1072.7371793910386, 1081.6646839479786, 6645.534812563171, 6693.732250709917, 6697.832554186087, 6700.329967003261, 6746.730130794714, 996.1184351848666, 1028.3572767020612, 1033.5142483033112, 1035.9689209323733, 1043.6242952537082, 5015.448300686921, 5054.115529782273, 5066.873328166826, 5070.884405430799, 5072.0, 8190.385721070944, 8528.147185281423, 8544.530050847263, 8592.828143437222, 8955.328350373748, 8708.08565100668, 8724.43291186071, 8737.563121843883, 8742.431741936754, 8795.164459376478, 6593.835154121185, 6797.28628494001, 6873.037774711544, 6905.516613836983, 6920.169579650374, 6361.8727625448155, 6407.935920640921, 6431.742730290736, 6463.57986730861, 6465.321141280286, 7188.460865435218, 7523.887141692989, 7577.583232922242, 7715.652795624323, 7733.574653394117, 7493.175750667531, 7613.238676132342, 7621.847563048819, 7662.923370766221, 7714.305712485903, 5255.527002569787, 5354.250404943233, 6202.317745048132, 6347.714352854225, 6356.5232607555545, 6238.220222472191, 6367.458766004941, 6389.073584330339, 6398.0402939559435, 6401.967990160019, 5967.37342579023, 6155.753769849335, 6162.815115546541, 6283.434490895841, 6552.148220731275, 6101.816945491642, 6372.394622510854, 6424.967875160594, 6454.709538070704, 6487.578307410004, 6294.874102517832, 6320.336364681642, 6321.431071203614, 6337.588056776295, 6348.619082855043, 5883.764649413975, 5898.144769008384, 5912.172295878667, 5916.053431450947, 5920.644761314335, 6009.909851352146, 6012.729427175875, 6029.306629737461, 6029.457348838626, 6045.395460453919], "unit": "score", "name": "mootools.html", "value": 4002.4594896873245}, {"lowerIsBetter": false, "replicates": [306.0558178020805, 311.32442599558954, 314.2285688634403, 315.32048435621243, 315.7710659771664, 5454.645448045874, 5578.63738856975, 5581.49766521013, 5596.664200147994, 5601.607887447875, 5488.588355873306, 5489.1217405215175, 5491.807786727465, 5492.313460817398, 5499.862503437416, 4072.8370865165357, 4163.167366526692, 4241.0669652676515, 4241.321388577828, 4253.276942919696, 4135.214309281227, 4155.605217504332, 4163.50037995441, 4164.854230101947, 4175.4363160973335, 4126.195391898581, 4133.379993001059, 4137.81379837908, 4156.085661154541, 4159.3968874513175, 4139.958600414003, 4141.213169497786, 4145.7719825409595, 4158.958410415902, 4172.332426811726, 3550.55618047744, 3606.1165014571334, 3607.062163837395, 3612.0789198754414, 3625.782453052825, 5150.253213284052, 5229.215617657382, 5246.265522826808, 5316.973415132899, 5321.733913304358, 4794.544518270794, 4802.807887684488, 4806.375171227753, 4821.63837712173, 4832.565069143794, 5719.542436605062, 5767.452092051249, 5774.82675519735, 5787.565932555075, 5788.5369170466265, 3878.340682084024, 3966.424868394067, 3969.106950936045, 3970.007498125469, 3972.801359931992, 5903.380145084747, 5969.731362088716, 5974.581779275452, 6020.2775666919815, 6026.54800889935, 4051.655609273245, 4056.634902858698, 4061.7969101544804, 4072.9389059164137, 4076.8369265229653, 4101.159262351211, 4129.669626429878, 4131.215069136854, 4135.110951145518, 4141.233871733679, 4621.09888571732, 4720.268358404453, 4726.432828060655, 4738.289256611536, 4739.786709598076, 5681.829545113653, 5787.392323806024, 5787.681677507778, 5793.073108302651, 5793.739281732248, 1456.2354763749117, 1478.9260536973109, 1479.1273148842236, 1480.5558332500207, 1484.3394689363129, 929.9814003720023, 984.6799790068256, 989.8713167288206, 1007.5214273220162, 1017.0947856407803, 5032.245163225545, 5033.823816166417, 5050.292958985745, 5054.721990290569, 5054.949450505448, 5990.580659353804, 5996.0, 5996.850078747979, 5999.790007349722, 6029.668368239789, 4998.275250088789, 5008.799648014112, 5041.798328066836, 5052.166392545262, 5056.115179843586, 3165.0504848545343, 3216.5818443602648, 3255.235019770352, 3258.7067163955358, 3271.656476070026, 5719.313682358061, 5720.0, 5721.370649228582, 5723.570732195102, 5726.055200891807, 6143.109249158936, 6146.385361463817, 6168.475679567287, 6178.165947597017, 6205.627662340274, 5542.695151766691, 5654.264945557051, 5694.857628559319, 5708.543316534668, 5720.799772008043, 5998.0, 6006.729697163551, 6007.549433792396, 6009.338972712911, 6015.849603759941, 5857.209276747584, 5860.29676438813, 5869.559783016376, 5884.08796636522, 5888.617239879394, 5649.887002260014, 5652.745626446737, 5667.574931880043, 5715.799682066646, 5719.083267533505, 4019.397090436458, 4065.3698676705158, 4117.91764164709, 4122.093139509303, 4135.7932103394105, 5893.351731309467, 6006.909896351471, 6014.518838492822, 6017.879642407215, 6018.428249316308, 5831.650100993954, 5862.0, 5864.618799778001, 5866.032104702676, 5874.060150375919, 5807.506361959112, 5819.79630712923, 5842.357340692605, 5855.38518455556, 5856.150858125633, 5587.636803607915, 5684.261046063985, 5726.627769194989, 5726.74229659658, 5734.05388110957, 5858.970705146447, 5865.237519122486, 5877.0302900022725, 5877.794277200277, 5878.470937615635, 5689.431056894277, 5715.799417224482, 5720.971395142998, 5734.569907257056, 5741.110127930177], "unit": "score", "name": "prototype.html", "value": 4318.9282314502025}, {"lowerIsBetter": false, "replicates": [735.9264073592641, 736.0137415862743, 762.5958242131669, 770.6570576093637, 775.7672698190541, 11120.221584489089, 11246.606368777095, 11279.830802537968, 11293.774124517515, 11329.376884271362, 11171.16216283778, 11190.0, 11208.15938804591, 11232.32606043638, 11248.662540123789, 582.0657844160104, 584.2463222443043, 737.8524295140967, 754.0348354106738, 756.2210922749576, 761.980950476237, 762.4015148108736, 765.678415065671, 767.8886561448587, 768.9807754806119, 788.8816677498393, 796.4146352430959, 800.6637212370789, 800.7037396163428, 801.8676918308472, 785.3363907498155, 789.1556035042507, 789.5144486141011, 790.2650535002446, 790.5967956342278, 589.9262592175978, 590.0294016343091, 592.62960649594, 592.9051351783737, 594.6610432053731, 11922.642320730392, 12027.21823081497, 12040.879591204151, 12054.758904821854, 12086.0, 11006.614768483145, 11225.494852731565, 11631.127665425043, 11961.282323060645, 12099.637010889599, 10407.531661075194, 10506.632267870587, 10663.680089597325, 10693.732656683567, 11037.0618497427, 3169.41365847319, 3178.4596618574665, 3199.1842080269616, 3264.951025734616, 3265.1673823175174, 39911.401328980086, 40660.186796264206, 40906.18187636261, 40915.386269205985, 40949.18101637951, 8489.023762267294, 8735.868961965576, 8752.824943501222, 8772.649094036167, 8896.777580560409, 15704.0, 15711.057336559843, 15738.0, 15746.291416886268, 15759.133247671489, 6118.632882027093, 6326.620402775849, 6349.460295874902, 6359.872802543923, 6710.597364158166, 3461.7057550108525, 3515.05093624725, 3551.4317709166407, 3560.537130173061, 3567.4113771227458, 2509.560826855293, 2549.847009179418, 2550.145701190122, 2552.0174732727664, 2555.6933168019955, 431.96328312093823, 447.894744734987, 450.9301058335963, 451.80798160781535, 471.27659043368266, 537.3095572189717, 571.3001573072952, 610.8045425463808, 619.5013014523352, 637.7225906730587, 7900.683972641145, 7942.920570794218, 8020.959895200486, 8021.558814265155, 8032.1164671886045, 453.1865301783307, 521.2546059135396, 523.3405908555247, 588.5821067042448, 591.6331874238, 3487.2676737885326, 3495.7378196635354, 3536.398812201932, 3674.0998455378067, 3911.8239679214503, 40743.7962810184, 41013.1797364051, 41286.79356603198, 41348.37977430341, 41359.793201033805, 37246.0, 37920.0519986997, 38166.42750358747, 38228.80885595554, 38406.0, 34102.65897341044, 34129.65870341265, 34800.825995870364, 35242.64757352394, 35643.82178089145, 7747.418943579141, 8055.552803890916, 8451.746447606582, 8539.573021349031, 8694.34792390586, 30751.53872691956, 31009.844950775103, 31347.529787052757, 31481.0, 31558.368832623677, 34686.0, 35245.82377088098, 38630.22739545249, 38810.417843731804, 38856.80571597124, 10114.241431892491, 10174.8473772892, 10218.1825453965, 10239.129673977795, 10386.688399348031, 11348.0, 11523.250988685708, 11569.132315076235, 11765.470553824927, 12232.816507752214, 10869.51087201062, 10888.346699198073, 10927.508262128382, 11049.558017679203, 11485.885141148481, 10572.376524814314, 10598.650590865711, 10801.0, 10929.18031147683, 11370.54517819311, 9524.761880953032, 9855.162311203629, 10756.731081723019, 11083.113350932068, 11532.654020379403, 8217.0, 8411.70559030431, 8555.272801811916, 8591.6992905248, 8735.956320218358, 9045.728628141167, 9263.16631503168, 9386.249100072115, 9442.858357124785, 9459.95270023673], "unit": "score", "name": "yui.html", "value": 5578.474118096789}], "name": "dromaeo_css", "value": 5995.387105905566}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 116.0, 115.0, 116.0, 127.0, 114.0, 114.0, 118.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 156.0, 166.0, 138.0, 160.0, 159.0, 135.0, 165.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 165.0, 168.0, 164.0, 171.0, 168.0, 164.0, 168.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.7}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 77.0, 146.0, 74.0, 72.0, 73.0, 73.0, 147.0], "unit": "score", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 142.0, 97.0, 99.0, 97.0, 135.0, 99.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 147.0, 150.0, 148.0, 149.0, 148.0, 147.0, 150.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 79.0, 71.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 69.0, 66.0, 70.0, 66.0, 67.0, 67.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 87.0, 85.0, 93.0, 84.0, 87.0, 86.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 124.0, 129.0, 124.0, 123.0, 122.0, 124.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [144.0, 152.0, 149.0, 153.0, 149.0, 142.0, 147.0, 145.0, 164.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 74.0, 74.0, 74.0, 70.0, 72.0, 70.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.6}], "name": "kraken", "value": 1553.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.34801016088062], "unit": "score", "name": "Richards", "value": 208.45830999999995}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [277.1618625277162], "unit": "score", "name": "Encrypt", "value": 960.3810479999997}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [707.2135785007072], "unit": "score", "name": "Earley", "value": 942.3786820000003}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [42829.78723404255], "unit": "score", "name": "RegExp", "value": 21.269893194237444}, {"lowerIsBetter": false, "replicates": [658.3278472679394], "unit": "score", "name": "Splay", "value": 123.78482899999993}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20062.82756725433}]} 03:38:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20062.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1553.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "5995.39"}}} 03:38:14 INFO - Return code: 0 03:38:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:38:14 INFO - # TBPL SUCCESS # 03:38:14 INFO - Running post-action listener: _resource_record_post_action 03:38:14 INFO - Running post-run listener: _resource_record_post_run 03:38:15 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 420454400; Read time: 0; Write time: 259432 03:38:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110170112; Read time: 0; Write time: 72320 03:38:15 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 310284288; Read time: 0; Write time: 187112 03:38:15 INFO - Running post-run listener: _upload_blobber_files 03:38:15 INFO - Blob upload gear active. 03:38:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:15 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 03:38:15 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'] 03:38:15 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 03:38:16 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:17 INFO - (blobuploader) - INFO - Done attempting. 03:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:17 INFO - (blobuploader) - INFO - Done attempting. 03:38:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:17 INFO - Return code: 0 03:38:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd3e3d817e719db877dd98787f10bf612b2c15956333037feb484bf74df69c5566d4dcfd8a9906e8c9084d6e7ece4a0ff2c53c13dd0da4a19d20615dcf198a9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2782e5cb803c99cc264f7c375e3f49455ccba1bb18dc3714172f7e7533c440e1066c84f4fac9b4461554d2e095de241937486b6d400f1eeabf3820ef6677dafa"} 03:38:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:17 INFO - Contents: 03:38:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd3e3d817e719db877dd98787f10bf612b2c15956333037feb484bf74df69c5566d4dcfd8a9906e8c9084d6e7ece4a0ff2c53c13dd0da4a19d20615dcf198a9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2782e5cb803c99cc264f7c375e3f49455ccba1bb18dc3714172f7e7533c440e1066c84f4fac9b4461554d2e095de241937486b6d400f1eeabf3820ef6677dafa"} 03:38:17 INFO - Copying logs to upload dir... 03:38:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.808511 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-14 03:38:17.398238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 03:38:17.402034) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd3e3d817e719db877dd98787f10bf612b2c15956333037feb484bf74df69c5566d4dcfd8a9906e8c9084d6e7ece4a0ff2c53c13dd0da4a19d20615dcf198a9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2782e5cb803c99cc264f7c375e3f49455ccba1bb18dc3714172f7e7533c440e1066c84f4fac9b4461554d2e095de241937486b6d400f1eeabf3820ef6677dafa"} build_url:https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011627 build_url: 'https://queue.taskcluster.net/v1/task/e1b0VBevR8e61VbP0WgBxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd3e3d817e719db877dd98787f10bf612b2c15956333037feb484bf74df69c5566d4dcfd8a9906e8c9084d6e7ece4a0ff2c53c13dd0da4a19d20615dcf198a9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2782e5cb803c99cc264f7c375e3f49455ccba1bb18dc3714172f7e7533c440e1066c84f4fac9b4461554d2e095de241937486b6d400f1eeabf3820ef6677dafa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 03:38:17.427257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:38:17.427576) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452768621.555533-1177232793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:38:17.512138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:38:17.512469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:38:17.512808) ========= ========= Total master_lag: 0.25 =========