builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1450873344.72 results: success (0) buildid: 20151223025830 builduid: 9b207523d8aa4cfcaa74616cd053bce0 revision: 5ed5f6f573597534d396a1e59298fd9c58a15ac9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.724135) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.724661) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.725060) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.762038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.762345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.776374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.776732) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.827772) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.828300) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.828906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:24.829420) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 04:22:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2015-12-23 04:22:25 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.025070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.025380) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019367 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.074853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.075211) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ed5f6f573597534d396a1e59298fd9c58a15ac9 --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 5ed5f6f573597534d396a1e59298fd9c58a15ac9 --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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 04:22:25,372 truncating revision to first 12 chars 2015-12-23 04:22:25,372 Setting DEBUG logging. 2015-12-23 04:22:25,372 attempt 1/10 2015-12-23 04:22:25,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ed5f6f57359?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 04:22:25,695 unpacking tar archive at: mozilla-central-5ed5f6f57359/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.704338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.704605) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.712614) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.712859) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 04:22:25.713241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-23 04:22:25.713516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:26 INFO - MultiFileLogger online at 20151223 04:22:26 in /builds/slave/test 04:22:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:26 INFO - {'append_to_log': False, 04:22:26 INFO - 'base_work_dir': '/builds/slave/test', 04:22:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:26 INFO - 'branch': 'Firefox-Non-PGO', 04:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:26 INFO - 'config_files': ('talos/linux_config.py',), 04:22:26 INFO - 'default_actions': ('clobber', 04:22:26 INFO - 'read-buildbot-config', 04:22:26 INFO - 'download-and-extract', 04:22:26 INFO - 'populate-webroot', 04:22:26 INFO - 'create-virtualenv', 04:22:26 INFO - 'install', 04:22:26 INFO - 'run-tests'), 04:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:26 INFO - 'download_minidump_stackwalk': True, 04:22:26 INFO - 'download_symbols': 'ondemand', 04:22:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:26 INFO - 'installer_path': 'installer.exe', 04:22:26 INFO - 'log_level': 'info', 04:22:26 INFO - 'log_name': 'talos', 04:22:26 INFO - 'log_to_console': True, 04:22:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:26 INFO - 'opt_config_files': (), 04:22:26 INFO - 'pip_index': False, 04:22:26 INFO - 'sps_profile': False, 04:22:26 INFO - 'sps_profile_interval': 0, 04:22:26 INFO - 'suite': 'dromaeojs', 04:22:26 INFO - 'system_bits': '64', 04:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:26 INFO - 'title': 'talos-linux64-ix-001', 04:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:26 INFO - 'use_talos_json': True, 04:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:26 INFO - 'work_dir': 'build'} 04:22:26 INFO - ##### 04:22:26 INFO - ##### Running clobber step. 04:22:26 INFO - ##### 04:22:26 INFO - Running pre-action listener: _resource_record_pre_action 04:22:26 INFO - Running main action method: clobber 04:22:26 INFO - rmtree: /builds/slave/test/build 04:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:26 INFO - Running post-action listener: _resource_record_post_action 04:22:26 INFO - ##### 04:22:26 INFO - ##### Running read-buildbot-config step. 04:22:26 INFO - ##### 04:22:26 INFO - Running pre-action listener: _resource_record_pre_action 04:22:26 INFO - Running main action method: read_buildbot_config 04:22:26 INFO - Using buildbot properties: 04:22:26 INFO - { 04:22:26 INFO - "project": "", 04:22:26 INFO - "product": "firefox", 04:22:26 INFO - "script_repo_revision": "production", 04:22:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:22:26 INFO - "repository": "", 04:22:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:22:26 INFO - "buildid": "20151223025830", 04:22:26 INFO - "pgo_build": "False", 04:22:26 INFO - "basedir": "/builds/slave/test", 04:22:26 INFO - "buildnumber": 416, 04:22:26 INFO - "slavename": "talos-linux64-ix-001", 04:22:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:22:26 INFO - "platform": "ubuntu64_hw", 04:22:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:22:26 INFO - "branch": "mozilla-central", 04:22:26 INFO - "repo_path": "mozilla-central", 04:22:26 INFO - "revision": "5ed5f6f573597534d396a1e59298fd9c58a15ac9", 04:22:26 INFO - "stage_platform": "linux64", 04:22:26 INFO - "builduid": "9b207523d8aa4cfcaa74616cd053bce0", 04:22:26 INFO - "slavebuilddir": "test" 04:22:26 INFO - } 04:22:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:22:26 INFO - Running post-action listener: _resource_record_post_action 04:22:26 INFO - ##### 04:22:26 INFO - ##### Running download-and-extract step. 04:22:26 INFO - ##### 04:22:26 INFO - Running pre-action listener: _resource_record_pre_action 04:22:26 INFO - Running main action method: download_and_extract 04:22:26 INFO - mkdir: /builds/slave/test/build/tests 04:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:26 INFO - https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/test_packages.json 04:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/test_packages.json 04:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:22:27 INFO - Downloaded 1302 bytes. 04:22:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:22:27 INFO - Using the following test package requirements: 04:22:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'jsshell-linux-x86_64.zip'], 04:22:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22: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')]} 04:22:27 INFO - https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:29 INFO - Downloaded 21926777 bytes. 04:22:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:22:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:22:30 INFO - Return code: 0 04:22:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:30 INFO - https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:34 INFO - Downloaded 21926777 bytes. 04:22:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:22:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:22:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:22:35 INFO - Return code: 0 04:22: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')]} 04:22:35 INFO - https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:22:36 INFO - Downloaded 11132277 bytes. 04:22:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:22:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:22:36 INFO - Return code: 0 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 INFO - https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:22:38 INFO - Downloaded 53350221 bytes. 04:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:38 INFO - mkdir: /builds/slave/test/properties 04:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:38 INFO - Contents: 04:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:22:38 INFO - Running post-action listener: _resource_record_post_action 04:22:38 INFO - Running post-action listener: set_extra_try_arguments 04:22:38 INFO - ##### 04:22:38 INFO - ##### Running populate-webroot step. 04:22:38 INFO - ##### 04:22:38 INFO - Running pre-action listener: _resource_record_pre_action 04:22:38 INFO - Running main action method: populate_webroot 04:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:38 INFO - '--tppagecycles', 04:22:38 INFO - '7'], 04:22:38 INFO - 'tests': ['tsvgm']}}, 04:22:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:22:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:22:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:22:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'tests': ['damp', 'tps']}, 04:22:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['damp', 'tps']}, 04:22:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:22:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:38 INFO - 'other': {'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'other_l64': {'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:22:38 INFO - 'ts_paint', 04:22:38 INFO - 'tpaint', 04:22:38 INFO - 'sessionrestore', 04:22:38 INFO - 'sessionrestore_no_auto_restore']}, 04:22:38 INFO - 'svgr': {'tests': ['tsvgx', 04:22:38 INFO - 'tsvgr_opacity', 04:22:38 INFO - 'tart', 04:22:38 INFO - 'tscrollx', 04:22:38 INFO - 'cart']}, 04:22:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['tsvgx', 04:22:38 INFO - 'tsvgr_opacity', 04:22:38 INFO - 'tart', 04:22:38 INFO - 'tscrollx', 04:22:38 INFO - 'cart']}, 04:22:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'tests': ['tp5o']}, 04:22:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'talos_options': ['--e10s'], 04:22:38 INFO - 'tests': ['tp5o']}, 04:22:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'talos_options': ['--xperf_path', 04:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:38 INFO - 'tests': ['tp5n']}, 04:22:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:38 INFO - 'talos_options': ['--e10s', 04:22:38 INFO - '--xperf_path', 04:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:38 INFO - 'tests': ['tp5n']}}, 04:22:38 INFO - 'talos.zip': {'path': '', 04:22:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:38 INFO - Running post-action listener: _resource_record_post_action 04:22:38 INFO - ##### 04:22:38 INFO - ##### Running create-virtualenv step. 04:22:38 INFO - ##### 04:22:38 INFO - Running pre-action listener: _resource_record_pre_action 04:22:38 INFO - Running main action method: create_virtualenv 04:22:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:38 INFO - Using real prefix '/usr' 04:22:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:41 INFO - Installing pip.................done. 04:22:41 INFO - Return code: 0 04:22:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:22:41 INFO - Using env: {'DISPLAY': ':0', 04:22:41 INFO - 'HOME': '/home/cltbld', 04:22:41 INFO - 'LANG': 'en_US.UTF-8', 04:22:41 INFO - 'LANGUAGE': 'en_US:en', 04:22:41 INFO - 'LOGNAME': 'cltbld', 04:22:41 INFO - 'MAIL': '/var/mail/cltbld', 04:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:41 INFO - 'MOZ_NO_REMOTE': '1', 04:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:41 INFO - 'NO_EM_RESTART': '1', 04:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:41 INFO - 'PWD': '/builds/slave/test', 04:22:41 INFO - 'SHELL': '/bin/bash', 04:22:41 INFO - 'SHLVL': '1', 04:22:41 INFO - 'TERM': 'linux', 04:22:41 INFO - 'TMOUT': '86400', 04:22:41 INFO - 'USER': 'cltbld', 04:22:41 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:41 INFO - '_': '/tools/buildbot/bin/python'} 04:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:22:41 INFO - Cleaning up... 04:22:41 INFO - Return code: 0 04:22:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:22:41 INFO - Using env: {'DISPLAY': ':0', 04:22:41 INFO - 'HOME': '/home/cltbld', 04:22:41 INFO - 'LANG': 'en_US.UTF-8', 04:22:41 INFO - 'LANGUAGE': 'en_US:en', 04:22:41 INFO - 'LOGNAME': 'cltbld', 04:22:41 INFO - 'MAIL': '/var/mail/cltbld', 04:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:41 INFO - 'MOZ_NO_REMOTE': '1', 04:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:41 INFO - 'NO_EM_RESTART': '1', 04:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:41 INFO - 'PWD': '/builds/slave/test', 04:22:41 INFO - 'SHELL': '/bin/bash', 04:22:41 INFO - 'SHLVL': '1', 04:22:41 INFO - 'TERM': 'linux', 04:22:41 INFO - 'TMOUT': '86400', 04:22:41 INFO - 'USER': 'cltbld', 04:22:41 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:41 INFO - '_': '/tools/buildbot/bin/python'} 04:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:41 INFO - Downloading/unpacking psutil>=0.7.1 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:22:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:43 INFO - Installing collected packages: psutil 04:22:43 INFO - Running setup.py install for psutil 04:22:43 INFO - building 'psutil._psutil_linux' extension 04:22:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:22:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:22:43 INFO - building 'psutil._psutil_posix' extension 04:22:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:22:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:22:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:43 INFO - Successfully installed psutil 04:22:43 INFO - Cleaning up... 04:22:43 INFO - Return code: 0 04:22:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:43 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 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:22:43 INFO - Using env: {'DISPLAY': ':0', 04:22:43 INFO - 'HOME': '/home/cltbld', 04:22:43 INFO - 'LANG': 'en_US.UTF-8', 04:22:43 INFO - 'LANGUAGE': 'en_US:en', 04:22:43 INFO - 'LOGNAME': 'cltbld', 04:22:43 INFO - 'MAIL': '/var/mail/cltbld', 04:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:43 INFO - 'MOZ_NO_REMOTE': '1', 04:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:43 INFO - 'NO_EM_RESTART': '1', 04:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:43 INFO - 'PWD': '/builds/slave/test', 04:22:43 INFO - 'SHELL': '/bin/bash', 04:22:43 INFO - 'SHLVL': '1', 04:22:43 INFO - 'TERM': 'linux', 04:22:43 INFO - 'TMOUT': '86400', 04:22:43 INFO - 'USER': 'cltbld', 04:22:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:43 INFO - '_': '/tools/buildbot/bin/python'} 04:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:22:45 INFO - Installing collected packages: mozsystemmonitor 04:22:45 INFO - Running setup.py install for mozsystemmonitor 04:22:45 INFO - Successfully installed mozsystemmonitor 04:22:45 INFO - Cleaning up... 04:22:45 INFO - Return code: 0 04:22:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:45 INFO - Using env: {'DISPLAY': ':0', 04:22:45 INFO - 'HOME': '/home/cltbld', 04:22:45 INFO - 'LANG': 'en_US.UTF-8', 04:22:45 INFO - 'LANGUAGE': 'en_US:en', 04:22:45 INFO - 'LOGNAME': 'cltbld', 04:22:45 INFO - 'MAIL': '/var/mail/cltbld', 04:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:45 INFO - 'MOZ_NO_REMOTE': '1', 04:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:45 INFO - 'NO_EM_RESTART': '1', 04:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:45 INFO - 'PWD': '/builds/slave/test', 04:22:45 INFO - 'SHELL': '/bin/bash', 04:22:45 INFO - 'SHLVL': '1', 04:22:45 INFO - 'TERM': 'linux', 04:22:45 INFO - 'TMOUT': '86400', 04:22:45 INFO - 'USER': 'cltbld', 04:22:45 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:45 INFO - '_': '/tools/buildbot/bin/python'} 04:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:48 INFO - Downloading docopt-0.6.1.tar.gz 04:22:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:48 INFO - Running setup.py install for blobuploader 04:22:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:48 INFO - Running setup.py install for requests 04:22:48 INFO - Running setup.py install for docopt 04:22:49 INFO - Successfully installed blobuploader requests docopt 04:22:49 INFO - Cleaning up... 04:22:49 INFO - Return code: 0 04:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:49 INFO - Using env: {'DISPLAY': ':0', 04:22:49 INFO - 'HOME': '/home/cltbld', 04:22:49 INFO - 'LANG': 'en_US.UTF-8', 04:22:49 INFO - 'LANGUAGE': 'en_US:en', 04:22:49 INFO - 'LOGNAME': 'cltbld', 04:22:49 INFO - 'MAIL': '/var/mail/cltbld', 04:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:49 INFO - 'MOZ_NO_REMOTE': '1', 04:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:49 INFO - 'NO_EM_RESTART': '1', 04:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:49 INFO - 'PWD': '/builds/slave/test', 04:22:49 INFO - 'SHELL': '/bin/bash', 04:22:49 INFO - 'SHLVL': '1', 04:22:49 INFO - 'TERM': 'linux', 04:22:49 INFO - 'TMOUT': '86400', 04:22:49 INFO - 'USER': 'cltbld', 04:22:49 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:49 INFO - '_': '/tools/buildbot/bin/python'} 04:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:49 INFO - Running setup.py (path:/tmp/pip-Z2E9MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:49 INFO - Running setup.py (path:/tmp/pip-4kzm4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:49 INFO - Running setup.py (path:/tmp/pip-MbhdQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:49 INFO - Running setup.py (path:/tmp/pip-L4VMyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:49 INFO - Running setup.py (path:/tmp/pip-LsdJsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:49 INFO - Running setup.py (path:/tmp/pip-ijeBy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:49 INFO - Running setup.py (path:/tmp/pip-Ftx9sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:49 INFO - Running setup.py (path:/tmp/pip-MbZsFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:49 INFO - Running setup.py (path:/tmp/pip-DNtTIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:49 INFO - Running setup.py (path:/tmp/pip-LKNAx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:50 INFO - Running setup.py (path:/tmp/pip-yusRBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:50 INFO - Running setup.py (path:/tmp/pip-5Qa68d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:50 INFO - Running setup.py (path:/tmp/pip-UGvLo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:50 INFO - Running setup.py (path:/tmp/pip-0j9k7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:50 INFO - Running setup.py (path:/tmp/pip-DQjPaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:50 INFO - Running setup.py (path:/tmp/pip-NGB8nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:50 INFO - Running setup.py (path:/tmp/pip-GOYWBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:50 INFO - Running setup.py install for manifestparser 04:22:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Running setup.py install for mozcrash 04:22:50 INFO - Running setup.py install for mozdebug 04:22:50 INFO - Running setup.py install for mozdevice 04:22:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Running setup.py install for mozfile 04:22:51 INFO - Running setup.py install for mozhttpd 04:22:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozinfo 04:22:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozInstall 04:22:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozleak 04:22:51 INFO - Running setup.py install for mozlog 04:22:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for moznetwork 04:22:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozprocess 04:22:51 INFO - Running setup.py install for mozprofile 04:22:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozrunner 04:22:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:51 INFO - Running setup.py install for mozscreenshot 04:22:52 INFO - Running setup.py install for moztest 04:22:52 INFO - Running setup.py install for mozversion 04:22:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:52 INFO - Cleaning up... 04:22:52 INFO - Return code: 0 04:22:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:52 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 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:52 INFO - Using env: {'DISPLAY': ':0', 04:22:52 INFO - 'HOME': '/home/cltbld', 04:22:52 INFO - 'LANG': 'en_US.UTF-8', 04:22:52 INFO - 'LANGUAGE': 'en_US:en', 04:22:52 INFO - 'LOGNAME': 'cltbld', 04:22:52 INFO - 'MAIL': '/var/mail/cltbld', 04:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:52 INFO - 'MOZ_NO_REMOTE': '1', 04:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:52 INFO - 'NO_EM_RESTART': '1', 04:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:52 INFO - 'PWD': '/builds/slave/test', 04:22:52 INFO - 'SHELL': '/bin/bash', 04:22:52 INFO - 'SHLVL': '1', 04:22:52 INFO - 'TERM': 'linux', 04:22:52 INFO - 'TMOUT': '86400', 04:22:52 INFO - 'USER': 'cltbld', 04:22:52 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:52 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:52 INFO - Running setup.py (path:/tmp/pip-APfz_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:52 INFO - Running setup.py (path:/tmp/pip-pQZcOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:52 INFO - Running setup.py (path:/tmp/pip-dFhbjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:52 INFO - Running setup.py (path:/tmp/pip-oeLbLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:52 INFO - Running setup.py (path:/tmp/pip-2OZG6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:52 INFO - Running setup.py (path:/tmp/pip-bvRS5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:52 INFO - Running setup.py (path:/tmp/pip-F6Mnt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:53 INFO - Running setup.py (path:/tmp/pip-jcIlfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:53 INFO - Running setup.py (path:/tmp/pip-AIdfFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:53 INFO - Running setup.py (path:/tmp/pip-a8bQNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:53 INFO - Running setup.py (path:/tmp/pip-gi2mER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:53 INFO - Running setup.py (path:/tmp/pip-YFuSpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:53 INFO - Running setup.py (path:/tmp/pip-hSR5hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:53 INFO - Running setup.py (path:/tmp/pip-CaDeHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:53 INFO - Running setup.py (path:/tmp/pip-hf64tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:53 INFO - Running setup.py (path:/tmp/pip-OBxInC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:53 INFO - Running setup.py (path:/tmp/pip-w0h4lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:55 INFO - Downloading blessings-1.5.1.tar.gz 04:22:55 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:55 INFO - Installing collected packages: blessings 04:22:55 INFO - Running setup.py install for blessings 04:22:55 INFO - Successfully installed blessings 04:22:55 INFO - Cleaning up... 04:22:55 INFO - Return code: 0 04:22:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:55 INFO - Reading from file tmpfile_stdout 04:22:55 INFO - Current package versions: 04:22:55 INFO - argparse == 1.2.1 04:22:55 INFO - blessings == 1.5.1 04:22:55 INFO - blobuploader == 1.2.4 04:22:55 INFO - docopt == 0.6.1 04:22:55 INFO - manifestparser == 1.1 04:22:55 INFO - mozInstall == 1.12 04:22:55 INFO - mozcrash == 0.16 04:22:55 INFO - mozdebug == 0.1 04:22:55 INFO - mozdevice == 0.47 04:22:55 INFO - mozfile == 1.2 04:22:55 INFO - mozhttpd == 0.7 04:22:55 INFO - mozinfo == 0.9 04:22:55 INFO - mozleak == 0.1 04:22:55 INFO - mozlog == 3.1 04:22:55 INFO - moznetwork == 0.27 04:22:55 INFO - mozprocess == 0.22 04:22:55 INFO - mozprofile == 0.28 04:22:55 INFO - mozrunner == 6.11 04:22:55 INFO - mozscreenshot == 0.1 04:22:55 INFO - mozsystemmonitor == 0.0 04:22:55 INFO - moztest == 0.7 04:22:55 INFO - mozversion == 1.4 04:22:55 INFO - psutil == 3.1.1 04:22:55 INFO - requests == 1.2.3 04:22:55 INFO - wsgiref == 0.1.2 04:22:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:55 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 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:55 INFO - Using env: {'DISPLAY': ':0', 04:22:55 INFO - 'HOME': '/home/cltbld', 04:22:55 INFO - 'LANG': 'en_US.UTF-8', 04:22:55 INFO - 'LANGUAGE': 'en_US:en', 04:22:55 INFO - 'LOGNAME': 'cltbld', 04:22:55 INFO - 'MAIL': '/var/mail/cltbld', 04:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:55 INFO - 'MOZ_NO_REMOTE': '1', 04:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:55 INFO - 'NO_EM_RESTART': '1', 04:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:55 INFO - 'PWD': '/builds/slave/test', 04:22:55 INFO - 'SHELL': '/bin/bash', 04:22:55 INFO - 'SHLVL': '1', 04:22:55 INFO - 'TERM': 'linux', 04:22:55 INFO - 'TMOUT': '86400', 04:22:55 INFO - 'USER': 'cltbld', 04:22:55 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:55 INFO - '_': '/tools/buildbot/bin/python'} 04:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:56 INFO - Cleaning up... 04:22:56 INFO - Return code: 0 04:22:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:22:56 INFO - Using env: {'DISPLAY': ':0', 04:22:56 INFO - 'HOME': '/home/cltbld', 04:22:56 INFO - 'LANG': 'en_US.UTF-8', 04:22:56 INFO - 'LANGUAGE': 'en_US:en', 04:22:56 INFO - 'LOGNAME': 'cltbld', 04:22:56 INFO - 'MAIL': '/var/mail/cltbld', 04:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:56 INFO - 'MOZ_NO_REMOTE': '1', 04:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:56 INFO - 'NO_EM_RESTART': '1', 04:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:56 INFO - 'PWD': '/builds/slave/test', 04:22:56 INFO - 'SHELL': '/bin/bash', 04:22:56 INFO - 'SHLVL': '1', 04:22:56 INFO - 'TERM': 'linux', 04:22:56 INFO - 'TMOUT': '86400', 04:22:56 INFO - 'USER': 'cltbld', 04:22:56 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:56 INFO - '_': '/tools/buildbot/bin/python'} 04:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:56 INFO - Downloading/unpacking jsonschema 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:22:57 INFO - Downloading/unpacking functools32 (from jsonschema) 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Installing collected packages: jsonschema, functools32 04:22:58 INFO - Running setup.py install for functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Successfully installed jsonschema functools32 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:58 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 0x7f8e5eaa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 INFO - Downloading/unpacking flake8 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:23:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:23:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:23:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:00 INFO - no previously-included directories found matching 'docs/_build' 04:23:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:01 INFO - Running setup.py install for pep8 04:23:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:01 INFO - no previously-included directories found matching 'docs/_build' 04:23:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:01 INFO - Cleaning up... 04:23:01 INFO - Return code: 0 04:23:01 INFO - Running post-action listener: _resource_record_post_action 04:23:01 INFO - Running post-action listener: _start_resource_monitoring 04:23:01 INFO - Starting resource monitoring. 04:23:01 INFO - ##### 04:23:01 INFO - ##### Running install step. 04:23:01 INFO - ##### 04:23:01 INFO - Running pre-action listener: _resource_record_pre_action 04:23:01 INFO - Running main action method: install 04:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:01 INFO - Reading from file tmpfile_stdout 04:23:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:01 INFO - Reading from file tmpfile_stdout 04:23:01 INFO - Output received: 04:23:01 INFO - Usage: mozinstall [options] installer 04:23:01 INFO - Options: 04:23:01 INFO - -h, --help show this help message and exit 04:23:01 INFO - -d DEST, --destination=DEST 04:23:01 INFO - Directory to install application into. [default: 04:23:01 INFO - "/builds/slave/test"] 04:23:01 INFO - --app=APP Application being installed. [default: firefox] 04:23:01 INFO - mkdir: /builds/slave/test/build/application 04:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:17 INFO - Reading from file tmpfile_stdout 04:23:17 INFO - Output received: 04:23:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:17 INFO - Running post-action listener: _resource_record_post_action 04:23:17 INFO - ##### 04:23:17 INFO - ##### Running run-tests step. 04:23:17 INFO - ##### 04:23:17 INFO - Running pre-action listener: _resource_record_pre_action 04:23:17 INFO - Running main action method: run_tests 04:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:17 INFO - Python 2.7.3 04:23:17 INFO - Return code: 0 04:23:17 INFO - grabbing minidump binary from tooltool 04:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:17 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 0x24be3d0>, '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 0x2429ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x242a360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:23:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:23:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:17 INFO - Return code: 0 04:23:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:18 INFO - Return code: 0 04:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:23:18 INFO - Using env: {'DISPLAY': ':0', 04:23:18 INFO - 'HOME': '/home/cltbld', 04:23:18 INFO - 'LANG': 'en_US.UTF-8', 04:23:18 INFO - 'LANGUAGE': 'en_US:en', 04:23:18 INFO - 'LOGNAME': 'cltbld', 04:23:18 INFO - 'MAIL': '/var/mail/cltbld', 04:23:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:18 INFO - 'MOZ_NO_REMOTE': '1', 04:23:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:18 INFO - 'NO_EM_RESTART': '1', 04:23:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:18 INFO - 'PWD': '/builds/slave/test', 04:23:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:18 INFO - 'SHELL': '/bin/bash', 04:23:18 INFO - 'SHLVL': '1', 04:23:18 INFO - 'TERM': 'linux', 04:23:18 INFO - 'TMOUT': '86400', 04:23:18 INFO - 'USER': 'cltbld', 04:23:18 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772', 04:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:18 INFO - '_': '/tools/buildbot/bin/python'} 04:23:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:23:18 INFO - mozversion application_buildid: 20151223025830 04:23:18 INFO - mozversion application_changeset: 5ed5f6f573597534d396a1e59298fd9c58a15ac9 04:23:18 INFO - mozversion application_display_name: Nightly 04:23:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:18 INFO - mozversion application_name: Firefox 04:23:18 INFO - mozversion application_remotingname: firefox 04:23:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:18 INFO - mozversion application_vendor: Mozilla 04:23:18 INFO - mozversion application_version: 46.0a1 04:23:18 INFO - mozversion platform_buildid: 20151223025830 04:23:18 INFO - mozversion platform_changeset: 5ed5f6f573597534d396a1e59298fd9c58a15ac9 04:23:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:18 INFO - mozversion platform_version: 46.0a1 04:23:18 INFO - using testdate: 1450873398 04:23:18 INFO - actual date: 1450873398 04:23:18 INFO - starting webserver on 'localhost:52412' 04:23:18 INFO - SUITE-START | Running 3 tests 04:23:18 INFO - TEST-START | dromaeo_css 04:23:18 INFO - operating with platform_type : linux_ 04:23:18 INFO - Initialising browser for dromaeo_css test... 04:23:18 INFO - TEST-INFO | started process 16869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6BKaj/profile http://localhost:52412/getInfo.html) 04:23:23 INFO - PROCESS | 16869 | __metrics Screen width/height:1600/1200 04:23:23 INFO - PROCESS | 16869 | colorDepth:24 04:23:23 INFO - PROCESS | 16869 | Browser inner width/height: 1024/697 04:23:23 INFO - PROCESS | 16869 | __metrics 04:23:23 INFO - PROCESS | 16869 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:23:23 INFO - PROCESS | 16869 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:23:23 ERROR - PROCESS | 16869 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:23:24 INFO - TEST-INFO | 16869: exit 0 04:23:24 INFO - Browser initialized. 04:23:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:24 INFO - TEST-INFO | started process 16962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6BKaj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:36 INFO - PROCESS | 16962 | RSS: Main: 149819392 04:23:36 INFO - PROCESS | 16962 | 04:24:27 INFO - PROCESS | 16962 | 1450873467667 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:26:39 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52412/tests/dromaeo/cssquery-ext.html) 04:26:40 INFO - PROCESS | 16962 | RSS: Main: 247484416 04:26:40 INFO - PROCESS | 16962 | 04:29:43 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-ext.html (next: http://localhost:52412/tests/dromaeo/cssquery-jquery.html) 04:29:43 INFO - PROCESS | 16962 | RSS: Main: 220811264 04:29:43 INFO - PROCESS | 16962 | 04:32:46 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52412/tests/dromaeo/cssquery-mootools.html) 04:32:46 INFO - PROCESS | 16962 | RSS: Main: 224722944 04:32:46 INFO - PROCESS | 16962 | 04:35:48 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52412/tests/dromaeo/cssquery-prototype.html) 04:35:49 INFO - PROCESS | 16962 | RSS: Main: 208900096 04:35:49 INFO - PROCESS | 16962 | 04:38:51 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52412/tests/dromaeo/cssquery-yui.html) 04:38:52 INFO - PROCESS | 16962 | RSS: Main: 210890752 04:38:52 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-yui.html (next: http://localhost:52412/tests/dromaeo/cssquery-dojo.html) 04:41:55 INFO - PROCESS | 16962 | RSS: Main: 271699968 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | __start_tp_report 04:41:55 INFO - PROCESS | 16962 | _x_x_mozilla_page_load 04:41:55 INFO - PROCESS | 16962 | _x_x_mozilla_page_load_details 04:41:55 INFO - PROCESS | 16962 | |i|pagename|runs| 04:41:55 INFO - PROCESS | 16962 | |0;dojo.html;2595.831270967387;2696.662917135358;2703.6079768433565;2713.2538551898224;2720.768734657554;4530.229860923642;4710.293455981605;4711.552402521764;4735.313379559966;4738.194506933821;4628.4677262114865;4633.397658304416;4759.452662943762;4762.7618619069;4782.306565547993;4296.269634162192;4297.05464797744;4336.176126535964;4379.299312110063;4385.758783266919;4337.9566204338025;4435.223835828717;4470.97764511177;4478.8880277992985;4509.4814096379005;4177.164567086595;4255.0426154115385;4294.334378171388;4394.055278115205;4457.442819647544;4376.190404775127;4378.496472905625;4383.189110014658;4391.055922976543;4413.051193993275;4345.044090300129;4349.978250108761;4355.891102722458;4357.150355680644;4391.275439552502;4445.8221671133115;4490.483594386655;4593.173228818811;4605.700629459075;4683.2975053741875;5071.771770270309;5087.542121209072;5090.465501122366;5095.872603184913;5108.335916330853;5082.644214904958;5082.720450375228;5110.66780659256;5112.872178195575;5135.512126347991;4558.111168322145;4573.336866154389;4669.34629151919;4673.299005149255;4716;5211.043257251536;5229.555487783581;5229.660072095302;5245.868853278698;5286.154215325606;5001.4998500149695;5010.073136469765;5011.1481048221885;5013.24801279811;5052.292679024939;4832.565069143794;4938.185199442124;5082.263071854561;5100.693958362436;5101.770420331094;4889;4910.337104490848;4940.950590494121;5040.445550989388;5059.97470012655;4974.7263900485095;5018.89962200754;5019.648624596243;5026.773795179226;5068.670536415195;4261.722988005769;4265.786710664454;4270.145970805851;4278.850240241577;4280.6789490788315;3586.4261718124976;3618.782873027574;3707.480952666629;3729.1422972716427;3732.272206919679;4384.868453946387;4409.470863496337;4413.8234470621455;4422.778861056934;4456.62118719906;5088.6946783193125;5094.541491265803;5096.592272618182;5110.105731497048;5121.769520371592;4196.9370459443135;4267.530571637118;4310.892227694333;4320.4599425071865;4352.303631418958;4474.351219073281;4478.955210447919;4488.820447182076;4498.460184777848;4503.369528266046;4763.095011947719;4775.6179505638775;4790.544898234732;4805.3512775774825;4832.395950506187;4791.448983366958;4904.558589726799;4928.285398617252;4939.851804445872;5089.6691715038405;4750.07373562152;4768.642351823696;4771.856844294677;4773.11697335994;4819.542143496362;4924.901501970012;4930.359053323045;4942.752862356796;4953.727544984917;4972.65191436596;4849.175640141255;4974.303597496426;4979.726115063561;5036.194208926554;5146.288666992523;4954.033963377107;4963.305137280856;4966.776495057803;4971.328870602422;5013.072581572421;4966.453690094015;4987.376577927759;4991.725455100004;4993.450720420823;5035.0685123252315;4644.396228490275;4724.929126063043;4743.691660042086;4754.168020596313;4852.611791056636;4987;4994.275830004702;4998.225275082368;5011.173156429149;5060.367454068241;4880.585150262267;4893.706377617212;4894.95105048945;4908.607311415007;4940.60475161979 04:41:55 INFO - PROCESS | 16962 | |1;ext.html;554.0944019617938;564.117156649843;572.4876235768984;579.8231539380489;592.4549414538625;26852.462950741;27425;32313.19217019573;32532.67467325326;32576.67423325766;35806;35952.64047359525;36118.277634447295;36193.27613447736;36268.81865590675;7041.119860017498;7175.928240717578;7725.652345644446;7868.213178682143;7912.20877912207;10095.596176152945;10295.485225738683;10326.173906087495;10330.328528645652;10342.224333175005;10121.898781012169;10247.180225581973;10249.436281004542;10250.436226007567;10252.794944101113;7321.487495875317;7495.700171993114;10076.345037572535;10265.384076955332;10514.053735163796;9937.602495900155;9999.550020249033;10019.44893030883;10024.097831195228;10028.298019138663;36385.45421818675;36832.63167368319;36878;36979.44530832013;37158;2870.512012957802;2939.5590661400747;2945.7054294570585;3158.8262645554487;3470.9652903470896;28285;28290.858545707346;28448.573271400946;28590.571141432894;29027.709722902924;3322.6345102039;3403.6256011838677;3450.994392134117;3465.081753335368;3605.441156620728;209184;209853;211489.99999999846;211585;211998;51708;55386.72306638441;55714.442855570924;55762;55766;46583;65183.34816651868;66646.33353666498;66661.6666916672;66753.66623166853;14784.852151478348;15056.623584410478;15066;15068.623284417978;15069.171195584348;11340.149488788209;11424.257423267461;11428.599998999995;11431.657050288504;11432.542698291974;19137.2345106197;19376.806231937782;19445.805541944683;19449.708254376197;19466.31867884617;7541.509801862861;7688.693391982383;7823.139454659983;7842.254985776342;7865.528068315919;788.6529926832291;807.3863863463692;939.9342046056847;946.5172761891484;980.0297705271872;26706.732932670424;26709.332266693487;26850.5972410414;26949.730502695114;26993.460130797666;909.7952960583816;934.9672761453317;941.2140862379989;959.098447459386;1073.4257172412879;13860.514881979083;14007.439702411993;14161.504347347793;14185.503507377398;14375.353109109907;244746;245620;246812;246937;247151;45312;45797.77101114473;45940.54059459429;45971.77014114975;45998;1131.0838221040983;1156.67613068341;1173.7711146326385;1179.3218899132862;1180.8819118088122;25383.492330153662;26333.473330533667;26553.33616659599;26751.598726019514;26780.866095669397;36064.73773417918;45285.77357113193;46690.766546167055;46692.06615867731;46710.299345510524;169767;225521;231827;231828;232130;34336.141596460286;35111.82444087763;35160.47259291164;35250;35300;41148.382774257814;41435.7928210357;41464.585354146075;41806;42245.1550968985;35320.646793531734;35478.8226058868;35665.82167089148;35988.64011359853;36264;35226.11934701653;35686;35757.82121089378;35857;36170.63829361673;34607.4808877862;35055.64944350524;35315.11712207215;35386.46920296146;35479;30853.69146308508;32248.193795155308;32810.835945820116;32927.341453170324;32932.83533582317;24438.51122977495;24636.38409039788;24666.63000054965;25001.749982499943;25118.3720406984 04:41:55 INFO - PROCESS | 16962 | |2;jquery.html;326.9722073623742;328.79778935954397;332.14804027669044;333.1438203816192;334.4281279012888;12426.378681065933;12728.809067863966;14404.495842645509;14874.330655120519;14918.328675209614;10473.371597704143;10875.564977400894;10890.074343680797;14854.405823767063;15252.771208431883;4612.700174488664;4656.9534304656945;4784.091022705675;4800.927986080212;4803.879903002418;3563.1626567756557;3643.271345730851;3646.1613828819386;3649.215418684982;4675.766211689419;3638.5815631202354;3645.4167333226687;5128.102582048126;5294.814681486148;5298.682079075248;5154.819581314673;5253.60597955153;5272.393674727417;5300.469953004707;5311.256424100629;5079.6952182869145;5120.539151476348;5130.256112863651;5135.306733590992;5135.897282054338;11368.090552755759;14981.550553483414;18372.356967506206;18855.151518181716;19097.904510477496;1792.829681180286;1807.3493542324752;1810.8551315894697;1839.7424360589528;1899.3352326685688;9071;9325.90674093264;9337.579808908615;11316.490757915913;12485.063620228428;1733.419304532983;1754.429810311654;1787.731840223964;1789.4899953513316;1826.2147276671026;51281.48718512805;53627;53639.463605364224;53882;54441.1833822493;9784.657536986171;9817.969113243149;9840.852387214198;9854.458004809805;9902.207823374112;12437.378131093408;12513.311767852674;12531.373431328397;12531.812022819666;12556.183848049848;7070.434365250768;7132.679029443688;7154;7188.640567971581;7222.711091556279;6898.482613803984;6908.3091690830515;6913.827154321081;6973;6984.476164287698;4158.91682166361;4169.499660040815;4172.70791044624;4178.623923846869;4206.0956894267265;1601.223406647775;1651.175451126512;1675.1373042882924;1730.4895055958523;1737.4961261234353;902.4359775140537;904.8733177355175;928.6192661008954;937.8792343150006;949.6248981652209;14653.560393188221;15717;16042.839571604369;16102.114383708775;16190.433334833224;727.8617062758059;777.0558771093149;816.4896939412866;862.4351050062219;919.6275508419101;5356.678599284055;8546.957265213758;8598.097199794056;8722.781930451663;8992.685256016008;298217;301919;302642;303321;449708;66916;71787;74211.62894185602;74279;74363;1060.1359891688248;1060.5863713151878;1060.9946950265353;1094.5457635081511;1096.2381145104237;14411.135331879701;14490.927545362205;14494.202818844644;14662.633434163805;14938.626534336729;31449.37101258008;31882.52176217312;32297.192570184994;32408.67591324151;33241.83379083089;40631;41954;42934.78532607317;44929.55070449254;45942.08115837731;8577;8837.20465158113;8896.332775042027;8959.865602016105;8968.865467018131;10281.331713438603;13412.93293533526;16209.189540522691;16276.837231627533;16405;13393.933030334785;13570.389332479865;13636.454541818217;13903.165810051429;13983.370748316554;12971.610851674464;13060.281684507443;13502.594922152352;13679.110857794212;13687;10685.51915163804;13494.595162145151;13577.253251071286;13711;13927.512537061155;7824;8437.789055273668;8797.692080777142;8851.734447966572;8970.41692289999;12550.30973296441;12637.2417654941;12681.80977285323;13000.154989925624;13002.739945201232 04:41:55 INFO - PROCESS | 16962 | |3;mootools.html;1408.042531078866;1428.3429622373708;1436.367998080845;1601.327442474161;1677.1698009485306;5712.628679135859;6898.965505172473;7069.540479868805;7079.185893622235;7079.681414336361;6920.100386949702;7109;7112.608806515639;7113;7125.536840105389;2051.6101940631306;2104.6737755647823;2105.431533485958;2105.7894210578975;2107.1676687708346;2050.097956898967;2087.4572611121066;2091.7594476635154;2092.3513710749717;2094.581083783242;1991.412533302672;2005.4384772263716;2022.2618744158349;2031.8882461464614;2033.3391647714552;2076.636588596997;2100.6953991671276;2101.432613194444;2102.9789702102935;2103.6739305407687;2024.4129202531249;2054.1783286685295;2058.958820823575;2063.587282543482;2066.0909199951975;6970.686319115652;7051.1186101737285;7068.717251309941;7073.186583542907;7075.150981882156;4058.1072164123843;4140.710150289481;4167.74993500391;4169.207850508394;4170.645495132917;2747.2994386431333;2755.7106503817213;2785.2062162283855;2798.2164993801766;2815.7184281571886;933.9252859771202;1673.7824082869272;1679.8572121369698;1681.840225178606;1682.3607029328898;9451.574679139387;9606.90393096067;9651;9662.710118696381;9668;3825.5218097737784;3865.342891708416;3886.9611303887164;3923.2545816294814;3926.332523471017;7719.575423351657;7723.884141737878;7724.073111226577;7736.7678969631;7737.419693523008;4251.489821221411;4254.191703576311;4257.8509752158525;4271.423357846713;4288.270993931039;3301.0756988043386;3367.5958884933475;3714.7771133732062;3951.1702542466405;3959.40608908666;3198.792078514889;3198.9680103199134;3247.723943464832;3252.3332716793;3261.6575259597876;937.329809186435;963.3786207896007;970.2529052629577;977.5112443778111;979.7158823940978;899.4648184330313;912.9954350228206;914.9176574108362;916.2532535983153;1131.095123900876;6718.160229971254;6728.192616886005;6729.596224226562;6755.831104222336;6757.459403247728;431.4994606256727;432.83119583362515;443.3726277317624;445.8305843779408;450.4279564952492;5212.348456442945;5284.603654725834;5287.524122828964;5288.65623734456;5294.100002999499;8045.678172873137;8086.070101938235;8261.958690206511;8314.41799074059;8328.125546817619;8109.310708589718;8187.345012398994;8189.50862948225;8202.794930126794;8205.671773129128;6420.454261387835;6511.772087976898;6522.086907832907;6546.214454265519;6546.738130474823;6302.180716506825;6306.873862522815;6311.116443697978;6322.715477803602;6325.7153428094925;7268.563886166847;7291.05216321896;7347.742829000959;7415.295546923034;7418.629068546659;7448.590327532038;7566.432517561095;7573.2048134947245;7573.621318933921;7602.657880395285;4833.709977401367;5245.396779370269;5687.829365119053;5772.9711351442975;5784.7107644618445;6540.149780528501;6761.966190169018;6787.457003439812;6798.456123510008;6800.761973330909;6262.749490020348;6407.551471396958;6470.773522926675;6477.935220647733;6558.770443034471;6085.208922840003;6241.344658810759;6270;6324.3991820776955;6401.071844582602;6384.425401713868;6411.743530258737;6417.39034791694;6417.422431981144;6432.453241474527;5772.1630363596205;5804.506616937439;5806.796762113306;5807.419258074159;5812.476877081083;5766.3368712598585;5851.561132915133;5875.823725288248;5919.6152250103605;5924.970375148269 04:41:55 INFO - PROCESS | 16962 | |4;prototype.html;301.61092191073516;302.20972157807324;311.7069954243013;313.2528918529307;314.76549970272146;5287.41838397776;5339.279197308367;5427.945720542793;5444.428335024825;5452.972735136329;5284.128118860383;5347.732613369335;5363.383210930744;5370.731463426823;5384.757685904144;3944.053427177471;4028.45615841862;4189.141226048653;4190.120074784299;4194.349875769245;4041.797910104483;4134.917301653965;4136.58634136587;4157.521884983235;4164.708470407073;4121.690873184508;4122.814473348706;4123.113530590922;4131.442255295542;4138.379243113527;3899.083715326896;3991.481107456041;4000.5399379071487;4093.283675356801;4114.033202197481;3593.6765691087667;3593.71250299978;3610.2418492116685;3610.2598967211657;3618.873339433107;5118.385793704742;5133.948660513384;5134.512221339004;5139.17773156297;5145.073886700392;4725.385699859031;4728.078024785168;4733.5503127202865;4736.052789442091;4737.928931066037;5405.081136206815;5589.944100558983;5602.159676048625;5608.270924779793;5609.52319052881;3914.1193231522966;3921.8431262749455;3921.941170882439;3925.214957008581;3929.8035098244973;5815.912761308584;5910.054391297372;5911.467967882868;5913.46778789911;5915.408459154093;4034.072163402434;4034.919301613951;4039.030632648143;4042.1915616876154;4042.5957404259925;3862.7102967277565;3864.768113913174;3979.7413168143976;4090.590940905945;4092.1815636872743;4523.638108951276;4667.066586682677;4668.906621867612;4670.859874203779;4671;5619.213310136584;5622.128570071645;5623.775048998076;5625.8593535161945;5627.831165065055;1423.302581734963;1423.5871597236685;1432.2194404049817;1432.8710416062604;1434.956951291442;967.3470407474927;968.7868668892833;979.24108815667;994.5822754443006;1004.3020101029714;4927.137750893579;4960.404751429852;4969.0807200668;4969.35398398206;4973.676711013773;5758.424157584208;5793.131030345482;5800.332961709458;5803.390643982406;5807.361190269067;4943.406791185081;4951.034548263126;4953.6037117030555;4956.231784073474;4962.379702537183;3055.877764889424;3090.258337998864;3107.875684972621;3123.2816452216116;3128.405602935435;5524.116141417354;5527.39198688144;5529.4470552944385;5534.52956498694;5536.058869992111;5953.642781433128;5964.194833697482;5964.224650795456;5968.194293770285;5969.074793407029;5468.671879687232;5519.751611177507;5540.944590554042;5549.112142057252;5551.916721249104;5576.414476479911;5786.074228123648;5794.710264486843;5797.797077102281;5800.216970708901;5658.066419040812;5671.064274394678;5675.943240567542;5692.857678558069;5696.458836410535;5530.6128570999645;5531.557475401878;5538.196961440649;5543.1408131739645;5548.0845660465575;3966.5835087315418;4025.7987100645437;4050.6556942659026;4055.0065234017857;4057.350823868167;5648.915266271091;5788.160716695971;5821.039528477923;5826.096954971986;5829.650220986754;5516.724163791875;5661.377248502744;5672.574556908331;5673.319201695823;5689.26039614864;5655.802046928337;5656.2929633795775;5666.829995100154;5669.829905102853;5670.829875103754;5371.865703357447;5497.917531236954;5520.420355862737;5522.30971128609;5525.336959564878;5680.630759000652;5690.5163061140265;5699.857503562444;5708.315002199596;5718.170865224436;5565.276514053147;5566.081596536526;5566.832995010156;5574.526165275997;5575.637583557056 04:41:55 INFO - PROCESS | 16962 | |5;yui.html;748.5284270909326;763.0461922596754;780.0639232920495;785.1912530094002;787.3111027850631;11593.478293476792;11885.881141188596;11907.285562866235;11934.224275422092;11939.34333611652;11960.461779219935;12082.637520874367;12088.153829231935;12096.153269271155;13486.865131348684;813.4793732011517;826.2068414322258;829.6681327469031;830.024720952881;830.754927296446;816.7753867686404;823.4976664234812;824.6660102658433;824.6907409721355;825.471698113208;855.7432770168956;863.3913091270671;864.0193380513132;864.1790299215738;864.6757465950269;856.3620103023256;858.845407826591;860.8665656823171;861.9741407757715;862.4652715316513;631.3970158498623;631.4348657951153;631.5515983651613;631.5863109663132;631.9304876463585;12006.279623222546;12232;12232.633021009384;12242.143049986504;12243.265404075784;11250.437478126061;11275.774484510346;11351.716207094805;11411.94294028533;11475.311481311148;9204.3096767742;9401;9415.717528474157;9588.760280992961;9602.951985240099;3167.635721891989;3246.4318744219668;3257.1042963185077;3282.556854824592;3333.1667083229195;34018.14954626154;34655;36418.63581364179;36544.817275913716;36816.44775328399;8951.194392504576;8967.820643587222;9088.909110908806;9168.954155229181;9241.168294853362;15672.843271567366;15685.921570392074;15696.293666785023;15708.136052516993;15734.606634834221;6494.902576461357;6746.966265168741;6803.353681400259;6888.724451021903;6923.376896079377;3700.888973330804;3722.9813850931114;3744.4196149596855;3823.866164684223;3877.1664092219744;2534.2017264561605;2574.6266791315156;2579.6904371475543;2579.793616510675;2583.225032490245;466.92529195329263;467.3340489802018;473.78129899160774;474.5231042802031;486.42844657527263;567.4580775359605;603.387561624951;604.9304330002018;619.9907001394982;625.3090335179561;7695.769126926201;7734.784740415814;7780.92219077802;7835.216478352119;7874.527528348317;539.937907140676;547.8110052032042;617.1606615003592;617.3332800575367;639.9904001439982;3599.38810402227;3913.7064720146104;4057.431959525669;4082.1427500225286;4120.381942708617;46616.533834661896;49866.501334986184;50624.493755062715;50679.23981140286;50690.23964640533;40916.59083409128;41823;41875.371869421986;47306.76346618245;47352.99999999931;36129.277414451564;44023;46075;46217;46230;8185.71350002747;8285.668573257002;8498.957505212435;8519.105493923296;8635.438696484709;26034.352810504544;30424.543631845096;30586.541201881544;30927.226819329695;30928.226794330323;35297.11757205988;39595.80202098971;39706;39796;42955;10608.151347891995;10741.289034168347;11157.944210278896;11199.552017919192;11357.659270221906;11124.777504450027;11370.147238957277;11421.086313094766;11874.46564904564;11943.04455643529;10379.844302335621;10637.202209834139;10700.678979630624;11036.392998385167;11383.430828458379;10551.736206594589;10929;11183.776324473627;11305.152113591677;11343.149263805082;10426.635067772591;10849.403282819521;10886.564537418415;11236.550537978716;11237.550497980315;8896.866547001671;9045.68340108093;9108.590113444778;9147.176754092163;9330.533473326443;8753.868691969752;8897.822043559223;9116;9129.406588571721;9500.656246271317 04:41:55 INFO - PROCESS | 16962 | __end_tp_report 04:41:55 INFO - PROCESS | 16962 | __start_cc_report 04:41:55 INFO - PROCESS | 16962 | _x_x_mozilla_cycle_collect,893 04:41:55 INFO - PROCESS | 16962 | __end_cc_report 04:41:55 INFO - PROCESS | 16962 | __startTimestamp1450874515478__endTimestamp 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | ------- Summary: start ------- 04:41:55 INFO - PROCESS | 16962 | Number of tests: 6 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#0] dojo.html Cycles:165 Average:4663.76 Median:4773.12 stddev:489.87 (10.3%) stddev-sans-first:463.74 04:41:55 INFO - PROCESS | 16962 | Values: 2595.8 2696.7 2703.6 2713.3 2720.8 4530.2 4710.3 4711.6 4735.3 4738.2 4628.5 4633.4 4759.5 4762.8 4782.3 4296.3 4297.1 4336.2 4379.3 4385.8 4338.0 4435.2 4471.0 4478.9 4509.5 4177.2 4255.0 4294.3 4394.1 4457.4 4376.2 4378.5 4383.2 4391.1 4413.1 4345.0 4350.0 4355.9 4357.2 4391.3 4445.8 4490.5 4593.2 4605.7 4683.3 5071.8 5087.5 5090.5 5095.9 5108.3 5082.6 5082.7 5110.7 5112.9 5135.5 4558.1 4573.3 4669.3 4673.3 4716.0 5211.0 5229.6 5229.7 5245.9 5286.2 5001.5 5010.1 5011.1 5013.2 5052.3 4832.6 4938.2 5082.3 5100.7 5101.8 4889.0 4910.3 4941.0 5040.4 5060.0 4974.7 5018.9 5019.6 5026.8 5068.7 4261.7 4265.8 4270.1 4278.9 4280.7 3586.4 3618.8 3707.5 3729.1 3732.3 4384.9 4409.5 4413.8 4422.8 4456.6 5088.7 5094.5 5096.6 5110.1 5121.8 4196.9 4267.5 4310.9 4320.5 4352.3 4474.4 4479.0 4488.8 4498.5 4503.4 4763.1 4775.6 4790.5 4805.4 4832.4 4791.4 4904.6 4928.3 4939.9 5089.7 4750.1 4768.6 4771.9 4773.1 4819.5 4924.9 4930.4 4942.8 4953.7 4972.7 4849.2 4974.3 4979.7 5036.2 5146.3 4954.0 4963.3 4966.8 4971.3 5013.1 4966.5 4987.4 4991.7 4993.5 5035.1 4644.4 4724.9 4743.7 4754.2 4852.6 4987.0 4994.3 4998.2 5011.2 5060.4 4880.6 4893.7 4895.0 4908.6 4940.6 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#1] ext.html Cycles:180 Average:39805.57 Median:18127.73 stddev:58614.38 (323.3%) stddev-sans-first:58704.71 04:41:55 INFO - PROCESS | 16962 | Values: 554.1 564.1 572.5 579.8 592.5 26852.5 27425.0 32313.2 32532.7 32576.7 35806.0 35952.6 36118.3 36193.3 36268.8 7041.1 7175.9 7725.7 7868.2 7912.2 10095.6 10295.5 10326.2 10330.3 10342.2 10121.9 10247.2 10249.4 10250.4 10252.8 7321.5 7495.7 10076.3 10265.4 10514.1 9937.6 9999.6 10019.4 10024.1 10028.3 36385.5 36832.6 36878.0 36979.4 37158.0 2870.5 2939.6 2945.7 3158.8 3471.0 28285.0 28290.9 28448.6 28590.6 29027.7 3322.6 3403.6 3451.0 3465.1 3605.4 209184.0 209853.0 211490.0 211585.0 211998.0 51708.0 55386.7 55714.4 55762.0 55766.0 46583.0 65183.3 66646.3 66661.7 66753.7 14784.9 15056.6 15066.0 15068.6 15069.2 11340.1 11424.3 11428.6 11431.7 11432.5 19137.2 19376.8 19445.8 19449.7 19466.3 7541.5 7688.7 7823.1 7842.3 7865.5 788.7 807.4 939.9 946.5 980.0 26706.7 26709.3 26850.6 26949.7 26993.5 909.8 935.0 941.2 959.1 1073.4 13860.5 14007.4 14161.5 14185.5 14375.4 244746.0 245620.0 246812.0 246937.0 247151.0 45312.0 45797.8 45940.5 45971.8 45998.0 1131.1 1156.7 1173.8 1179.3 1180.9 25383.5 26333.5 26553.3 26751.6 26780.9 36064.7 45285.8 46690.8 46692.1 46710.3 169767.0 225521.0 231827.0 231828.0 232130.0 34336.1 35111.8 35160.5 35250.0 35300.0 41148.4 41435.8 41464.6 41806.0 42245.2 35320.6 35478.8 35665.8 35988.6 36264.0 35226.1 35686.0 35757.8 35857.0 36170.6 34607.5 35055.6 35315.1 35386.5 35479.0 30853.7 32248.2 32810.8 32927.3 32932.8 24438.5 24636.4 24666.6 25001.7 25118.4 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#2] jquery.html Cycles:180 Average:21706.27 Median:1948.80 stddev:55447.68 (2845.2%) stddev-sans-first:55579.99 04:41:55 INFO - PROCESS | 16962 | Values: 327.0 328.8 332.1 333.1 334.4 12426.4 12728.8 14404.5 14874.3 14918.3 10473.4 10875.6 10890.1 14854.4 15252.8 4612.7 4657.0 4784.1 4800.9 4803.9 3563.2 3643.3 3646.2 3649.2 4675.8 3638.6 3645.4 5128.1 5294.8 5298.7 5154.8 5253.6 5272.4 5300.5 5311.3 5079.7 5120.5 5130.3 5135.3 5135.9 11368.1 14981.6 18372.4 18855.2 19097.9 1792.8 1807.3 1810.9 1839.7 1899.3 9071.0 9325.9 9337.6 11316.5 12485.1 1733.4 1754.4 1787.7 1789.5 1826.2 51281.5 53627.0 53639.5 53882.0 54441.2 9784.7 9818.0 9840.9 9854.5 9902.2 12437.4 12513.3 12531.4 12531.8 12556.2 7070.4 7132.7 7154.0 7188.6 7222.7 6898.5 6908.3 6913.8 6973.0 6984.5 4158.9 4169.5 4172.7 4178.6 4206.1 1601.2 1651.2 1675.1 1730.5 1737.5 902.4 904.9 928.6 937.9 949.6 14653.6 15717.0 16042.8 16102.1 16190.4 727.9 777.1 816.5 862.4 919.6 5356.7 8547.0 8598.1 8722.8 8992.7 298217.0 301919.0 302642.0 303321.0 449708.0 66916.0 71787.0 74211.6 74279.0 74363.0 1060.1 1060.6 1061.0 1094.5 1096.2 14411.1 14490.9 14494.2 14662.6 14938.6 31449.4 31882.5 32297.2 32408.7 33241.8 40631.0 41954.0 42934.8 44929.6 45942.1 8577.0 8837.2 8896.3 8959.9 8968.9 10281.3 13412.9 16209.2 16276.8 16405.0 13393.9 13570.4 13636.5 13903.2 13983.4 12971.6 13060.3 13502.6 13679.1 13687.0 10685.5 13494.6 13577.3 13711.0 13927.5 7824.0 8437.8 8797.7 8851.7 8970.4 12550.3 12637.2 12681.8 13000.2 13002.7 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#3] mootools.html Cycles:180 Average:4862.33 Median:6005.09 stddev:2496.31 (41.6%) stddev-sans-first:2489.82 04:41:55 INFO - PROCESS | 16962 | Values: 1408.0 1428.3 1436.4 1601.3 1677.2 5712.6 6899.0 7069.5 7079.2 7079.7 6920.1 7109.0 7112.6 7113.0 7125.5 2051.6 2104.7 2105.4 2105.8 2107.2 2050.1 2087.5 2091.8 2092.4 2094.6 1991.4 2005.4 2022.3 2031.9 2033.3 2076.6 2100.7 2101.4 2103.0 2103.7 2024.4 2054.2 2059.0 2063.6 2066.1 6970.7 7051.1 7068.7 7073.2 7075.2 4058.1 4140.7 4167.7 4169.2 4170.6 2747.3 2755.7 2785.2 2798.2 2815.7 933.9 1673.8 1679.9 1681.8 1682.4 9451.6 9606.9 9651.0 9662.7 9668.0 3825.5 3865.3 3887.0 3923.3 3926.3 7719.6 7723.9 7724.1 7736.8 7737.4 4251.5 4254.2 4257.9 4271.4 4288.3 3301.1 3367.6 3714.8 3951.2 3959.4 3198.8 3199.0 3247.7 3252.3 3261.7 937.3 963.4 970.3 977.5 979.7 899.5 913.0 914.9 916.3 1131.1 6718.2 6728.2 6729.6 6755.8 6757.5 431.5 432.8 443.4 445.8 450.4 5212.3 5284.6 5287.5 5288.7 5294.1 8045.7 8086.1 8262.0 8314.4 8328.1 8109.3 8187.3 8189.5 8202.8 8205.7 6420.5 6511.8 6522.1 6546.2 6546.7 6302.2 6306.9 6311.1 6322.7 6325.7 7268.6 7291.1 7347.7 7415.3 7418.6 7448.6 7566.4 7573.2 7573.6 7602.7 4833.7 5245.4 5687.8 5773.0 5784.7 6540.1 6762.0 6787.5 6798.5 6800.8 6262.7 6407.6 6470.8 6477.9 6558.8 6085.2 6241.3 6270.0 6324.4 6401.1 6384.4 6411.7 6417.4 6417.4 6432.5 5772.2 5804.5 5806.8 5807.4 5812.5 5766.3 5851.6 5875.8 5919.6 5925.0 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#4] prototype.html Cycles:180 Average:4656.91 Median:5367.06 stddev:1373.88 (25.6%) stddev-sans-first:1338.28 04:41:55 INFO - PROCESS | 16962 | Values: 301.6 302.2 311.7 313.3 314.8 5287.4 5339.3 5427.9 5444.4 5453.0 5284.1 5347.7 5363.4 5370.7 5384.8 3944.1 4028.5 4189.1 4190.1 4194.3 4041.8 4134.9 4136.6 4157.5 4164.7 4121.7 4122.8 4123.1 4131.4 4138.4 3899.1 3991.5 4000.5 4093.3 4114.0 3593.7 3593.7 3610.2 3610.3 3618.9 5118.4 5133.9 5134.5 5139.2 5145.1 4725.4 4728.1 4733.6 4736.1 4737.9 5405.1 5589.9 5602.2 5608.3 5609.5 3914.1 3921.8 3921.9 3925.2 3929.8 5815.9 5910.1 5911.5 5913.5 5915.4 4034.1 4034.9 4039.0 4042.2 4042.6 3862.7 3864.8 3979.7 4090.6 4092.2 4523.6 4667.1 4668.9 4670.9 4671.0 5619.2 5622.1 5623.8 5625.9 5627.8 1423.3 1423.6 1432.2 1432.9 1435.0 967.3 968.8 979.2 994.6 1004.3 4927.1 4960.4 4969.1 4969.4 4973.7 5758.4 5793.1 5800.3 5803.4 5807.4 4943.4 4951.0 4953.6 4956.2 4962.4 3055.9 3090.3 3107.9 3123.3 3128.4 5524.1 5527.4 5529.4 5534.5 5536.1 5953.6 5964.2 5964.2 5968.2 5969.1 5468.7 5519.8 5540.9 5549.1 5551.9 5576.4 5786.1 5794.7 5797.8 5800.2 5658.1 5671.1 5675.9 5692.9 5696.5 5530.6 5531.6 5538.2 5543.1 5548.1 3966.6 4025.8 4050.7 4055.0 4057.4 5648.9 5788.2 5821.0 5826.1 5829.7 5516.7 5661.4 5672.6 5673.3 5689.3 5655.8 5656.3 5666.8 5669.8 5670.8 5371.9 5497.9 5520.4 5522.3 5525.3 5680.6 5690.5 5699.9 5708.3 5718.2 5565.3 5566.1 5566.8 5574.5 5575.6 04:41:55 INFO - PROCESS | 16962 | 04:41:55 INFO - PROCESS | 16962 | [#5] yui.html Cycles:180 Average:12242.68 Median:46146.00 stddev:13642.26 (29.6%) stddev-sans-first:13653.23 04:41:55 INFO - PROCESS | 16962 | Values: 748.5 763.0 780.1 785.2 787.3 11593.5 11885.9 11907.3 11934.2 11939.3 11960.5 12082.6 12088.2 12096.2 13486.9 813.5 826.2 829.7 830.0 830.8 816.8 823.5 824.7 824.7 825.5 855.7 863.4 864.0 864.2 864.7 856.4 858.8 860.9 862.0 862.5 631.4 631.4 631.6 631.6 631.9 12006.3 12232.0 12232.6 12242.1 12243.3 11250.4 11275.8 11351.7 11411.9 11475.3 9204.3 9401.0 9415.7 9588.8 9603.0 3167.6 3246.4 3257.1 3282.6 3333.2 34018.1 34655.0 36418.6 36544.8 36816.4 8951.2 8967.8 9088.9 9169.0 9241.2 15672.8 15685.9 15696.3 15708.1 15734.6 6494.9 6747.0 6803.4 6888.7 6923.4 3700.9 3723.0 3744.4 3823.9 3877.2 2534.2 2574.6 2579.7 2579.8 2583.2 466.9 467.3 473.8 474.5 486.4 567.5 603.4 604.9 620.0 625.3 7695.8 7734.8 7780.9 7835.2 7874.5 539.9 547.8 617.2 617.3 640.0 3599.4 3913.7 4057.4 4082.1 4120.4 46616.5 49866.5 50624.5 50679.2 50690.2 40916.6 41823.0 41875.4 47306.8 47353.0 36129.3 44023.0 46075.0 46217.0 46230.0 8185.7 8285.7 8499.0 8519.1 8635.4 26034.4 30424.5 30586.5 30927.2 30928.2 35297.1 39595.8 39706.0 39796.0 42955.0 10608.2 10741.3 11157.9 11199.6 11357.7 11124.8 11370.1 11421.1 11874.5 11943.0 10379.8 10637.2 10700.7 11036.4 11383.4 10551.7 10929.0 11183.8 11305.2 11343.1 10426.6 10849.4 10886.6 11236.6 11237.6 8896.9 9045.7 9108.6 9147.2 9330.5 8753.9 8897.8 9116.0 9129.4 9500.7 04:41:55 INFO - PROCESS | 16962 | -------- Summary: end -------- 04:41:55 INFO - PROCESS | 16962 | 04:41:56 INFO - TEST-INFO | 16962: exit 0 04:41:56 INFO - TEST-OK | dromaeo_css | took 1118017ms 04:41:56 INFO - TEST-START | kraken 04:41:56 INFO - operating with platform_type : linux_ 04:41:56 INFO - Initialising browser for kraken test... 04:41:56 INFO - TEST-INFO | started process 17150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jHya8/profile http://localhost:52412/getInfo.html) 04:42:00 INFO - PROCESS | 17150 | __metrics Screen width/height:1600/1200 04:42:00 INFO - PROCESS | 17150 | colorDepth:24 04:42:00 INFO - PROCESS | 17150 | Browser inner width/height: 1024/697 04:42:00 INFO - PROCESS | 17150 | __metrics 04:42:01 INFO - PROCESS | 17150 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:42:01 INFO - PROCESS | 17150 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:01 ERROR - PROCESS | 17150 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:42:02 INFO - TEST-INFO | 17150: exit 0 04:42:02 INFO - Browser initialized. 04:42:02 INFO - Running cycle 1/1 for kraken test... 04:42:02 INFO - TEST-INFO | started process 17231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jHya8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:14 INFO - PROCESS | 17231 | RSS: Main: 149913600 04:42:14 INFO - PROCESS | 17231 | 04:42:16 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:17 INFO - PROCESS | 17231 | RSS: Main: 184352768 04:42:17 INFO - PROCESS | 17231 | 04:42:19 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-dft) 04:42:20 INFO - PROCESS | 17231 | RSS: Main: 173277184 04:42:20 INFO - PROCESS | 17231 | 04:42:23 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-fft) 04:42:24 INFO - PROCESS | 17231 | RSS: Main: 161824768 04:42:24 INFO - PROCESS | 17231 | 04:42:26 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator) 04:42:26 INFO - PROCESS | 17231 | RSS: Main: 163549184 04:42:26 INFO - PROCESS | 17231 | 04:42:28 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:29 INFO - PROCESS | 17231 | RSS: Main: 163999744 04:42:29 INFO - PROCESS | 17231 | 04:42:32 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:33 INFO - PROCESS | 17231 | RSS: Main: 163684352 04:42:33 INFO - PROCESS | 17231 | 04:42:36 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:37 INFO - PROCESS | 17231 | RSS: Main: 164892672 04:42:37 INFO - PROCESS | 17231 | 04:42:39 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial) 04:42:40 INFO - PROCESS | 17231 | RSS: Main: 167288832 04:42:40 INFO - PROCESS | 17231 | 04:42:42 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:42 INFO - PROCESS | 17231 | RSS: Main: 175177728 04:42:42 INFO - PROCESS | 17231 | 04:42:44 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:45 INFO - PROCESS | 17231 | RSS: Main: 174632960 04:42:45 INFO - PROCESS | 17231 | 04:42:47 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:47 INFO - PROCESS | 17231 | RSS: Main: 185344000 04:42:47 INFO - PROCESS | 17231 | 04:42:50 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:51 INFO - PROCESS | 17231 | RSS: Main: 191377408 04:42:51 INFO - PROCESS | 17231 | 04:42:53 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:54 INFO - PROCESS | 17231 | RSS: Main: 186945536 04:42:54 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52412/tests/kraken/driver.html?testName=ai-astar) 04:42:56 INFO - PROCESS | 17231 | RSS: Main: 245207040 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | __start_tp_report 04:42:56 INFO - PROCESS | 17231 | _x_x_mozilla_page_load 04:42:56 INFO - PROCESS | 17231 | _x_x_mozilla_page_load_details 04:42:56 INFO - PROCESS | 17231 | |i|pagename|runs| 04:42:56 INFO - PROCESS | 17231 | |0;ai-astar;111;115;106;111;114;114;103;112;112;104 04:42:56 INFO - PROCESS | 17231 | |1;audio-beat-detection;155;130;154;165;135;153;154;131;181;129 04:42:56 INFO - PROCESS | 17231 | |2;audio-dft;160;161;163;162;165;162;162;164;161;161 04:42:56 INFO - PROCESS | 17231 | |3;audio-fft;72;72;82;92;72;73;72;95;90;75 04:42:56 INFO - PROCESS | 17231 | |4;audio-oscillator;95;95;133;94;95;95;136;94;96;127 04:42:56 INFO - PROCESS | 17231 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;109 04:42:56 INFO - PROCESS | 17231 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;146;146 04:42:56 INFO - PROCESS | 17231 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 04:42:56 INFO - PROCESS | 17231 | |8;json-parse-financial;71;71;71;70;71;71;72;79;68;68 04:42:56 INFO - PROCESS | 17231 | |9;json-stringify-tinderbox;67;68;69;68;68;68;68;68;69;68 04:42:56 INFO - PROCESS | 17231 | |10;stanford-crypto-aes;83;85;86;84;84;85;83;94;86;84 04:42:56 INFO - PROCESS | 17231 | |11;stanford-crypto-ccm;126;126;127;131;127;137;130;124;127;135 04:42:56 INFO - PROCESS | 17231 | |12;stanford-crypto-pbkdf2;134;150;148;147;148;137;150;154;148;138 04:42:56 INFO - PROCESS | 17231 | |13;stanford-crypto-sha256-iterative;70;69;69;71;69;69;69;68;69;69 04:42:56 INFO - PROCESS | 17231 | __end_tp_report 04:42:56 INFO - PROCESS | 17231 | __start_cc_report 04:42:56 INFO - PROCESS | 17231 | _x_x_mozilla_cycle_collect,986 04:42:56 INFO - PROCESS | 17231 | __end_cc_report 04:42:56 INFO - PROCESS | 17231 | __startTimestamp1450874576291__endTimestamp 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | ------- Summary: start ------- 04:42:56 INFO - PROCESS | 17231 | Number of tests: 14 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.32 (3.9%) stddev-sans-first:4.57 04:42:56 INFO - PROCESS | 17231 | Values: 111.0 115.0 106.0 111.0 114.0 114.0 103.0 112.0 112.0 104.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.00 stddev:17.20 (11.2%) stddev-sans-first:18.09 04:42:56 INFO - PROCESS | 17231 | Values: 155.0 130.0 154.0 165.0 135.0 153.0 154.0 131.0 181.0 129.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.52 (0.9%) stddev-sans-first:1.41 04:42:56 INFO - PROCESS | 17231 | Values: 160.0 161.0 163.0 162.0 165.0 162.0 162.0 164.0 161.0 161.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#3] audio-fft Cycles:10 Average:79.50 Median:78.50 stddev:9.43 (12.0%) stddev-sans-first:9.60 04:42:56 INFO - PROCESS | 17231 | Values: 72.0 72.0 82.0 92.0 72.0 73.0 72.0 95.0 90.0 75.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#4] audio-oscillator Cycles:10 Average:106.00 Median:95.00 stddev:18.08 (19.0%) stddev-sans-first:18.73 04:42:56 INFO - PROCESS | 17231 | Values: 95.0 95.0 133.0 94.0 95.0 95.0 136.0 94.0 96.0 127.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:42:56 INFO - PROCESS | 17231 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:42:56 INFO - PROCESS | 17231 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:42:56 INFO - PROCESS | 17231 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:3.05 (4.3%) stddev-sans-first:3.23 04:42:56 INFO - PROCESS | 17231 | Values: 71.0 71.0 71.0 70.0 71.0 71.0 72.0 79.0 68.0 68.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 04:42:56 INFO - PROCESS | 17231 | Values: 67.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.20 (3.8%) stddev-sans-first:3.28 04:42:56 INFO - PROCESS | 17231 | Values: 83.0 85.0 86.0 84.0 84.0 85.0 83.0 94.0 86.0 84.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.50 stddev:4.22 (3.3%) stddev-sans-first:4.33 04:42:56 INFO - PROCESS | 17231 | Values: 126.0 126.0 127.0 131.0 127.0 137.0 130.0 124.0 127.0 135.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.00 stddev:6.62 (4.5%) stddev-sans-first:5.59 04:42:56 INFO - PROCESS | 17231 | Values: 134.0 150.0 148.0 147.0 148.0 137.0 150.0 154.0 148.0 138.0 04:42:56 INFO - PROCESS | 17231 | 04:42:56 INFO - PROCESS | 17231 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 04:42:56 INFO - PROCESS | 17231 | Values: 70.0 69.0 69.0 71.0 69.0 69.0 69.0 68.0 69.0 69.0 04:42:56 INFO - PROCESS | 17231 | -------- Summary: end -------- 04:42:56 INFO - PROCESS | 17231 | 04:42:57 INFO - TEST-INFO | 17231: exit 0 04:42:57 INFO - TEST-OK | kraken | took 60897ms 04:42:57 INFO - TEST-START | v8_7 04:42:57 INFO - operating with platform_type : linux_ 04:42:57 INFO - Initialising browser for v8_7 test... 04:42:57 INFO - TEST-INFO | started process 17478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbt5hB/profile http://localhost:52412/getInfo.html) 04:43:01 INFO - PROCESS | 17478 | __metrics Screen width/height:1600/1200 04:43:01 INFO - PROCESS | 17478 | colorDepth:24 04:43:01 INFO - PROCESS | 17478 | Browser inner width/height: 1024/697 04:43:01 INFO - PROCESS | 17478 | __metrics 04:43:01 INFO - PROCESS | 17478 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:43:01 INFO - PROCESS | 17478 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:03 INFO - TEST-INFO | 17478: exit 0 04:43:03 INFO - Browser initialized. 04:43:03 INFO - Running cycle 1/1 for v8_7 test... 04:43:03 INFO - TEST-INFO | started process 17562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbt5hB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:15 INFO - PROCESS | 17562 | RSS: Main: 150425600 04:43:15 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | Cycle 1(1): loaded http://localhost:52412/tests/v8_7/run.html (next: http://localhost:52412/tests/v8_7/run.html) 04:43:36 INFO - PROCESS | 17562 | RSS: Main: 457580544 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | __start_tp_report 04:43:36 INFO - PROCESS | 17562 | _x_x_mozilla_page_load 04:43:36 INFO - PROCESS | 17562 | _x_x_mozilla_page_load_details 04:43:36 INFO - PROCESS | 17562 | |i|pagename|runs| 04:43:36 INFO - PROCESS | 17562 | |0;Richards;165.80998176090202 04:43:36 INFO - PROCESS | 17562 | |1;DeltaBlue;185.73551263001485 04:43:36 INFO - PROCESS | 17562 | |2;Encrypt;279.56388034665923 04:43:36 INFO - PROCESS | 17562 | |3;Decrypt;5128.205128205128 04:43:36 INFO - PROCESS | 17562 | |4;RayTrace;1970.4724409448818 04:43:36 INFO - PROCESS | 17562 | |5;Earley;786.7820613690008 04:43:36 INFO - PROCESS | 17562 | |6;Boyer;12096.385542168675 04:43:36 INFO - PROCESS | 17562 | |7;RegExp;26763.157894736843 04:43:36 INFO - PROCESS | 17562 | |8;Splay;612.1951219512196 04:43:36 INFO - PROCESS | 17562 | |9;NavierStokes;4840.579710144928 04:43:36 INFO - PROCESS | 17562 | __end_tp_report 04:43:36 INFO - PROCESS | 17562 | __startTimestamp1450874616717__endTimestamp 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | ------- Summary: start ------- 04:43:36 INFO - PROCESS | 17562 | Number of tests: 10 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 165.8 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#1] DeltaBlue Cycles:1 Average:185.74 Median:185.74 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 185.7 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 279.6 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 5128.2 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 1970.5 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 786.8 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 12096.4 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 26763.2 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#8] Splay Cycles:1 Average:612.20 Median:612.20 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 612.2 04:43:36 INFO - PROCESS | 17562 | 04:43:36 INFO - PROCESS | 17562 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:43:36 INFO - PROCESS | 17562 | Values: 4840.6 04:43:36 INFO - PROCESS | 17562 | -------- Summary: end -------- 04:43:36 INFO - PROCESS | 17562 | 04:43:37 INFO - TEST-INFO | 17562: exit 0 04:43:37 INFO - TEST-OK | v8_7 | took 40511ms 04:43:37 INFO - SUITE-END | took 1219s 04:43:37 INFO - Completed test suite (00:20:19) 04:43:37 INFO - Working with test: dromaeo_css 04:43:37 INFO - Generating results file: dromaeo_css 04:43:37 INFO - Working with test: kraken 04:43:37 INFO - Generating results file: kraken 04:43:37 INFO - javascript benchmark 04:43:37 INFO - Working with test: v8_7 04:43:37 INFO - Generating results file: v8_7 04:43:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:43:37 INFO - process_Request line: dromaeo_css 6306.00 graph.html#tests=[[72,94,35]] 04:43:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:37 INFO - process_Request line: kraken 1525.20 graph.html#tests=[[232,94,35]] 04:43:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:43:37 INFO - process_Request line: v8_7 19846.48 graph.html#tests=[[230,94,35]] 04:43:37 INFO - RETURN: dromaeo_css: 6306.00 04:43:37 INFO - RETURN: kraken: 1525.20 04:43:37 INFO - RETURN: v8_7: 19846.48 04:43:37 INFO - javascript benchmark 04:43:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.831270967387, 2696.662917135358, 2703.6079768433565, 2713.2538551898224, 2720.768734657554, 4530.229860923642, 4710.293455981605, 4711.552402521764, 4735.313379559966, 4738.194506933821, 4628.4677262114865, 4633.397658304416, 4759.452662943762, 4762.7618619069, 4782.306565547993, 4296.269634162192, 4297.05464797744, 4336.176126535964, 4379.299312110063, 4385.758783266919, 4337.9566204338025, 4435.223835828717, 4470.97764511177, 4478.8880277992985, 4509.4814096379005, 4177.164567086595, 4255.0426154115385, 4294.334378171388, 4394.055278115205, 4457.442819647544, 4376.190404775127, 4378.496472905625, 4383.189110014658, 4391.055922976543, 4413.051193993275, 4345.044090300129, 4349.978250108761, 4355.891102722458, 4357.150355680644, 4391.275439552502, 4445.8221671133115, 4490.483594386655, 4593.173228818811, 4605.700629459075, 4683.2975053741875, 5071.771770270309, 5087.542121209072, 5090.465501122366, 5095.872603184913, 5108.335916330853, 5082.644214904958, 5082.720450375228, 5110.66780659256, 5112.872178195575, 5135.512126347991, 4558.111168322145, 4573.336866154389, 4669.34629151919, 4673.299005149255, 4716.0, 5211.043257251536, 5229.555487783581, 5229.660072095302, 5245.868853278698, 5286.154215325606, 5001.4998500149695, 5010.073136469765, 5011.1481048221885, 5013.24801279811, 5052.292679024939, 4832.565069143794, 4938.185199442124, 5082.263071854561, 5100.693958362436, 5101.770420331094, 4889.0, 4910.337104490848, 4940.950590494121, 5040.445550989388, 5059.97470012655, 4974.7263900485095, 5018.89962200754, 5019.648624596243, 5026.773795179226, 5068.670536415195, 4261.722988005769, 4265.786710664454, 4270.145970805851, 4278.850240241577, 4280.6789490788315, 3586.4261718124976, 3618.782873027574, 3707.480952666629, 3729.1422972716427, 3732.272206919679, 4384.868453946387, 4409.470863496337, 4413.8234470621455, 4422.778861056934, 4456.62118719906, 5088.6946783193125, 5094.541491265803, 5096.592272618182, 5110.105731497048, 5121.769520371592, 4196.9370459443135, 4267.530571637118, 4310.892227694333, 4320.4599425071865, 4352.303631418958, 4474.351219073281, 4478.955210447919, 4488.820447182076, 4498.460184777848, 4503.369528266046, 4763.095011947719, 4775.6179505638775, 4790.544898234732, 4805.3512775774825, 4832.395950506187, 4791.448983366958, 4904.558589726799, 4928.285398617252, 4939.851804445872, 5089.6691715038405, 4750.07373562152, 4768.642351823696, 4771.856844294677, 4773.11697335994, 4819.542143496362, 4924.901501970012, 4930.359053323045, 4942.752862356796, 4953.727544984917, 4972.65191436596, 4849.175640141255, 4974.303597496426, 4979.726115063561, 5036.194208926554, 5146.288666992523, 4954.033963377107, 4963.305137280856, 4966.776495057803, 4971.328870602422, 5013.072581572421, 4966.453690094015, 4987.376577927759, 4991.725455100004, 4993.450720420823, 5035.0685123252315, 4644.396228490275, 4724.929126063043, 4743.691660042086, 4754.168020596313, 4852.611791056636, 4987.0, 4994.275830004702, 4998.225275082368, 5011.173156429149, 5060.367454068241, 4880.585150262267, 4893.706377617212, 4894.95105048945, 4908.607311415007, 4940.60475161979], "unit": "score", "name": "dojo.html", "value": 4632.935062447283}, {"lowerIsBetter": false, "replicates": [554.0944019617938, 564.117156649843, 572.4876235768984, 579.8231539380489, 592.4549414538625, 26852.462950741, 27425.0, 32313.19217019573, 32532.67467325326, 32576.67423325766, 35806.0, 35952.64047359525, 36118.277634447295, 36193.27613447736, 36268.81865590675, 7041.119860017498, 7175.928240717578, 7725.652345644446, 7868.213178682143, 7912.20877912207, 10095.596176152945, 10295.485225738683, 10326.173906087495, 10330.328528645652, 10342.224333175005, 10121.898781012169, 10247.180225581973, 10249.436281004542, 10250.436226007567, 10252.794944101113, 7321.487495875317, 7495.700171993114, 10076.345037572535, 10265.384076955332, 10514.053735163796, 9937.602495900155, 9999.550020249033, 10019.44893030883, 10024.097831195228, 10028.298019138663, 36385.45421818675, 36832.63167368319, 36878.0, 36979.44530832013, 37158.0, 2870.512012957802, 2939.5590661400747, 2945.7054294570585, 3158.8262645554487, 3470.9652903470896, 28285.0, 28290.858545707346, 28448.573271400946, 28590.571141432894, 29027.709722902924, 3322.6345102039, 3403.6256011838677, 3450.994392134117, 3465.081753335368, 3605.441156620728, 209184.0, 209853.0, 211489.99999999846, 211585.0, 211998.0, 51708.0, 55386.72306638441, 55714.442855570924, 55762.0, 55766.0, 46583.0, 65183.34816651868, 66646.33353666498, 66661.6666916672, 66753.66623166853, 14784.852151478348, 15056.623584410478, 15066.0, 15068.623284417978, 15069.171195584348, 11340.149488788209, 11424.257423267461, 11428.599998999995, 11431.657050288504, 11432.542698291974, 19137.2345106197, 19376.806231937782, 19445.805541944683, 19449.708254376197, 19466.31867884617, 7541.509801862861, 7688.693391982383, 7823.139454659983, 7842.254985776342, 7865.528068315919, 788.6529926832291, 807.3863863463692, 939.9342046056847, 946.5172761891484, 980.0297705271872, 26706.732932670424, 26709.332266693487, 26850.5972410414, 26949.730502695114, 26993.460130797666, 909.7952960583816, 934.9672761453317, 941.2140862379989, 959.098447459386, 1073.4257172412879, 13860.514881979083, 14007.439702411993, 14161.504347347793, 14185.503507377398, 14375.353109109907, 244746.0, 245620.0, 246812.0, 246937.0, 247151.0, 45312.0, 45797.77101114473, 45940.54059459429, 45971.77014114975, 45998.0, 1131.0838221040983, 1156.67613068341, 1173.7711146326385, 1179.3218899132862, 1180.8819118088122, 25383.492330153662, 26333.473330533667, 26553.33616659599, 26751.598726019514, 26780.866095669397, 36064.73773417918, 45285.77357113193, 46690.766546167055, 46692.06615867731, 46710.299345510524, 169767.0, 225521.0, 231827.0, 231828.0, 232130.0, 34336.141596460286, 35111.82444087763, 35160.47259291164, 35250.0, 35300.0, 41148.382774257814, 41435.7928210357, 41464.585354146075, 41806.0, 42245.1550968985, 35320.646793531734, 35478.8226058868, 35665.82167089148, 35988.64011359853, 36264.0, 35226.11934701653, 35686.0, 35757.82121089378, 35857.0, 36170.63829361673, 34607.4808877862, 35055.64944350524, 35315.11712207215, 35386.46920296146, 35479.0, 30853.69146308508, 32248.193795155308, 32810.835945820116, 32927.341453170324, 32932.83533582317, 24438.51122977495, 24636.38409039788, 24666.63000054965, 25001.749982499943, 25118.3720406984], "unit": "score", "name": "ext.html", "value": 17481.612404475803}, {"lowerIsBetter": false, "replicates": [326.9722073623742, 328.79778935954397, 332.14804027669044, 333.1438203816192, 334.4281279012888, 12426.378681065933, 12728.809067863966, 14404.495842645509, 14874.330655120519, 14918.328675209614, 10473.371597704143, 10875.564977400894, 10890.074343680797, 14854.405823767063, 15252.771208431883, 4612.700174488664, 4656.9534304656945, 4784.091022705675, 4800.927986080212, 4803.879903002418, 3563.1626567756557, 3643.271345730851, 3646.1613828819386, 3649.215418684982, 4675.766211689419, 3638.5815631202354, 3645.4167333226687, 5128.102582048126, 5294.814681486148, 5298.682079075248, 5154.819581314673, 5253.60597955153, 5272.393674727417, 5300.469953004707, 5311.256424100629, 5079.6952182869145, 5120.539151476348, 5130.256112863651, 5135.306733590992, 5135.897282054338, 11368.090552755759, 14981.550553483414, 18372.356967506206, 18855.151518181716, 19097.904510477496, 1792.829681180286, 1807.3493542324752, 1810.8551315894697, 1839.7424360589528, 1899.3352326685688, 9071.0, 9325.90674093264, 9337.579808908615, 11316.490757915913, 12485.063620228428, 1733.419304532983, 1754.429810311654, 1787.731840223964, 1789.4899953513316, 1826.2147276671026, 51281.48718512805, 53627.0, 53639.463605364224, 53882.0, 54441.1833822493, 9784.657536986171, 9817.969113243149, 9840.852387214198, 9854.458004809805, 9902.207823374112, 12437.378131093408, 12513.311767852674, 12531.373431328397, 12531.812022819666, 12556.183848049848, 7070.434365250768, 7132.679029443688, 7154.0, 7188.640567971581, 7222.711091556279, 6898.482613803984, 6908.3091690830515, 6913.827154321081, 6973.0, 6984.476164287698, 4158.91682166361, 4169.499660040815, 4172.70791044624, 4178.623923846869, 4206.0956894267265, 1601.223406647775, 1651.175451126512, 1675.1373042882924, 1730.4895055958523, 1737.4961261234353, 902.4359775140537, 904.8733177355175, 928.6192661008954, 937.8792343150006, 949.6248981652209, 14653.560393188221, 15717.0, 16042.839571604369, 16102.114383708775, 16190.433334833224, 727.8617062758059, 777.0558771093149, 816.4896939412866, 862.4351050062219, 919.6275508419101, 5356.678599284055, 8546.957265213758, 8598.097199794056, 8722.781930451663, 8992.685256016008, 298217.0, 301919.0, 302642.0, 303321.0, 449708.0, 66916.0, 71787.0, 74211.62894185602, 74279.0, 74363.0, 1060.1359891688248, 1060.5863713151878, 1060.9946950265353, 1094.5457635081511, 1096.2381145104237, 14411.135331879701, 14490.927545362205, 14494.202818844644, 14662.633434163805, 14938.626534336729, 31449.37101258008, 31882.52176217312, 32297.192570184994, 32408.67591324151, 33241.83379083089, 40631.0, 41954.0, 42934.78532607317, 44929.55070449254, 45942.08115837731, 8577.0, 8837.20465158113, 8896.332775042027, 8959.865602016105, 8968.865467018131, 10281.331713438603, 13412.93293533526, 16209.189540522691, 16276.837231627533, 16405.0, 13393.933030334785, 13570.389332479865, 13636.454541818217, 13903.165810051429, 13983.370748316554, 12971.610851674464, 13060.281684507443, 13502.594922152352, 13679.110857794212, 13687.0, 10685.51915163804, 13494.595162145151, 13577.253251071286, 13711.0, 13927.512537061155, 7824.0, 8437.789055273668, 8797.692080777142, 8851.734447966572, 8970.41692289999, 12550.30973296441, 12637.2417654941, 12681.80977285323, 13000.154989925624, 13002.739945201232], "unit": "score", "name": "jquery.html", "value": 7966.801960944246}, {"lowerIsBetter": false, "replicates": [1408.042531078866, 1428.3429622373708, 1436.367998080845, 1601.327442474161, 1677.1698009485306, 5712.628679135859, 6898.965505172473, 7069.540479868805, 7079.185893622235, 7079.681414336361, 6920.100386949702, 7109.0, 7112.608806515639, 7113.0, 7125.536840105389, 2051.6101940631306, 2104.6737755647823, 2105.431533485958, 2105.7894210578975, 2107.1676687708346, 2050.097956898967, 2087.4572611121066, 2091.7594476635154, 2092.3513710749717, 2094.581083783242, 1991.412533302672, 2005.4384772263716, 2022.2618744158349, 2031.8882461464614, 2033.3391647714552, 2076.636588596997, 2100.6953991671276, 2101.432613194444, 2102.9789702102935, 2103.6739305407687, 2024.4129202531249, 2054.1783286685295, 2058.958820823575, 2063.587282543482, 2066.0909199951975, 6970.686319115652, 7051.1186101737285, 7068.717251309941, 7073.186583542907, 7075.150981882156, 4058.1072164123843, 4140.710150289481, 4167.74993500391, 4169.207850508394, 4170.645495132917, 2747.2994386431333, 2755.7106503817213, 2785.2062162283855, 2798.2164993801766, 2815.7184281571886, 933.9252859771202, 1673.7824082869272, 1679.8572121369698, 1681.840225178606, 1682.3607029328898, 9451.574679139387, 9606.90393096067, 9651.0, 9662.710118696381, 9668.0, 3825.5218097737784, 3865.342891708416, 3886.9611303887164, 3923.2545816294814, 3926.332523471017, 7719.575423351657, 7723.884141737878, 7724.073111226577, 7736.7678969631, 7737.419693523008, 4251.489821221411, 4254.191703576311, 4257.8509752158525, 4271.423357846713, 4288.270993931039, 3301.0756988043386, 3367.5958884933475, 3714.7771133732062, 3951.1702542466405, 3959.40608908666, 3198.792078514889, 3198.9680103199134, 3247.723943464832, 3252.3332716793, 3261.6575259597876, 937.329809186435, 963.3786207896007, 970.2529052629577, 977.5112443778111, 979.7158823940978, 899.4648184330313, 912.9954350228206, 914.9176574108362, 916.2532535983153, 1131.095123900876, 6718.160229971254, 6728.192616886005, 6729.596224226562, 6755.831104222336, 6757.459403247728, 431.4994606256727, 432.83119583362515, 443.3726277317624, 445.8305843779408, 450.4279564952492, 5212.348456442945, 5284.603654725834, 5287.524122828964, 5288.65623734456, 5294.100002999499, 8045.678172873137, 8086.070101938235, 8261.958690206511, 8314.41799074059, 8328.125546817619, 8109.310708589718, 8187.345012398994, 8189.50862948225, 8202.794930126794, 8205.671773129128, 6420.454261387835, 6511.772087976898, 6522.086907832907, 6546.214454265519, 6546.738130474823, 6302.180716506825, 6306.873862522815, 6311.116443697978, 6322.715477803602, 6325.7153428094925, 7268.563886166847, 7291.05216321896, 7347.742829000959, 7415.295546923034, 7418.629068546659, 7448.590327532038, 7566.432517561095, 7573.2048134947245, 7573.621318933921, 7602.657880395285, 4833.709977401367, 5245.396779370269, 5687.829365119053, 5772.9711351442975, 5784.7107644618445, 6540.149780528501, 6761.966190169018, 6787.457003439812, 6798.456123510008, 6800.761973330909, 6262.749490020348, 6407.551471396958, 6470.773522926675, 6477.935220647733, 6558.770443034471, 6085.208922840003, 6241.344658810759, 6270.0, 6324.3991820776955, 6401.071844582602, 6384.425401713868, 6411.743530258737, 6417.39034791694, 6417.422431981144, 6432.453241474527, 5772.1630363596205, 5804.506616937439, 5806.796762113306, 5807.419258074159, 5812.476877081083, 5766.3368712598585, 5851.561132915133, 5875.823725288248, 5919.6152250103605, 5924.970375148269], "unit": "score", "name": "mootools.html", "value": 3968.798539169043}, {"lowerIsBetter": false, "replicates": [301.61092191073516, 302.20972157807324, 311.7069954243013, 313.2528918529307, 314.76549970272146, 5287.41838397776, 5339.279197308367, 5427.945720542793, 5444.428335024825, 5452.972735136329, 5284.128118860383, 5347.732613369335, 5363.383210930744, 5370.731463426823, 5384.757685904144, 3944.053427177471, 4028.45615841862, 4189.141226048653, 4190.120074784299, 4194.349875769245, 4041.797910104483, 4134.917301653965, 4136.58634136587, 4157.521884983235, 4164.708470407073, 4121.690873184508, 4122.814473348706, 4123.113530590922, 4131.442255295542, 4138.379243113527, 3899.083715326896, 3991.481107456041, 4000.5399379071487, 4093.283675356801, 4114.033202197481, 3593.6765691087667, 3593.71250299978, 3610.2418492116685, 3610.2598967211657, 3618.873339433107, 5118.385793704742, 5133.948660513384, 5134.512221339004, 5139.17773156297, 5145.073886700392, 4725.385699859031, 4728.078024785168, 4733.5503127202865, 4736.052789442091, 4737.928931066037, 5405.081136206815, 5589.944100558983, 5602.159676048625, 5608.270924779793, 5609.52319052881, 3914.1193231522966, 3921.8431262749455, 3921.941170882439, 3925.214957008581, 3929.8035098244973, 5815.912761308584, 5910.054391297372, 5911.467967882868, 5913.46778789911, 5915.408459154093, 4034.072163402434, 4034.919301613951, 4039.030632648143, 4042.1915616876154, 4042.5957404259925, 3862.7102967277565, 3864.768113913174, 3979.7413168143976, 4090.590940905945, 4092.1815636872743, 4523.638108951276, 4667.066586682677, 4668.906621867612, 4670.859874203779, 4671.0, 5619.213310136584, 5622.128570071645, 5623.775048998076, 5625.8593535161945, 5627.831165065055, 1423.302581734963, 1423.5871597236685, 1432.2194404049817, 1432.8710416062604, 1434.956951291442, 967.3470407474927, 968.7868668892833, 979.24108815667, 994.5822754443006, 1004.3020101029714, 4927.137750893579, 4960.404751429852, 4969.0807200668, 4969.35398398206, 4973.676711013773, 5758.424157584208, 5793.131030345482, 5800.332961709458, 5803.390643982406, 5807.361190269067, 4943.406791185081, 4951.034548263126, 4953.6037117030555, 4956.231784073474, 4962.379702537183, 3055.877764889424, 3090.258337998864, 3107.875684972621, 3123.2816452216116, 3128.405602935435, 5524.116141417354, 5527.39198688144, 5529.4470552944385, 5534.52956498694, 5536.058869992111, 5953.642781433128, 5964.194833697482, 5964.224650795456, 5968.194293770285, 5969.074793407029, 5468.671879687232, 5519.751611177507, 5540.944590554042, 5549.112142057252, 5551.916721249104, 5576.414476479911, 5786.074228123648, 5794.710264486843, 5797.797077102281, 5800.216970708901, 5658.066419040812, 5671.064274394678, 5675.943240567542, 5692.857678558069, 5696.458836410535, 5530.6128570999645, 5531.557475401878, 5538.196961440649, 5543.1408131739645, 5548.0845660465575, 3966.5835087315418, 4025.7987100645437, 4050.6556942659026, 4055.0065234017857, 4057.350823868167, 5648.915266271091, 5788.160716695971, 5821.039528477923, 5826.096954971986, 5829.650220986754, 5516.724163791875, 5661.377248502744, 5672.574556908331, 5673.319201695823, 5689.26039614864, 5655.802046928337, 5656.2929633795775, 5666.829995100154, 5669.829905102853, 5670.829875103754, 5371.865703357447, 5497.917531236954, 5520.420355862737, 5522.30971128609, 5525.336959564878, 5680.630759000652, 5690.5163061140265, 5699.857503562444, 5708.315002199596, 5718.170865224436, 5565.276514053147, 5566.081596536526, 5566.832995010156, 5574.526165275997, 5575.637583557056], "unit": "score", "name": "prototype.html", "value": 4216.449066550185}, {"lowerIsBetter": false, "replicates": [748.5284270909326, 763.0461922596754, 780.0639232920495, 785.1912530094002, 787.3111027850631, 11593.478293476792, 11885.881141188596, 11907.285562866235, 11934.224275422092, 11939.34333611652, 11960.461779219935, 12082.637520874367, 12088.153829231935, 12096.153269271155, 13486.865131348684, 813.4793732011517, 826.2068414322258, 829.6681327469031, 830.024720952881, 830.754927296446, 816.7753867686404, 823.4976664234812, 824.6660102658433, 824.6907409721355, 825.471698113208, 855.7432770168956, 863.3913091270671, 864.0193380513132, 864.1790299215738, 864.6757465950269, 856.3620103023256, 858.845407826591, 860.8665656823171, 861.9741407757715, 862.4652715316513, 631.3970158498623, 631.4348657951153, 631.5515983651613, 631.5863109663132, 631.9304876463585, 12006.279623222546, 12232.0, 12232.633021009384, 12242.143049986504, 12243.265404075784, 11250.437478126061, 11275.774484510346, 11351.716207094805, 11411.94294028533, 11475.311481311148, 9204.3096767742, 9401.0, 9415.717528474157, 9588.760280992961, 9602.951985240099, 3167.635721891989, 3246.4318744219668, 3257.1042963185077, 3282.556854824592, 3333.1667083229195, 34018.14954626154, 34655.0, 36418.63581364179, 36544.817275913716, 36816.44775328399, 8951.194392504576, 8967.820643587222, 9088.909110908806, 9168.954155229181, 9241.168294853362, 15672.843271567366, 15685.921570392074, 15696.293666785023, 15708.136052516993, 15734.606634834221, 6494.902576461357, 6746.966265168741, 6803.353681400259, 6888.724451021903, 6923.376896079377, 3700.888973330804, 3722.9813850931114, 3744.4196149596855, 3823.866164684223, 3877.1664092219744, 2534.2017264561605, 2574.6266791315156, 2579.6904371475543, 2579.793616510675, 2583.225032490245, 466.92529195329263, 467.3340489802018, 473.78129899160774, 474.5231042802031, 486.42844657527263, 567.4580775359605, 603.387561624951, 604.9304330002018, 619.9907001394982, 625.3090335179561, 7695.769126926201, 7734.784740415814, 7780.92219077802, 7835.216478352119, 7874.527528348317, 539.937907140676, 547.8110052032042, 617.1606615003592, 617.3332800575367, 639.9904001439982, 3599.38810402227, 3913.7064720146104, 4057.431959525669, 4082.1427500225286, 4120.381942708617, 46616.533834661896, 49866.501334986184, 50624.493755062715, 50679.23981140286, 50690.23964640533, 40916.59083409128, 41823.0, 41875.371869421986, 47306.76346618245, 47352.99999999931, 36129.277414451564, 44023.0, 46075.0, 46217.0, 46230.0, 8185.71350002747, 8285.668573257002, 8498.957505212435, 8519.105493923296, 8635.438696484709, 26034.352810504544, 30424.543631845096, 30586.541201881544, 30927.226819329695, 30928.226794330323, 35297.11757205988, 39595.80202098971, 39706.0, 39796.0, 42955.0, 10608.151347891995, 10741.289034168347, 11157.944210278896, 11199.552017919192, 11357.659270221906, 11124.777504450027, 11370.147238957277, 11421.086313094766, 11874.46564904564, 11943.04455643529, 10379.844302335621, 10637.202209834139, 10700.678979630624, 11036.392998385167, 11383.430828458379, 10551.736206594589, 10929.0, 11183.776324473627, 11305.152113591677, 11343.149263805082, 10426.635067772591, 10849.403282819521, 10886.564537418415, 11236.550537978716, 11237.550497980315, 8896.866547001671, 9045.68340108093, 9108.590113444778, 9147.176754092163, 9330.533473326443, 8753.868691969752, 8897.822043559223, 9116.0, 9129.406588571721, 9500.656246271317], "unit": "score", "name": "yui.html", "value": 5823.002835238992}], "name": "dromaeo_css", "value": 6305.9944564954}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 106.0, 111.0, 114.0, 114.0, 103.0, 112.0, 112.0, 104.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [155.0, 130.0, 154.0, 165.0, 135.0, 153.0, 154.0, 131.0, 181.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 163.0, 162.0, 165.0, 162.0, 162.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 82.0, 92.0, 72.0, 73.0, 72.0, 95.0, 90.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 94.0, 95.0, 95.0, 136.0, 94.0, 96.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 70.0, 71.0, 71.0, 72.0, 79.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 84.0, 84.0, 85.0, 83.0, 94.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [126.0, 126.0, 127.0, 131.0, 127.0, 137.0, 130.0, 124.0, 127.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [134.0, 150.0, 148.0, 147.0, 148.0, 137.0, 150.0, 154.0, 148.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 71.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1525.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [185.73551263001485], "unit": "score", "name": "DeltaBlue", "value": 355.9793120000001}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [612.1951219512196], "unit": "score", "name": "Splay", "value": 133.1127888446215}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19846.4847935392}]} 04:43:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19846.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1525.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6306.00"}}} 04:43:37 INFO - Return code: 0 04:43:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:43:38 ERROR - # TBPL SUCCESS # 04:43:38 INFO - Running post-action listener: _resource_record_post_action 04:43:38 INFO - Running post-run listener: _resource_record_post_run 04:43:39 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555171840; Read time: 12; Write time: 503192 04:43:39 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 236580864; Read time: 0; Write time: 333844 04:43:39 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318590976; Read time: 12; Write time: 169348 04:43:39 INFO - Running post-run listener: _upload_blobber_files 04:43:39 INFO - Blob upload gear active. 04:43:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:40 INFO - (blobuploader) - INFO - Done attempting. 04:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:41 INFO - (blobuploader) - INFO - Done attempting. 04:43:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:41 INFO - Return code: 0 04:43:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48340e420a366bedc39127594d5d52390aa42ebeb1b94875e1185134a17f327c0a1fdf5b2dd46ec4fe25d47698222e0242eca4d3443b649aa4dd930ed62e6820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fdf1e50369dfbf78c2ac4368eb9bf75ffcf66792fa6cc7c3430adeddca4e5b5fb52053b6f5e04e99fc419396e6aab8390651f4b253f5379954328a815129829"} 04:43:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:41 INFO - Contents: 04:43:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48340e420a366bedc39127594d5d52390aa42ebeb1b94875e1185134a17f327c0a1fdf5b2dd46ec4fe25d47698222e0242eca4d3443b649aa4dd930ed62e6820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fdf1e50369dfbf78c2ac4368eb9bf75ffcf66792fa6cc7c3430adeddca4e5b5fb52053b6f5e04e99fc419396e6aab8390651f4b253f5379954328a815129829"} 04:43:41 INFO - Copying logs to upload dir... 04:43:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.382693 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-23 04:43:41.132301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 04:43:41.135491) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48340e420a366bedc39127594d5d52390aa42ebeb1b94875e1185134a17f327c0a1fdf5b2dd46ec4fe25d47698222e0242eca4d3443b649aa4dd930ed62e6820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fdf1e50369dfbf78c2ac4368eb9bf75ffcf66792fa6cc7c3430adeddca4e5b5fb52053b6f5e04e99fc419396e6aab8390651f4b253f5379954328a815129829"} build_url:https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/IDceocHZSwKuzhkyZbmEWw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48340e420a366bedc39127594d5d52390aa42ebeb1b94875e1185134a17f327c0a1fdf5b2dd46ec4fe25d47698222e0242eca4d3443b649aa4dd930ed62e6820", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fdf1e50369dfbf78c2ac4368eb9bf75ffcf66792fa6cc7c3430adeddca4e5b5fb52053b6f5e04e99fc419396e6aab8390651f4b253f5379954328a815129829"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 04:43:41.162790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:43:41.163136) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1450872782.739302-2037598772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 04:43:41.212689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 04:43:41.216009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 04:43:41.216340) ========= ========= Total master_lag: 0.23 =========