builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1452474520.88 results: success (0) buildid: 20160110154031 builduid: cd284599d0604c9795edff27fbb5b028 revision: 6020a4cb41a77a09484c24a5875bb221714c0e6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.876539) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.877012) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.877345) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004316 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.894559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.894858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.905695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.905972) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.954596) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.955018) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.955386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:40.955660) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 17:08:41-- 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% 69.9M=0s 2016-01-10 17:08:41 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:41.136048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:41.136364) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:41.185662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:41.186047) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6020a4cb41a77a09484c24a5875bb221714c0e6a --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 6020a4cb41a77a09484c24a5875bb221714c0e6a --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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 17:08:42,063 truncating revision to first 12 chars 2016-01-10 17:08:42,063 Setting DEBUG logging. 2016-01-10 17:08:42,063 attempt 1/10 2016-01-10 17:08:42,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6020a4cb41a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 17:08:42,650 unpacking tar archive at: mozilla-central-6020a4cb41a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:42.100443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:42.100791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:42.108543) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:42.108988) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 17:08:42.109454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-10 17:08:42.109757) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:43 INFO - MultiFileLogger online at 20160110 17:08:43 in /builds/slave/test 17:08:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:08:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:43 INFO - {'append_to_log': False, 17:08:43 INFO - 'base_work_dir': '/builds/slave/test', 17:08:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:08:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:43 INFO - 'branch': 'Firefox-Non-PGO', 17:08:43 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:43 INFO - 'config_files': ('talos/linux_config.py',), 17:08:43 INFO - 'default_actions': ('clobber', 17:08:43 INFO - 'read-buildbot-config', 17:08:43 INFO - 'download-and-extract', 17:08:43 INFO - 'populate-webroot', 17:08:43 INFO - 'create-virtualenv', 17:08:43 INFO - 'install', 17:08:43 INFO - 'run-tests'), 17:08:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:43 INFO - 'download_minidump_stackwalk': True, 17:08:43 INFO - 'download_symbols': 'ondemand', 17:08:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:43 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:43 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:43 INFO - 'installer_path': 'installer.exe', 17:08:43 INFO - 'log_level': 'info', 17:08:43 INFO - 'log_name': 'talos', 17:08:43 INFO - 'log_to_console': True, 17:08:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:43 INFO - 'opt_config_files': (), 17:08:43 INFO - 'pip_index': False, 17:08:43 INFO - 'sps_profile': False, 17:08:43 INFO - 'sps_profile_interval': 0, 17:08:43 INFO - 'suite': 'dromaeojs-e10s', 17:08:43 INFO - 'system_bits': '32', 17:08:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:43 INFO - 'title': 'talos-linux64-ix-018', 17:08:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:43 INFO - 'use_talos_json': True, 17:08:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:43 INFO - 'work_dir': 'build'} 17:08:43 INFO - ##### 17:08:43 INFO - ##### Running clobber step. 17:08:43 INFO - ##### 17:08:43 INFO - Running pre-action listener: _resource_record_pre_action 17:08:43 INFO - Running main action method: clobber 17:08:43 INFO - rmtree: /builds/slave/test/build 17:08:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:44 INFO - Running post-action listener: _resource_record_post_action 17:08:44 INFO - ##### 17:08:44 INFO - ##### Running read-buildbot-config step. 17:08:44 INFO - ##### 17:08:44 INFO - Running pre-action listener: _resource_record_pre_action 17:08:44 INFO - Running main action method: read_buildbot_config 17:08:44 INFO - Using buildbot properties: 17:08:44 INFO - { 17:08:44 INFO - "project": "", 17:08:44 INFO - "product": "firefox", 17:08:44 INFO - "script_repo_revision": "production", 17:08:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:08:44 INFO - "repository": "", 17:08:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:08:44 INFO - "buildid": "20160110154031", 17:08:44 INFO - "pgo_build": "False", 17:08:44 INFO - "basedir": "/builds/slave/test", 17:08:44 INFO - "buildnumber": 203, 17:08:44 INFO - "slavename": "talos-linux64-ix-018", 17:08:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:08:44 INFO - "platform": "ubuntu64_hw", 17:08:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:08:44 INFO - "branch": "mozilla-central", 17:08:44 INFO - "repo_path": "mozilla-central", 17:08:44 INFO - "revision": "6020a4cb41a77a09484c24a5875bb221714c0e6a", 17:08:44 INFO - "stage_platform": "linux64", 17:08:44 INFO - "builduid": "cd284599d0604c9795edff27fbb5b028", 17:08:44 INFO - "slavebuilddir": "test" 17:08:44 INFO - } 17:08:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:08:44 INFO - Running post-action listener: _resource_record_post_action 17:08:44 INFO - ##### 17:08:44 INFO - ##### Running download-and-extract step. 17:08:44 INFO - ##### 17:08:44 INFO - Running pre-action listener: _resource_record_pre_action 17:08:44 INFO - Running main action method: download_and_extract 17:08:44 INFO - mkdir: /builds/slave/test/build/tests 17:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:44 INFO - https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/test_packages.json 17:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/test_packages.json 17:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:08:44 INFO - Downloaded 1302 bytes. 17:08:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:08:44 INFO - Using the following test package requirements: 17:08:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'jsshell-linux-x86_64.zip'], 17:08:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:44 INFO - https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:47 INFO - Downloaded 22761282 bytes. 17:08:47 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 17:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:47 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 17:08:48 INFO - Return code: 0 17:08:48 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 17:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:48 INFO - https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:50 INFO - Downloaded 22761282 bytes. 17:08:50 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 17:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:08:50 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 17:08:52 INFO - Return code: 0 17:08: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')]} 17:08:52 INFO - https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:54 INFO - Downloaded 11132285 bytes. 17:08:54 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 17:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:54 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 17:08:54 INFO - Return code: 0 17:08:54 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')]} 17:08:54 INFO - https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLSKCJbQTYuH6mj7EITRUA/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 17:08:57 INFO - Downloaded 54050632 bytes. 17:08:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:08:57 INFO - mkdir: /builds/slave/test/properties 17:08:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:57 INFO - Contents: 17:08:57 INFO - build_url:https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:08:57 INFO - Running post-action listener: _resource_record_post_action 17:08:57 INFO - Running post-action listener: set_extra_try_arguments 17:08:57 INFO - ##### 17:08:57 INFO - ##### Running populate-webroot step. 17:08:57 INFO - ##### 17:08:57 INFO - Running pre-action listener: _resource_record_pre_action 17:08:57 INFO - Running main action method: populate_webroot 17:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:57 INFO - '--tppagecycles', 17:08:57 INFO - '7'], 17:08:57 INFO - 'tests': ['tsvgm']}}, 17:08:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:08:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:08:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'tests': ['damp', 'tps']}, 17:08:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['damp', 'tps']}, 17:08:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:57 INFO - 'other': {'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'other_l64': {'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:57 INFO - 'ts_paint', 17:08:57 INFO - 'tpaint', 17:08:57 INFO - 'sessionrestore', 17:08:57 INFO - 'sessionrestore_no_auto_restore']}, 17:08:57 INFO - 'svgr': {'tests': ['tsvgx', 17:08:57 INFO - 'tsvgr_opacity', 17:08:57 INFO - 'tart', 17:08:57 INFO - 'tscrollx', 17:08:57 INFO - 'cart']}, 17:08:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['tsvgx', 17:08:57 INFO - 'tsvgr_opacity', 17:08:57 INFO - 'tart', 17:08:57 INFO - 'tscrollx', 17:08:57 INFO - 'cart']}, 17:08:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'tests': ['tp5o']}, 17:08:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'talos_options': ['--e10s'], 17:08:57 INFO - 'tests': ['tp5o']}, 17:08:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'talos_options': ['--xperf_path', 17:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:57 INFO - 'tests': ['tp5n']}, 17:08:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:57 INFO - 'talos_options': ['--e10s', 17:08:57 INFO - '--xperf_path', 17:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:57 INFO - 'tests': ['tp5n']}}, 17:08:57 INFO - 'talos.zip': {'path': '', 17:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:57 INFO - Running post-action listener: _resource_record_post_action 17:08:57 INFO - ##### 17:08:57 INFO - ##### Running create-virtualenv step. 17:08:57 INFO - ##### 17:08:57 INFO - Running pre-action listener: _resource_record_pre_action 17:08:57 INFO - Running main action method: create_virtualenv 17:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:57 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 17:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:57 INFO - Using real prefix '/usr' 17:08:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:59 INFO - Installing pip.................done. 17:08:59 INFO - Return code: 0 17:08:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:59 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 17:08:59 INFO - Cleaning up... 17:08:59 INFO - Return code: 0 17:08:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:08:59 INFO - Using env: {'DISPLAY': ':0', 17:08:59 INFO - 'HOME': '/home/cltbld', 17:08:59 INFO - 'LANG': 'en_US.UTF-8', 17:08:59 INFO - 'LANGUAGE': 'en_US:en', 17:08:59 INFO - 'LOGNAME': 'cltbld', 17:08:59 INFO - 'MAIL': '/var/mail/cltbld', 17:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:59 INFO - 'MOZ_NO_REMOTE': '1', 17:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:59 INFO - 'NO_EM_RESTART': '1', 17:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:59 INFO - 'PWD': '/builds/slave/test', 17:08:59 INFO - 'SHELL': '/bin/bash', 17:08:59 INFO - 'SHLVL': '1', 17:08:59 INFO - 'TERM': 'linux', 17:08:59 INFO - 'TMOUT': '86400', 17:08:59 INFO - 'USER': 'cltbld', 17:08:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:59 INFO - '_': '/tools/buildbot/bin/python'} 17:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:00 INFO - Downloading/unpacking psutil>=0.7.1 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:09:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:01 INFO - Installing collected packages: psutil 17:09:01 INFO - Running setup.py install for psutil 17:09:01 INFO - building 'psutil._psutil_linux' extension 17:09:01 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 17:09:02 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 17:09:02 INFO - building 'psutil._psutil_posix' extension 17:09:02 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 17:09:02 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 17:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:02 INFO - Successfully installed psutil 17:09:02 INFO - Cleaning up... 17:09:02 INFO - Return code: 0 17:09:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:09:02 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')]} 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:02 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')]} 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:02 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:02 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 17:09:02 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 17:09:02 INFO - Using env: {'DISPLAY': ':0', 17:09:02 INFO - 'HOME': '/home/cltbld', 17:09:02 INFO - 'LANG': 'en_US.UTF-8', 17:09:02 INFO - 'LANGUAGE': 'en_US:en', 17:09:02 INFO - 'LOGNAME': 'cltbld', 17:09:02 INFO - 'MAIL': '/var/mail/cltbld', 17:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:02 INFO - 'MOZ_NO_REMOTE': '1', 17:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:02 INFO - 'NO_EM_RESTART': '1', 17:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:02 INFO - 'PWD': '/builds/slave/test', 17:09:02 INFO - 'SHELL': '/bin/bash', 17:09:02 INFO - 'SHLVL': '1', 17:09:02 INFO - 'TERM': 'linux', 17:09:02 INFO - 'TMOUT': '86400', 17:09:02 INFO - 'USER': 'cltbld', 17:09:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:02 INFO - '_': '/tools/buildbot/bin/python'} 17:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:04 INFO - Installing collected packages: mozsystemmonitor 17:09:04 INFO - Running setup.py install for mozsystemmonitor 17:09:04 INFO - Successfully installed mozsystemmonitor 17:09:04 INFO - Cleaning up... 17:09:04 INFO - Return code: 0 17:09:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:04 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:04 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 17:09:04 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 17:09:04 INFO - Using env: {'DISPLAY': ':0', 17:09:04 INFO - 'HOME': '/home/cltbld', 17:09:04 INFO - 'LANG': 'en_US.UTF-8', 17:09:04 INFO - 'LANGUAGE': 'en_US:en', 17:09:04 INFO - 'LOGNAME': 'cltbld', 17:09:04 INFO - 'MAIL': '/var/mail/cltbld', 17:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:04 INFO - 'MOZ_NO_REMOTE': '1', 17:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:04 INFO - 'NO_EM_RESTART': '1', 17:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:04 INFO - 'PWD': '/builds/slave/test', 17:09:04 INFO - 'SHELL': '/bin/bash', 17:09:04 INFO - 'SHLVL': '1', 17:09:04 INFO - 'TERM': 'linux', 17:09:04 INFO - 'TMOUT': '86400', 17:09:04 INFO - 'USER': 'cltbld', 17:09:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:04 INFO - '_': '/tools/buildbot/bin/python'} 17:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:04 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 17:09:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:06 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 17:09:07 INFO - Downloading docopt-0.6.1.tar.gz 17:09:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:07 INFO - Running setup.py install for blobuploader 17:09:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:07 INFO - Running setup.py install for requests 17:09:07 INFO - Running setup.py install for docopt 17:09:07 INFO - Successfully installed blobuploader requests docopt 17:09:07 INFO - Cleaning up... 17:09:07 INFO - Return code: 0 17:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:07 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:07 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 17:09:07 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 17:09:07 INFO - Using env: {'DISPLAY': ':0', 17:09:07 INFO - 'HOME': '/home/cltbld', 17:09:07 INFO - 'LANG': 'en_US.UTF-8', 17:09:07 INFO - 'LANGUAGE': 'en_US:en', 17:09:07 INFO - 'LOGNAME': 'cltbld', 17:09:07 INFO - 'MAIL': '/var/mail/cltbld', 17:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:07 INFO - 'MOZ_NO_REMOTE': '1', 17:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:07 INFO - 'NO_EM_RESTART': '1', 17:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:07 INFO - 'PWD': '/builds/slave/test', 17:09:07 INFO - 'SHELL': '/bin/bash', 17:09:07 INFO - 'SHLVL': '1', 17:09:07 INFO - 'TERM': 'linux', 17:09:07 INFO - 'TMOUT': '86400', 17:09:07 INFO - 'USER': 'cltbld', 17:09:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:07 INFO - '_': '/tools/buildbot/bin/python'} 17:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:07 INFO - Running setup.py (path:/tmp/pip-armcax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:08 INFO - Running setup.py (path:/tmp/pip-WTd701-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:08 INFO - Running setup.py (path:/tmp/pip-8AF9pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:08 INFO - Running setup.py (path:/tmp/pip-e0womg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Running setup.py (path:/tmp/pip-fCsbUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 INFO - Running setup.py (path:/tmp/pip-71MQWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 INFO - Running setup.py (path:/tmp/pip-hOL_rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Running setup.py (path:/tmp/pip-9WMmX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Running setup.py (path:/tmp/pip-EAui8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Running setup.py (path:/tmp/pip-Cj_hJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Running setup.py (path:/tmp/pip-h6sTI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 INFO - Running setup.py (path:/tmp/pip-kqeReS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:08 INFO - Running setup.py (path:/tmp/pip-sW20ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:08 INFO - Running setup.py (path:/tmp/pip-4a1Zt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:08 INFO - Running setup.py (path:/tmp/pip-fsQiT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Running setup.py (path:/tmp/pip-P0yfGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Running setup.py (path:/tmp/pip-oVVWo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:09 INFO - Running setup.py install for manifestparser 17:09:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozcrash 17:09:09 INFO - Running setup.py install for mozdebug 17:09:09 INFO - Running setup.py install for mozdevice 17:09:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozfile 17:09:09 INFO - Running setup.py install for mozhttpd 17:09:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozinfo 17:09:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozInstall 17:09:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:09 INFO - Running setup.py install for mozleak 17:09:10 INFO - Running setup.py install for mozlog 17:09:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for moznetwork 17:09:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for mozprocess 17:09:10 INFO - Running setup.py install for mozprofile 17:09:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for mozrunner 17:09:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Running setup.py install for mozscreenshot 17:09:10 INFO - Running setup.py install for moztest 17:09:10 INFO - Running setup.py install for mozversion 17:09:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:10 INFO - Cleaning up... 17:09:10 INFO - Return code: 0 17:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:10 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')]} 17:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:10 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')]} 17:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:10 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:10 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 17:09:10 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 17:09:10 INFO - Using env: {'DISPLAY': ':0', 17:09:10 INFO - 'HOME': '/home/cltbld', 17:09:10 INFO - 'LANG': 'en_US.UTF-8', 17:09:10 INFO - 'LANGUAGE': 'en_US:en', 17:09:10 INFO - 'LOGNAME': 'cltbld', 17:09:10 INFO - 'MAIL': '/var/mail/cltbld', 17:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:10 INFO - 'MOZ_NO_REMOTE': '1', 17:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:10 INFO - 'NO_EM_RESTART': '1', 17:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:10 INFO - 'PWD': '/builds/slave/test', 17:09:10 INFO - 'SHELL': '/bin/bash', 17:09:10 INFO - 'SHLVL': '1', 17:09:10 INFO - 'TERM': 'linux', 17:09:10 INFO - 'TMOUT': '86400', 17:09:10 INFO - 'USER': 'cltbld', 17:09:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:10 INFO - '_': '/tools/buildbot/bin/python'} 17:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:11 INFO - Running setup.py (path:/tmp/pip-Dl6XdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:11 INFO - Running setup.py (path:/tmp/pip-uqCtc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:11 INFO - Running setup.py (path:/tmp/pip-Y49TEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:11 INFO - Running setup.py (path:/tmp/pip-c4KCca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:11 INFO - Running setup.py (path:/tmp/pip-j95IHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:11 INFO - Running setup.py (path:/tmp/pip-ZL47Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:11 INFO - Running setup.py (path:/tmp/pip-uBFPqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:11 INFO - Running setup.py (path:/tmp/pip-KqrbdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:11 INFO - Running setup.py (path:/tmp/pip-hT0i5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:11 INFO - Running setup.py (path:/tmp/pip-_dPlQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:11 INFO - Running setup.py (path:/tmp/pip-3_PMdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:11 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)) 17:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:11 INFO - Running setup.py (path:/tmp/pip-AiVTJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:12 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)) 17:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:12 INFO - Running setup.py (path:/tmp/pip-n6oRwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:12 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)) 17:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:12 INFO - Running setup.py (path:/tmp/pip-OMOkwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:12 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)) 17:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:12 INFO - Running setup.py (path:/tmp/pip-LWADh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:12 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)) 17:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:12 INFO - Running setup.py (path:/tmp/pip-9wjK3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:12 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)) 17:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:12 INFO - Running setup.py (path:/tmp/pip-cRi6Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:12 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)) 17:09:12 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)) 17:09:12 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)) 17:09:12 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)) 17:09:12 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)) 17:09:12 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)) 17:09:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:12 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 17:09:14 INFO - Downloading blessings-1.5.1.tar.gz 17:09:14 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 17:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:14 INFO - Installing collected packages: blessings 17:09:14 INFO - Running setup.py install for blessings 17:09:14 INFO - Successfully installed blessings 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:14 INFO - Reading from file tmpfile_stdout 17:09:14 INFO - Current package versions: 17:09:14 INFO - argparse == 1.2.1 17:09:14 INFO - blessings == 1.5.1 17:09:14 INFO - blobuploader == 1.2.4 17:09:14 INFO - docopt == 0.6.1 17:09:14 INFO - manifestparser == 1.1 17:09:14 INFO - mozInstall == 1.12 17:09:14 INFO - mozcrash == 0.16 17:09:14 INFO - mozdebug == 0.1 17:09:14 INFO - mozdevice == 0.47 17:09:14 INFO - mozfile == 1.2 17:09:14 INFO - mozhttpd == 0.7 17:09:14 INFO - mozinfo == 0.9 17:09:14 INFO - mozleak == 0.1 17:09:14 INFO - mozlog == 3.1 17:09:14 INFO - moznetwork == 0.27 17:09:14 INFO - mozprocess == 0.22 17:09:14 INFO - mozprofile == 0.28 17:09:14 INFO - mozrunner == 6.11 17:09:14 INFO - mozscreenshot == 0.1 17:09:14 INFO - mozsystemmonitor == 0.0 17:09:14 INFO - moztest == 0.7 17:09:14 INFO - mozversion == 1.4 17:09:14 INFO - psutil == 3.1.1 17:09:14 INFO - requests == 1.2.3 17:09:14 INFO - wsgiref == 0.1.2 17:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:14 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')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'DISPLAY': ':0', 17:09:14 INFO - 'HOME': '/home/cltbld', 17:09:14 INFO - 'LANG': 'en_US.UTF-8', 17:09:14 INFO - 'LANGUAGE': 'en_US:en', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MAIL': '/var/mail/cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SHLVL': '1', 17:09:14 INFO - 'TERM': 'linux', 17:09:14 INFO - 'TMOUT': '86400', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - '_': '/tools/buildbot/bin/python'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 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)) 17:09:14 INFO - Cleaning up... 17:09:14 INFO - Return code: 0 17:09:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:14 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')]} 17:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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')]} 17:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:14 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 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:14 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 17:09:14 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 17:09:14 INFO - Using env: {'DISPLAY': ':0', 17:09:14 INFO - 'HOME': '/home/cltbld', 17:09:14 INFO - 'LANG': 'en_US.UTF-8', 17:09:14 INFO - 'LANGUAGE': 'en_US:en', 17:09:14 INFO - 'LOGNAME': 'cltbld', 17:09:14 INFO - 'MAIL': '/var/mail/cltbld', 17:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:14 INFO - 'MOZ_NO_REMOTE': '1', 17:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:14 INFO - 'NO_EM_RESTART': '1', 17:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:14 INFO - 'PWD': '/builds/slave/test', 17:09:14 INFO - 'SHELL': '/bin/bash', 17:09:14 INFO - 'SHLVL': '1', 17:09:14 INFO - 'TERM': 'linux', 17:09:14 INFO - 'TMOUT': '86400', 17:09:14 INFO - 'USER': 'cltbld', 17:09:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:14 INFO - '_': '/tools/buildbot/bin/python'} 17:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:14 INFO - Downloading/unpacking jsonschema 17:09:14 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 17:09:14 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 17:09:14 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 17:09:14 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 17:09:14 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 17:09:14 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 17:09:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:16 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 17:09:16 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 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 17:09:16 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:16 INFO - warning: no files found matching '*.txt' 17:09:16 INFO - no previously-included directories found matching 'build' 17:09:16 INFO - no previously-included directories found matching 'dist' 17:09:16 INFO - no previously-included directories found matching '.git*' 17:09:16 INFO - Installing collected packages: jsonschema, functools32 17:09:17 INFO - Running setup.py install for functools32 17:09:17 INFO - warning: no files found matching '*.txt' 17:09:17 INFO - no previously-included directories found matching 'build' 17:09:17 INFO - no previously-included directories found matching 'dist' 17:09:17 INFO - no previously-included directories found matching '.git*' 17:09:17 INFO - Successfully installed jsonschema functools32 17:09:17 INFO - Cleaning up... 17:09:17 INFO - Return code: 0 17:09:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feea2ed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e21dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, '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': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', '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 17:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:09:17 INFO - Using env: {'DISPLAY': ':0', 17:09:17 INFO - 'HOME': '/home/cltbld', 17:09:17 INFO - 'LANG': 'en_US.UTF-8', 17:09:17 INFO - 'LANGUAGE': 'en_US:en', 17:09:17 INFO - 'LOGNAME': 'cltbld', 17:09:17 INFO - 'MAIL': '/var/mail/cltbld', 17:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:17 INFO - 'MOZ_NO_REMOTE': '1', 17:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:17 INFO - 'NO_EM_RESTART': '1', 17:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:17 INFO - 'PWD': '/builds/slave/test', 17:09:17 INFO - 'SHELL': '/bin/bash', 17:09:17 INFO - 'SHLVL': '1', 17:09:17 INFO - 'TERM': 'linux', 17:09:17 INFO - 'TMOUT': '86400', 17:09:17 INFO - 'USER': 'cltbld', 17:09:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:17 INFO - '_': '/tools/buildbot/bin/python'} 17:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:17 INFO - Downloading/unpacking flake8 17:09:17 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 17:09:17 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 17:09:17 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 17:09:17 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 17:09:17 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 17:09:17 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 17:09:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:19 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 17:09:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:19 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 17:09:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 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 17:09:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:19 INFO - no previously-included directories found matching 'docs/_build' 17:09:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:19 INFO - Running setup.py install for pep8 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:19 INFO - no previously-included directories found matching 'docs/_build' 17:09:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:19 INFO - Cleaning up... 17:09:20 INFO - Return code: 0 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - Running post-action listener: _start_resource_monitoring 17:09:20 INFO - Starting resource monitoring. 17:09:20 INFO - ##### 17:09:20 INFO - ##### Running install step. 17:09:20 INFO - ##### 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: install 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:20 INFO - Reading from file tmpfile_stdout 17:09:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:20 INFO - Reading from file tmpfile_stdout 17:09:20 INFO - Output received: 17:09:20 INFO - Usage: mozinstall [options] installer 17:09:20 INFO - Options: 17:09:20 INFO - -h, --help show this help message and exit 17:09:20 INFO - -d DEST, --destination=DEST 17:09:20 INFO - Directory to install application into. [default: 17:09:20 INFO - "/builds/slave/test"] 17:09:20 INFO - --app=APP Application being installed. [default: firefox] 17:09:20 INFO - mkdir: /builds/slave/test/build/application 17:09:20 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'] 17:09:20 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 17:09:36 INFO - Reading from file tmpfile_stdout 17:09:36 INFO - Output received: 17:09:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:36 INFO - Running post-action listener: _resource_record_post_action 17:09:36 INFO - ##### 17:09:36 INFO - ##### Running run-tests step. 17:09:36 INFO - ##### 17:09:36 INFO - Running pre-action listener: _resource_record_pre_action 17:09:36 INFO - Running main action method: run_tests 17:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:36 INFO - Python 2.7.3 17:09:36 INFO - Return code: 0 17:09:36 INFO - grabbing minidump binary from tooltool 17:09: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')]} 17:09:36 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 0x1eb43d0>, '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 0x1e1fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e20360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:36 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 17:09:36 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 17:09:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:36 INFO - Return code: 0 17:09:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:37 INFO - Return code: 0 17:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:09:37 INFO - Using env: {'DISPLAY': ':0', 17:09:37 INFO - 'HOME': '/home/cltbld', 17:09:37 INFO - 'LANG': 'en_US.UTF-8', 17:09:37 INFO - 'LANGUAGE': 'en_US:en', 17:09:37 INFO - 'LOGNAME': 'cltbld', 17:09:37 INFO - 'MAIL': '/var/mail/cltbld', 17:09:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:37 INFO - 'MOZ_NO_REMOTE': '1', 17:09:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:37 INFO - 'NO_EM_RESTART': '1', 17:09:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:37 INFO - 'PWD': '/builds/slave/test', 17:09:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:37 INFO - 'SHELL': '/bin/bash', 17:09:37 INFO - 'SHLVL': '1', 17:09:37 INFO - 'TERM': 'linux', 17:09:37 INFO - 'TMOUT': '86400', 17:09:37 INFO - 'USER': 'cltbld', 17:09:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865', 17:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:37 INFO - '_': '/tools/buildbot/bin/python'} 17:09:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:09:37 INFO - mozversion application_buildid: 20160110154031 17:09:37 INFO - mozversion application_changeset: 6020a4cb41a77a09484c24a5875bb221714c0e6a 17:09:37 INFO - mozversion application_display_name: Nightly 17:09:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:37 INFO - mozversion application_name: Firefox 17:09:37 INFO - mozversion application_remotingname: firefox 17:09:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:09:37 INFO - mozversion application_vendor: Mozilla 17:09:37 INFO - mozversion application_version: 46.0a1 17:09:37 INFO - mozversion platform_buildid: 20160110154031 17:09:37 INFO - mozversion platform_changeset: 6020a4cb41a77a09484c24a5875bb221714c0e6a 17:09:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:09:37 INFO - mozversion platform_version: 46.0a1 17:09:37 INFO - using testdate: 1452474577 17:09:37 INFO - actual date: 1452474577 17:09:37 INFO - starting webserver on 'localhost:39234' 17:09:37 INFO - SUITE-START | Running 3 tests 17:09:37 INFO - TEST-START | dromaeo_css 17:09:37 INFO - operating with platform_type : linux_ 17:09:37 INFO - Initialising browser for dromaeo_css test... 17:09:37 INFO - TEST-INFO | started process 3071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMYFCV/profile http://localhost:39234/getInfo.html) 17:09:40 INFO - PROCESS | 3071 | 17:09:40 INFO - PROCESS | 3071 | (process:3156): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:41 INFO - PROCESS | 3071 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:09:41 INFO - PROCESS | 3071 | __metrics Screen width/height:1600/1200 17:09:41 INFO - PROCESS | 3071 | colorDepth:24 17:09:41 INFO - PROCESS | 3071 | Browser inner width/height: 1024/697 17:09:41 INFO - PROCESS | 3071 | __metrics 17:09:41 INFO - PROCESS | 3071 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:09:42 INFO - TEST-INFO | 3071: exit 0 17:09:42 INFO - Browser initialized. 17:09:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:42 INFO - TEST-INFO | started process 3205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMYFCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:44 INFO - PROCESS | 3205 | 17:09:44 INFO - PROCESS | 3205 | (process:3260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:54 INFO - PROCESS | 3205 | RSS: Main: 150704128 17:09:54 INFO - PROCESS | 3205 | 17:10:44 INFO - PROCESS | 3205 | 1452474644332 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] 17:12:55 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39234/tests/dromaeo/cssquery-ext.html) 17:12:57 INFO - PROCESS | 3205 | RSS: Main: 154144768 17:12:57 INFO - PROCESS | 3205 | 17:15:59 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-ext.html (next: http://localhost:39234/tests/dromaeo/cssquery-jquery.html) 17:15:59 INFO - PROCESS | 3205 | RSS: Main: 153014272 17:15:59 INFO - PROCESS | 3205 | 17:19:01 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39234/tests/dromaeo/cssquery-mootools.html) 17:19:02 INFO - PROCESS | 3205 | RSS: Main: 154017792 17:19:02 INFO - PROCESS | 3205 | 17:22:04 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39234/tests/dromaeo/cssquery-prototype.html) 17:22:04 INFO - PROCESS | 3205 | RSS: Main: 152870912 17:22:04 INFO - PROCESS | 3205 | 17:25:07 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39234/tests/dromaeo/cssquery-yui.html) 17:25:07 INFO - PROCESS | 3205 | RSS: Main: 152797184 17:25:07 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | Cycle 1(1): loaded http://localhost:39234/tests/dromaeo/cssquery-yui.html (next: http://localhost:39234/tests/dromaeo/cssquery-dojo.html) 17:28:10 INFO - PROCESS | 3205 | RSS: Main: 155856896 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | __start_tp_report 17:28:10 INFO - PROCESS | 3205 | _x_x_mozilla_page_load 17:28:10 INFO - PROCESS | 3205 | _x_x_mozilla_page_load_details 17:28:10 INFO - PROCESS | 3205 | |i|pagename|runs| 17:28:10 INFO - PROCESS | 3205 | |0;dojo.html;2598.714141444441;2648.801339899508;2678.866056697165;2691.475162343344;2692.8518931458766;4411.205982923073;4519.435070616169;4586.197415452295;4602.930956035654;4632.166210082188;4469.351943968123;4491.326301054835;4549.24937385331;4646.488886222522;4648.697834640746;4238.66090712743;4304.892377690551;4350.847720329789;4364.345348197764;4399.274119770234;4265.338872474771;4268.551802060785;4342.370356298335;4342.67429942754;4360.14977079468;4083.775392353419;4156.896077598054;4168.43726096976;4182.707210495267;4184.686148538842;4264.104538047014;4274.059706864485;4282.528921818597;4282.892927676802;4293.677974151919;4239.258129827268;4244.702870799046;4264.168487145008;4289.957100428987;4300.6989510734265;4325.52419233884;4389.539098394686;4442.111577684476;4493.730376177407;4531.410916580823;4864.8297309594345;4873.366462359906;4882.609391248727;4893.217085266376;4906.460289368167;4843.321934929113;4874.341963834872;4877.292792545097;4908.337374454439;4933.506649335073;4428.402165707653;4522.819087236539;4565.474970378383;4567.406237189178;4660.627149828006;4952.47998960104;4956.330895329084;4979.278004689299;4995.432520454388;5014.774335154927;4788.449328327218;4798.760061996886;4799.688020278671;4815.277708343777;4865.294532292798;4706.929396059062;4805.8077676892535;4812.639052071108;4931.950680493221;4993.650444468853;4782.450018247877;4790.760461976957;4805.975970120127;4808.773762690562;4854.271859221074;4652.976735116303;4801.95198048022;4814.277858321279;4824.372831531879;4838.7338696372035;4062.7156099073372;4064.878053658395;4067;4075.5109386873764;4089.672826173899;3603.7117030637487;3628.3650361186687;3653.5798383185743;3685.3919103348185;3700.3339398908456;4239.109786944715;4264.829406823755;4268.0183557781265;4272.594103560157;4283.421738065384;4683.976580117078;4760.809567617326;4923.187674033816;4943.950560494349;5016.54851063406;4173.311403618369;4232.809523571446;4242.893927651833;4263.275243208662;4274.016976095515;4364.3017117261725;4399.934000989988;4406.427164468599;4407.228734971367;4418.80115394808;4443.089166720879;4562.749048802348;4654.557817007379;4677.508861569554;4722.220833562424;4945.455999840086;4966.577840883565;4969.0807200668;4976.651634385703;4984.02811451778;4687.67186296956;4701.858944231679;4703.623710103115;4742.573168414721;4749.572538471554;4654.720716757005;4791.353167322367;4806.8798280043275;4878.243872199815;4899.412070551557;4845.927311090407;4854.78153483087;4856.781444835062;4859.878503037452;4911.877203069809;4657.86026419208;4678.508756580646;4685.437747470325;4692.648051396227;4748.430188377417;4574.5425457453985;4671.85984420468;4716.882077948078;4820.517948205292;4855.805767769391;4608.700434471749;4634.490206077397;4637.83767568147;4646.210144275549;4693.624510039121;4639.837605683785;4752.667313288037;4762.642801789811;4769.332293478847;4775.785089670903;4588.059447813257;4604.1252162089095;4607.331936869202;4610.170169369546;4673.3457315976475 17:28:10 INFO - PROCESS | 3205 | |1;ext.html;490.7717911171307;510.4538144185723;527.4698927577784;530.9681419114853;531.9654222475539;31986.68013319866;32849.01452956409;32894;32903.83548082256;32907.67092329076;36048;36055.278894422096;36568.45147322792;36604;36636.26727465449;7632.236776322379;7779.922200777976;7828.80427989302;7836.921630783676;7842.098158711736;7549.169591344948;7636.770896873075;7689.231076892322;7822.061352637691;7827.921720782805;7823.3350165236025;7905.920940790605;7911.683532658687;7913.248241417056;7923.524588524678;7718.266764657376;7837.020372453443;7851.136374998746;7871.134175240719;7901.683932642687;7718.652660630285;7844.49010814301;7851.725189618393;7858.0570331560575;7867.449278550504;37872.242555149016;38227.80886095552;38256.42615360772;38286.425703614186;38297.234055319015;2950.660674022472;2983.3138378173144;3052.664206937235;3064.877404903801;3090.273785660368;28256.576151357745;28493.715062849315;28554.714452855413;28641.28396790076;28731;3381.2730262993327;3455.861765529401;3494;3549.1482044309437;3553.3603951288756;214042;215087;215906;216648;216816.99999999843;47364;48306.27540586894;56260.03089891916;56423.43576564182;56615;62073.37926620676;62974.370256296854;62977.370226298066;63006;63033;12944.805827912589;13193.93403032998;13206.207627542379;13259.535916242885;13340.933295333462;9842.704718858446;9940.552675129637;9947;9988.850167247498;9995.250356223312;18772.906135469235;19009.714854277197;19113.139908703863;19859;19867.205311787366;7699.345555627722;7971.322437592754;8020.11778704342;8034.799130021679;8140.226678465537;818.7953011747063;848.3382961290204;954.61815273891;997.8553109799038;1032.9845052324222;26188.60717089245;26724.064657736886;26738.331541711224;26793.464130717275;26948.461030779275;918.4994178172911;923.6582464488182;923.787528868364;959.0840747086515;1060.1624716474053;13672.179669219879;13872.375743091585;14145.434182632785;14170.929145354414;14212.64468388278;255369;263040;263942;264930;265045;46552.7672361636;46880.29679554809;47290.5270947293;47343.763281183376;47369.52630473651;1221.773971815217;1238.6655602987144;1246.6197809667956;1251.5619533163501;1251.8560365558078;25167.37081572975;25320.873395632905;25494.107706230192;25738.485230294915;26024.8698756505;40962;40969.79515102405;40971.38542921918;41220.351185952226;41335.1732965345;239538;241953;242030;242461;243087;29176.47764596491;39666.206675865746;40626.79686601548;40860.79569602133;40909.590904090575;34940.12649683778;36215;36373.636263637025;38843.64047258333;39434.80282598684;32993.67006330002;33606;33668.49497257592;33945.32109357848;34161.82919085389;36426.45360319544;37511.2497750038;38017.61982380141;38345;38975.41536877006;33636.1590960228;33658.49512257269;33857.66142338545;34554.13614659654;34573.65426345704;35469.46795798116;36113.458298126076;36502;36503;36795.44806827953;27788.861055694593;28671.283217918884;29390.265243369086;29828.552571711007;29921.551176732803 17:28:10 INFO - PROCESS | 3205 | |2;jquery.html;335.1687814220733;337.5830848901606;343.0737010072804;343.4384780883255;344.3148135210931;14353.35409906554;14536.41854325827;14915.179665118414;15743.84256157438;15760.605984850385;10418.114460270866;10834.945825270883;13441;15447.073175609443;15448.845511544881;4605.930911036337;4726.267428548564;4814.422269327668;5082.186850103984;5085.745712714368;5008.39899212095;5088.363954505687;5112.744362781865;5113.411957624883;5125.12872811621;4760.690555113906;4837.911469919275;4854.393200849894;5077.136886729247;5082;4874.731889746063;4964.751762411883;4968.925466118011;4986.5761410280165;5225.2162175673575;5040.5463508284065;5066.164082926312;5069.9746501267255;5070.2141168119;5082.390113186441;11404.885951140466;16387.262573184234;17292.65414691699;17987.19057642409;18103;1849.7410362549253;1859.6466671332403;1872.8408085312765;1898.6582415165265;1930.1893204853995;8619.310455163572;8839;8942.061083586195;8965.193132618097;9344.15902568772;1742.8954262744148;1748.7464317673866;1751.6321572469797;1765.761622181002;1803.2065891007915;48406.757966209945;49806.7509662453;49851.2522312162;50302.496975030146;50414.7479262605;9471.242300615933;9640.276979226446;9759.26805489591;9768.853467197998;9844.261680374;12272.938635306766;12337.753244935051;12375.75248495025;12378.81431778524;12462.189957652723;6821.590704557742;6888.586684798928;6919.204291506541;6932.688029038705;6981.5112942093565;6489.643069631215;6492.318306577741;6494.772682956074;6523.24982627004;6529.412352888168;4119.464469618991;4150.418941348214;4207.116505533811;4216.2832318505925;4232.809523571385;1606.5742578216782;1754.2719771295026;1788.9910550447164;1789.1590952252682;1804.9278028878698;771.4368510987011;820.5609998650693;904.7195369435497;996.4071377530503;1001.2990906365574;13937.651558711113;14459.204743738985;14459.27703614815;15060.171690556905;15545.922270388575;777.366446346226;817.4237162800212;851.527402291734;872.0843114729508;929.1126973740062;8312.625931833081;8425.95787021061;8477.533735644598;8523.678829781395;8627.654893804178;406217;422571;424034;430655;431252;60689.696551517845;62333;62698;62870.68564657147;63022.36977630165;1007.2294694558668;1010.6816352848829;1038.4184856480395;1039.1894322428518;1041.4584416103585;13027.47890084386;13807.654808629462;14050.156990580597;14326.856731432552;14669.193194374411;30448.391032179676;30827.691723082484;31041.534376983913;31301.686983129875;31452.370952581277;37202;37306.25387492289;37500.24999500049;37667.24665506729;39968.60031399765;6523.4128928394775;6690.330966903271;6769.120014398097;6777.051212830109;6872.793816185523;8866.33502487329;9036.186743193144;10047.899521004989;10367.170626350025;10490.94754526253;7963.243491868263;8197.139300373614;8410.201030902055;8522.27560657351;8567.100454452193;8533.701320453754;8623.956880215559;8675.91324086751;8918.86621700662;9089.545522723705;8291.58542072906;8453.915460845314;8495.830083398421;8574.399792014749;8644.56777161152;6793;6975.058367120577;7015.088038554955;7025.758785942451;7026.367626913602;8444.577771111542;8486.618102185294;8521.233089022018;8524;8691.739247822576 17:28:10 INFO - PROCESS | 3205 | |3;mootools.html;1384.3493558027726;1426.4935947738556;1560.3290585048424;1742.5120966129489;1762.0132725673623;6171.876562468759;6264.31092579817;7003.579785212891;7122.074130363052;7159.928400715991;7263.0921134858145;7378.262173782632;7468.813279668011;7479.139898911627;7488.737894173705;2036.4806974221553;2084.98957505213;2091.801278878504;2094.235604004535;2104.221438067917;2068.989655051723;2090.9163633454646;2101.558672678739;2128.936131916045;2132.8507004509693;2041.2447394464068;2090.790920907912;2095.685647152924;2096.8427367947465;2119.501917049492;2111.767705552388;2114.7568029676554;2125.6598944169014;2125.95748085039;2128.404046866872;2102.9948722041595;2117.9682304765442;2121.9257325993517;2127.308624696964;2130.648443006902;7615.200403957616;7647.808804779869;7660.348870346027;7678.769636910902;7698.538087714755;3577.874774382884;3680.190358121209;4250.91498170038;4414.3157810539415;4421.557844215585;2784.763295119917;2812.9859350703114;2826;2826.067397758735;2864.9856750716112;926.0554234680656;940.5203346293371;966.4249771386014;977.2768151567789;984.6799790068185;9931;10067.748306292327;10099.39403635777;10122.987701229891;10135.695929122065;3934.2328245991757;4051.7974101294817;4080.9387859182134;4081.755094694328;4087.4890638670167;9142.725718228463;9186;9231.630734770533;9245.861312080324;9252.768680783034;4523.5024147343765;4538.795754191069;4550.362949187116;4577.404937358188;4578.88552786183;4068.349064149722;4085.428040074392;4085.550589435219;4115.6295933365545;4120.464339635828;3417.333619944087;3424.6061702904485;3443.9827800860835;3472.808995505221;3474.7567670263343;1035.7565971996576;1045.2683121814607;1045.2839804733783;1052.6684094510206;1055.5830446973403;929.697848199338;951.5480146930153;951.752544338477;989.5497548615363;1187.2994932989577;6912.4815638826285;6956.826079348057;6970.059042029363;7001.124859392576;7003.089598352181;446.6850870136546;451.3162558723536;482.36568911880767;486.25602827673714;486.4308758752198;5472.2338872557875;5491.093969495068;5536.612437129363;5541.168824676331;5541.722913854291;9267.212286955684;9440.433573985583;9455.29085318604;9528.094830991045;9624.807503850025;9284.071592840663;9310.394824336396;9357;9369.437833729999;9405.858912116324;6811.9659401702675;6889.586624802528;6906.965465172642;6911.412529934912;6978.371946524837;7100.325469080429;7117.679704413417;7165.713371465083;7178.641067946477;7219.927800721925;8063.629183039015;8206.876896846432;8237.629306681094;8283.50298982063;8310.958445207736;8405.453645513022;8432.662693492191;8446.577671116542;8468.3648726347;8544.102869198645;6738.427233685192;6832.316768323327;6838.692258848463;6840;6886.965565172142;7077.610731409822;7133.037039999534;7154.069970903749;7176;7190.280971902977;6794.456443484608;6909.827254318481;6985.5808651481075;7014.333638304353;7048.682809273492;6827.317268273133;6840.965795170992;6883;6942.375186233263;6973.267806880204;6935.063766391472;6980.092587963735;7035.753748618774;7058.047163633049;7070.71717131309;6205.6586887721605;6220.315765265907;6266.717997690206;6297.52768542352;6310.958691815983;5338.893222135458;5710.914336284876;6231.906521402273;6275.246970363585;6337.144485494399 17:28:10 INFO - PROCESS | 3205 | |4;prototype.html;309.4955222986532;320.608857194223;320.99839500802494;321.4278584120266;321.76028858500405;5485.6982865942355;5547.583931205156;5674.602777805555;5680.545556355492;5683.374828768832;5488.890222195564;5528.087865502197;5560.138178582316;5564.276644036279;5570.108782594785;4149.585041495857;4222.662187025046;4238.173556156551;4307.870763877088;4311.956880431203;4194.4337514435465;4218.873433796975;4249.44757181566;4265.9786701066605;4272.487301523806;4218.97890510547;4232.703710740249;4234.322508398657;4238.279492486269;4240.512341080769;4244.660427165819;4248.256555102845;4250.319948808206;4252.128313695685;4252.87241382759;3699.2971335446177;3699.408094704834;3703.7407381483035;3707.277080969212;3709.4806727058235;5159.845204643867;5255.421903590602;5306.628536002481;5311.814086506993;5323.760430780624;4863.440704319013;4867.075255701406;4868.902621947576;4871.537203965653;4886.096072226649;5778.711064446761;5785.62393444429;5787.739551720183;5799.623024503394;5804.2744656917885;3973.086190176247;3989.3018721723583;3992.061865461614;3995.6603688686496;4019.738716983387;5887.293524777011;6037;6080.635161890256;6117.816465505997;6119.204503414528;4078.34746440574;4095.877123686294;4105.753654780723;4107.240160570304;4114.362273847559;4145.067359844072;4151.045259590311;4162.62536371728;4172.687048471316;4186.455760751083;4791.856244312677;4797.424309082932;4816.638752093607;4817.373741413594;4818.084563932842;5649.406812284733;5804.187413762077;5807.448292412214;5807.477327040587;5819.505342045889;1465.0623600895435;1487.4719474586366;1488.761798112297;1489.858463445971;1490.4261859184292;993.7764003099245;1005.8994100589882;1010.8079464901792;1022.0188618925766;1022.4529876516028;4990.451050384455;5037.420696619935;5037.722925239073;5038.370203724535;5040.924386134211;5790.536757059425;5921.5558833086825;5968.37332080134;6026.397360264026;6048.818535443944;5026.773795179226;5052.469490703496;5068.949310506921;5074.416442109205;5087.3386459759995;3237.530558069114;3268.5587445695;3273.06717585487;3276.3283526876935;3278.0821370016433;5650.660960342392;5705.800296989585;5706.514946229534;5708.429157084258;5742.799002034909;6223.906641400383;6227;6234.1583886175695;6243.531735119885;6256.874862502725;5734.455226753452;5742.598018138774;5742.712864356766;5761.135829625589;5800.6809625471005;6061.605995610271;6067.635941843503;6070.666113363631;6072.817815465543;6086.847828804315;5748.48263656273;5900.793472228452;5905.232319798571;5918.852028699317;5935.851603709942;5695.231143795535;5724.742386592697;5741.397153299011;5744.942550574441;5755.510781583444;4132.834686612622;4155.750654960712;4161.854335098257;4178.101708132766;4186.079062606222;5915.053591425351;6029.75880964774;6044.576879618385;6060.2424696912885;6079.452849243412;5811;5811.501054546586;5815.66239764848;5824.854378640568;5833.125031245348;5815.273090863642;5829.7085145743395;5836.153757705194;5836.912446313394;5847.5906686533235;5574.386817449996;5663.1788390682295;5671.688057156896;5677.233573467694;5712.0860662293835;5853.94146058551;5854.297484301741;5857.677827719516;5859.707014649165;5860.355360910211;5542.140968149944;5685.403032681509;5697.4302569742695;5712.314522257356;5732.828015159552 17:28:10 INFO - PROCESS | 3205 | |5;yui.html;675.3314218923265;729.58049121755;761.8400135971444;776.5263189454429;816.3917881178523;10705.25063245573;10773.138148948085;10976.067034302074;11007.669769906895;11026.834597481035;12692.619221423349;13056.804147937764;13059.216447013187;13069.08516403852;13071.08502404832;619.8109576579142;619.8884200843846;778.2023425988378;782.6321628834439;788.3259812860008;775.5269285735696;782.3936449251847;784.7214238945178;785.8939043229177;790.0677200902933;816.0615292413712;822.0341099208437;825.8183199696088;827.93790465715;833.9249467547919;812.544974814106;812.8577498937663;814.8573999550084;821.2813787935556;826.450410477032;607.0772425912633;608.8143116349512;613.0773186354553;614.3733391940241;614.6926536731634;12127.151099423045;12152.21010634306;12211.511539538407;12226.75546489074;12254.693632659166;11050.281731687415;11229.3262404256;11300.378479183642;11303.321800691903;11748.941255293754;9226.81546369069;9259.814803703955;9294.163525282689;9346.065393460667;9415.482148481831;3023.0930720783895;3045.345250771095;3084.6761090085665;3094.8607312670983;3126.374725054998;38571.22857542834;38912.80543597292;38945.41581876274;38989.415158772645;39007.21985560301;8643.611037503328;8785.385023048326;8848.07095254989;8933.419327743675;9107.134822191882;15714.21428928549;15762.39920413142;15787.447439339798;15813.68372632541;16293.34826606946;5633;5739.713014349266;5747.1379293106365;5782.450667186695;5823.854403639943;3569.4824250484053;3576.2847430514003;3612.313660404515;3629.872954446582;3652.3790955537625;2583.8191326606957;2606.1139212667786;2613.5948927915824;2624.317677403889;2625.921222363332;480.0974168563079;485.9514048595183;486.34829328699715;497.5522030172801;500.01746567994064;407.38078121255523;420.0969607677227;461.31034104014043;505.37333706204777;577.1487056591494;6903.827404314932;7158.355747982707;7196;7426.480146389809;7489.101307842985;477.0982842427814;583.6993948116723;587.8566188762901;590.9097714716341;617.9104029915637;3670.2292518570866;3705.5182826232417;3709.8330575124182;3749.343864823645;3768.246350729865;41681.37477937833;41945.79027104906;42067.7896610515;42270;45570.772146139054;41862.79068604638;42583.14833703308;43239;43997.78001110038;44086.7795661026;36897.26205475876;38158.61841381551;38826.6117338823;38911.80544097262;39779.40330894981;8063.233992770677;8093.5953202340825;8104.068032176139;8205;8465.83068338642;29134.7086529132;29417.85291073531;29967;29971;32280.838595806872;36412.635873641986;36956.44565331576;37187.25625487421;38970.220595587365;39060.41409378805;9813.509324533887;10030.949845250727;10051.447170405698;10086.646967356108;10145.289829712145;11141.610043648434;11367.715807104889;11444.771104578029;11463;12144.817827732415;10362.792744145225;10544.26190166681;10595.311304765166;10665.680029599125;10723.088537474401;10086.445245511273;10225.846612300673;10674.733131671459;10722.410267435054;10790.946045269724;8926.06276340975;9378.859317110113;10363.948180259353;10375.740606484898;10825.188110891557;8669.60986755585;8845.4250473719;9005.187641266164;9039.548022598976;9057.77355566116;8424.747257582283;9085.2731781456;9095.909040909506;9170.541472926194;9191.080891910755 17:28:10 INFO - PROCESS | 3205 | __end_tp_report 17:28:10 INFO - PROCESS | 3205 | __start_cc_report 17:28:10 INFO - PROCESS | 3205 | _x_x_mozilla_cycle_collect,325 17:28:10 INFO - PROCESS | 3205 | __end_cc_report 17:28:10 INFO - PROCESS | 3205 | __startTimestamp1452475690540__endTimestamp 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | ------- Summary: start ------- 17:28:10 INFO - PROCESS | 3205 | Number of tests: 6 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#0] dojo.html Cycles:165 Average:4515.26 Median:4639.84 stddev:446.78 (9.6%) stddev-sans-first:422.10 17:28:10 INFO - PROCESS | 3205 | Values: 2598.7 2648.8 2678.9 2691.5 2692.9 4411.2 4519.4 4586.2 4602.9 4632.2 4469.4 4491.3 4549.2 4646.5 4648.7 4238.7 4304.9 4350.8 4364.3 4399.3 4265.3 4268.6 4342.4 4342.7 4360.1 4083.8 4156.9 4168.4 4182.7 4184.7 4264.1 4274.1 4282.5 4282.9 4293.7 4239.3 4244.7 4264.2 4290.0 4300.7 4325.5 4389.5 4442.1 4493.7 4531.4 4864.8 4873.4 4882.6 4893.2 4906.5 4843.3 4874.3 4877.3 4908.3 4933.5 4428.4 4522.8 4565.5 4567.4 4660.6 4952.5 4956.3 4979.3 4995.4 5014.8 4788.4 4798.8 4799.7 4815.3 4865.3 4706.9 4805.8 4812.6 4932.0 4993.7 4782.5 4790.8 4806.0 4808.8 4854.3 4653.0 4802.0 4814.3 4824.4 4838.7 4062.7 4064.9 4067.0 4075.5 4089.7 3603.7 3628.4 3653.6 3685.4 3700.3 4239.1 4264.8 4268.0 4272.6 4283.4 4684.0 4760.8 4923.2 4944.0 5016.5 4173.3 4232.8 4242.9 4263.3 4274.0 4364.3 4399.9 4406.4 4407.2 4418.8 4443.1 4562.7 4654.6 4677.5 4722.2 4945.5 4966.6 4969.1 4976.7 4984.0 4687.7 4701.9 4703.6 4742.6 4749.6 4654.7 4791.4 4806.9 4878.2 4899.4 4845.9 4854.8 4856.8 4859.9 4911.9 4657.9 4678.5 4685.4 4692.6 4748.4 4574.5 4671.9 4716.9 4820.5 4855.8 4608.7 4634.5 4637.8 4646.2 4693.6 4639.8 4752.7 4762.6 4769.3 4775.8 4588.1 4604.1 4607.3 4610.2 4673.3 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#1] ext.html Cycles:180 Average:40890.41 Median:36464.23 stddev:62627.86 (171.8%) stddev-sans-first:62730.08 17:28:10 INFO - PROCESS | 3205 | Values: 490.8 510.5 527.5 531.0 532.0 31986.7 32849.0 32894.0 32903.8 32907.7 36048.0 36055.3 36568.5 36604.0 36636.3 7632.2 7779.9 7828.8 7836.9 7842.1 7549.2 7636.8 7689.2 7822.1 7827.9 7823.3 7905.9 7911.7 7913.2 7923.5 7718.3 7837.0 7851.1 7871.1 7901.7 7718.7 7844.5 7851.7 7858.1 7867.4 37872.2 38227.8 38256.4 38286.4 38297.2 2950.7 2983.3 3052.7 3064.9 3090.3 28256.6 28493.7 28554.7 28641.3 28731.0 3381.3 3455.9 3494.0 3549.1 3553.4 214042.0 215087.0 215906.0 216648.0 216817.0 47364.0 48306.3 56260.0 56423.4 56615.0 62073.4 62974.4 62977.4 63006.0 63033.0 12944.8 13193.9 13206.2 13259.5 13340.9 9842.7 9940.6 9947.0 9988.9 9995.3 18772.9 19009.7 19113.1 19859.0 19867.2 7699.3 7971.3 8020.1 8034.8 8140.2 818.8 848.3 954.6 997.9 1033.0 26188.6 26724.1 26738.3 26793.5 26948.5 918.5 923.7 923.8 959.1 1060.2 13672.2 13872.4 14145.4 14170.9 14212.6 255369.0 263040.0 263942.0 264930.0 265045.0 46552.8 46880.3 47290.5 47343.8 47369.5 1221.8 1238.7 1246.6 1251.6 1251.9 25167.4 25320.9 25494.1 25738.5 26024.9 40962.0 40969.8 40971.4 41220.4 41335.2 239538.0 241953.0 242030.0 242461.0 243087.0 29176.5 39666.2 40626.8 40860.8 40909.6 34940.1 36215.0 36373.6 38843.6 39434.8 32993.7 33606.0 33668.5 33945.3 34161.8 36426.5 37511.2 38017.6 38345.0 38975.4 33636.2 33658.5 33857.7 34554.1 34573.7 35469.5 36113.5 36502.0 36503.0 36795.4 27788.9 28671.3 29390.3 29828.6 29921.6 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#2] jquery.html Cycles:180 Average:22921.26 Median:27418.91 stddev:69117.30 (252.1%) stddev-sans-first:69290.39 17:28:10 INFO - PROCESS | 3205 | Values: 335.2 337.6 343.1 343.4 344.3 14353.4 14536.4 14915.2 15743.8 15760.6 10418.1 10834.9 13441.0 15447.1 15448.8 4605.9 4726.3 4814.4 5082.2 5085.7 5008.4 5088.4 5112.7 5113.4 5125.1 4760.7 4837.9 4854.4 5077.1 5082.0 4874.7 4964.8 4968.9 4986.6 5225.2 5040.5 5066.2 5070.0 5070.2 5082.4 11404.9 16387.3 17292.7 17987.2 18103.0 1849.7 1859.6 1872.8 1898.7 1930.2 8619.3 8839.0 8942.1 8965.2 9344.2 1742.9 1748.7 1751.6 1765.8 1803.2 48406.8 49806.8 49851.3 50302.5 50414.7 9471.2 9640.3 9759.3 9768.9 9844.3 12272.9 12337.8 12375.8 12378.8 12462.2 6821.6 6888.6 6919.2 6932.7 6981.5 6489.6 6492.3 6494.8 6523.2 6529.4 4119.5 4150.4 4207.1 4216.3 4232.8 1606.6 1754.3 1789.0 1789.2 1804.9 771.4 820.6 904.7 996.4 1001.3 13937.7 14459.2 14459.3 15060.2 15545.9 777.4 817.4 851.5 872.1 929.1 8312.6 8426.0 8477.5 8523.7 8627.7 406217.0 422571.0 424034.0 430655.0 431252.0 60689.7 62333.0 62698.0 62870.7 63022.4 1007.2 1010.7 1038.4 1039.2 1041.5 13027.5 13807.7 14050.2 14326.9 14669.2 30448.4 30827.7 31041.5 31301.7 31452.4 37202.0 37306.3 37500.2 37667.2 39968.6 6523.4 6690.3 6769.1 6777.1 6872.8 8866.3 9036.2 10047.9 10367.2 10490.9 7963.2 8197.1 8410.2 8522.3 8567.1 8533.7 8624.0 8675.9 8918.9 9089.5 8291.6 8453.9 8495.8 8574.4 8644.6 6793.0 6975.1 7015.1 7025.8 7026.4 8444.6 8486.6 8521.2 8524.0 8691.7 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#3] mootools.html Cycles:180 Average:5244.76 Median:6324.05 stddev:2823.53 (44.6%) stddev-sans-first:2816.54 17:28:10 INFO - PROCESS | 3205 | Values: 1384.3 1426.5 1560.3 1742.5 1762.0 6171.9 6264.3 7003.6 7122.1 7159.9 7263.1 7378.3 7468.8 7479.1 7488.7 2036.5 2085.0 2091.8 2094.2 2104.2 2069.0 2090.9 2101.6 2128.9 2132.9 2041.2 2090.8 2095.7 2096.8 2119.5 2111.8 2114.8 2125.7 2126.0 2128.4 2103.0 2118.0 2121.9 2127.3 2130.6 7615.2 7647.8 7660.3 7678.8 7698.5 3577.9 3680.2 4250.9 4414.3 4421.6 2784.8 2813.0 2826.0 2826.1 2865.0 926.1 940.5 966.4 977.3 984.7 9931.0 10067.7 10099.4 10123.0 10135.7 3934.2 4051.8 4080.9 4081.8 4087.5 9142.7 9186.0 9231.6 9245.9 9252.8 4523.5 4538.8 4550.4 4577.4 4578.9 4068.3 4085.4 4085.6 4115.6 4120.5 3417.3 3424.6 3444.0 3472.8 3474.8 1035.8 1045.3 1045.3 1052.7 1055.6 929.7 951.5 951.8 989.5 1187.3 6912.5 6956.8 6970.1 7001.1 7003.1 446.7 451.3 482.4 486.3 486.4 5472.2 5491.1 5536.6 5541.2 5541.7 9267.2 9440.4 9455.3 9528.1 9624.8 9284.1 9310.4 9357.0 9369.4 9405.9 6812.0 6889.6 6907.0 6911.4 6978.4 7100.3 7117.7 7165.7 7178.6 7219.9 8063.6 8206.9 8237.6 8283.5 8311.0 8405.5 8432.7 8446.6 8468.4 8544.1 6738.4 6832.3 6838.7 6840.0 6887.0 7077.6 7133.0 7154.1 7176.0 7190.3 6794.5 6909.8 6985.6 7014.3 7048.7 6827.3 6841.0 6883.0 6942.4 6973.3 6935.1 6980.1 7035.8 7058.0 7070.7 6205.7 6220.3 6266.7 6297.5 6311.0 5338.9 5710.9 6231.9 6275.2 6337.1 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#4] prototype.html Cycles:180 Average:4810.92 Median:5508.49 stddev:1421.07 (25.8%) stddev-sans-first:1384.31 17:28:10 INFO - PROCESS | 3205 | Values: 309.5 320.6 321.0 321.4 321.8 5485.7 5547.6 5674.6 5680.5 5683.4 5488.9 5528.1 5560.1 5564.3 5570.1 4149.6 4222.7 4238.2 4307.9 4312.0 4194.4 4218.9 4249.4 4266.0 4272.5 4219.0 4232.7 4234.3 4238.3 4240.5 4244.7 4248.3 4250.3 4252.1 4252.9 3699.3 3699.4 3703.7 3707.3 3709.5 5159.8 5255.4 5306.6 5311.8 5323.8 4863.4 4867.1 4868.9 4871.5 4886.1 5778.7 5785.6 5787.7 5799.6 5804.3 3973.1 3989.3 3992.1 3995.7 4019.7 5887.3 6037.0 6080.6 6117.8 6119.2 4078.3 4095.9 4105.8 4107.2 4114.4 4145.1 4151.0 4162.6 4172.7 4186.5 4791.9 4797.4 4816.6 4817.4 4818.1 5649.4 5804.2 5807.4 5807.5 5819.5 1465.1 1487.5 1488.8 1489.9 1490.4 993.8 1005.9 1010.8 1022.0 1022.5 4990.5 5037.4 5037.7 5038.4 5040.9 5790.5 5921.6 5968.4 6026.4 6048.8 5026.8 5052.5 5068.9 5074.4 5087.3 3237.5 3268.6 3273.1 3276.3 3278.1 5650.7 5705.8 5706.5 5708.4 5742.8 6223.9 6227.0 6234.2 6243.5 6256.9 5734.5 5742.6 5742.7 5761.1 5800.7 6061.6 6067.6 6070.7 6072.8 6086.8 5748.5 5900.8 5905.2 5918.9 5935.9 5695.2 5724.7 5741.4 5744.9 5755.5 4132.8 4155.8 4161.9 4178.1 4186.1 5915.1 6029.8 6044.6 6060.2 6079.5 5811.0 5811.5 5815.7 5824.9 5833.1 5815.3 5829.7 5836.2 5836.9 5847.6 5574.4 5663.2 5671.7 5677.2 5712.1 5853.9 5854.3 5857.7 5859.7 5860.4 5542.1 5685.4 5697.4 5712.3 5732.8 17:28:10 INFO - PROCESS | 3205 | 17:28:10 INFO - PROCESS | 3205 | [#5] yui.html Cycles:180 Average:11758.86 Median:21182.94 stddev:12880.61 (60.8%) stddev-sans-first:12889.85 17:28:10 INFO - PROCESS | 3205 | Values: 675.3 729.6 761.8 776.5 816.4 10705.3 10773.1 10976.1 11007.7 11026.8 12692.6 13056.8 13059.2 13069.1 13071.1 619.8 619.9 778.2 782.6 788.3 775.5 782.4 784.7 785.9 790.1 816.1 822.0 825.8 827.9 833.9 812.5 812.9 814.9 821.3 826.5 607.1 608.8 613.1 614.4 614.7 12127.2 12152.2 12211.5 12226.8 12254.7 11050.3 11229.3 11300.4 11303.3 11748.9 9226.8 9259.8 9294.2 9346.1 9415.5 3023.1 3045.3 3084.7 3094.9 3126.4 38571.2 38912.8 38945.4 38989.4 39007.2 8643.6 8785.4 8848.1 8933.4 9107.1 15714.2 15762.4 15787.4 15813.7 16293.3 5633.0 5739.7 5747.1 5782.5 5823.9 3569.5 3576.3 3612.3 3629.9 3652.4 2583.8 2606.1 2613.6 2624.3 2625.9 480.1 486.0 486.3 497.6 500.0 407.4 420.1 461.3 505.4 577.1 6903.8 7158.4 7196.0 7426.5 7489.1 477.1 583.7 587.9 590.9 617.9 3670.2 3705.5 3709.8 3749.3 3768.2 41681.4 41945.8 42067.8 42270.0 45570.8 41862.8 42583.1 43239.0 43997.8 44086.8 36897.3 38158.6 38826.6 38911.8 39779.4 8063.2 8093.6 8104.1 8205.0 8465.8 29134.7 29417.9 29967.0 29971.0 32280.8 36412.6 36956.4 37187.3 38970.2 39060.4 9813.5 10030.9 10051.4 10086.6 10145.3 11141.6 11367.7 11444.8 11463.0 12144.8 10362.8 10544.3 10595.3 10665.7 10723.1 10086.4 10225.8 10674.7 10722.4 10790.9 8926.1 9378.9 10363.9 10375.7 10825.2 8669.6 8845.4 9005.2 9039.5 9057.8 8424.7 9085.3 9095.9 9170.5 9191.1 17:28:10 INFO - PROCESS | 3205 | -------- Summary: end -------- 17:28:10 INFO - PROCESS | 3205 | 17:28:11 INFO - TEST-INFO | 3205: exit 0 17:28:11 INFO - TEST-OK | dromaeo_css | took 1114046ms 17:28:11 INFO - TEST-START | kraken 17:28:11 INFO - operating with platform_type : linux_ 17:28:11 INFO - Initialising browser for kraken test... 17:28:11 INFO - TEST-INFO | started process 3443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NSzG1/profile http://localhost:39234/getInfo.html) 17:28:14 INFO - PROCESS | 3443 | 17:28:14 INFO - PROCESS | 3443 | (process:3511): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:28:15 INFO - PROCESS | 3443 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:28:15 INFO - PROCESS | 3443 | __metrics Screen width/height:1600/1200 17:28:15 INFO - PROCESS | 3443 | colorDepth:24 17:28:15 INFO - PROCESS | 3443 | Browser inner width/height: 1024/697 17:28:15 INFO - PROCESS | 3443 | __metrics 17:28:15 INFO - PROCESS | 3443 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:28:16 INFO - TEST-INFO | 3443: exit 0 17:28:16 INFO - Browser initialized. 17:28:16 INFO - Running cycle 1/1 for kraken test... 17:28:16 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NSzG1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:18 INFO - PROCESS | 3560 | 17:28:18 INFO - PROCESS | 3560 | (process:3617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:28:28 INFO - PROCESS | 3560 | RSS: Main: 150540288 17:28:28 INFO - PROCESS | 3560 | 17:28:31 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:32 INFO - PROCESS | 3560 | RSS: Main: 152297472 17:28:32 INFO - PROCESS | 3560 | 17:28:34 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-dft) 17:28:35 INFO - PROCESS | 3560 | RSS: Main: 152481792 17:28:35 INFO - PROCESS | 3560 | 17:28:38 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-fft) 17:28:38 INFO - PROCESS | 3560 | RSS: Main: 147488768 17:28:38 INFO - PROCESS | 3560 | 17:28:41 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39234/tests/kraken/driver.html?testName=audio-oscillator) 17:28:41 INFO - PROCESS | 3560 | RSS: Main: 147726336 17:28:41 INFO - PROCESS | 3560 | 17:28:43 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:44 INFO - PROCESS | 3560 | RSS: Main: 147001344 17:28:44 INFO - PROCESS | 3560 | 17:28:47 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:48 INFO - PROCESS | 3560 | RSS: Main: 147771392 17:28:48 INFO - PROCESS | 3560 | 17:28:51 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39234/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:52 INFO - PROCESS | 3560 | RSS: Main: 146509824 17:28:52 INFO - PROCESS | 3560 | 17:28:55 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39234/tests/kraken/driver.html?testName=json-parse-financial) 17:28:55 INFO - PROCESS | 3560 | RSS: Main: 147288064 17:28:55 INFO - PROCESS | 3560 | 17:28:57 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:58 INFO - PROCESS | 3560 | RSS: Main: 148828160 17:28:58 INFO - PROCESS | 3560 | 17:28:59 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:00 INFO - PROCESS | 3560 | RSS: Main: 149061632 17:29:00 INFO - PROCESS | 3560 | 17:29:02 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:03 INFO - PROCESS | 3560 | RSS: Main: 149188608 17:29:03 INFO - PROCESS | 3560 | 17:29:05 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:06 INFO - PROCESS | 3560 | RSS: Main: 148918272 17:29:06 INFO - PROCESS | 3560 | 17:29:09 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:09 INFO - PROCESS | 3560 | RSS: Main: 149422080 17:29:09 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | Cycle 1(1): loaded http://localhost:39234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39234/tests/kraken/driver.html?testName=ai-astar) 17:29:11 INFO - PROCESS | 3560 | RSS: Main: 148328448 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | __start_tp_report 17:29:11 INFO - PROCESS | 3560 | _x_x_mozilla_page_load 17:29:11 INFO - PROCESS | 3560 | _x_x_mozilla_page_load_details 17:29:11 INFO - PROCESS | 3560 | |i|pagename|runs| 17:29:11 INFO - PROCESS | 3560 | |0;ai-astar;114;109;112;113;112;125;113;112;114;112 17:29:11 INFO - PROCESS | 3560 | |1;audio-beat-detection;154;141;154;171;132;153;156;138;172;137 17:29:11 INFO - PROCESS | 3560 | |2;audio-dft;165;164;164;163;166;167;167;164;165;164 17:29:11 INFO - PROCESS | 3560 | |3;audio-fft;72;73;74;73;133;72;72;72;73;92 17:29:11 INFO - PROCESS | 3560 | |4;audio-oscillator;97;98;137;97;99;98;136;98;97;132 17:29:11 INFO - PROCESS | 3560 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;111;110;109 17:29:11 INFO - PROCESS | 3560 | |6;imaging-darkroom;148;147;148;148;148;149;148;148;147;148 17:29:11 INFO - PROCESS | 3560 | |7;imaging-desaturate;96;96;96;97;96;96;96;97;96;96 17:29:11 INFO - PROCESS | 3560 | |8;json-parse-financial;70;73;72;72;71;73;71;79;69;70 17:29:11 INFO - PROCESS | 3560 | |9;json-stringify-tinderbox;69;69;68;69;69;69;69;71;69;69 17:29:11 INFO - PROCESS | 3560 | |10;stanford-crypto-aes;82;82;83;82;85;83;84;92;83;88 17:29:11 INFO - PROCESS | 3560 | |11;stanford-crypto-ccm;123;122;131;128;141;122;134;121;120;134 17:29:11 INFO - PROCESS | 3560 | |12;stanford-crypto-pbkdf2;142;158;148;148;150;151;160;134;149;146 17:29:11 INFO - PROCESS | 3560 | |13;stanford-crypto-sha256-iterative;75;71;69;73;70;73;77;79;71;71 17:29:11 INFO - PROCESS | 3560 | __end_tp_report 17:29:11 INFO - PROCESS | 3560 | __start_cc_report 17:29:11 INFO - PROCESS | 3560 | _x_x_mozilla_cycle_collect,803 17:29:11 INFO - PROCESS | 3560 | __end_cc_report 17:29:11 INFO - PROCESS | 3560 | __startTimestamp1452475751767__endTimestamp 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | ------- Summary: start ------- 17:29:11 INFO - PROCESS | 3560 | Number of tests: 14 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:4.25 (3.8%) stddev-sans-first:4.50 17:29:11 INFO - PROCESS | 3560 | Values: 114.0 109.0 112.0 113.0 112.0 125.0 113.0 112.0 114.0 112.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.00 stddev:13.80 (9.0%) stddev-sans-first:14.59 17:29:11 INFO - PROCESS | 3560 | Values: 154.0 141.0 154.0 171.0 132.0 153.0 156.0 138.0 172.0 137.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 17:29:11 INFO - PROCESS | 3560 | Values: 165.0 164.0 164.0 163.0 166.0 167.0 167.0 164.0 165.0 164.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:19.40 (26.6%) stddev-sans-first:20.33 17:29:11 INFO - PROCESS | 3560 | Values: 72.0 73.0 74.0 73.0 133.0 72.0 72.0 72.0 73.0 92.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:97.50 stddev:18.06 (18.5%) stddev-sans-first:18.64 17:29:11 INFO - PROCESS | 3560 | Values: 97.0 98.0 137.0 97.0 99.0 98.0 136.0 98.0 97.0 132.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:29:11 INFO - PROCESS | 3560 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:29:11 INFO - PROCESS | 3560 | Values: 148.0 147.0 148.0 148.0 148.0 149.0 148.0 148.0 147.0 148.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:29:11 INFO - PROCESS | 3560 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:2.79 (3.9%) stddev-sans-first:2.86 17:29:11 INFO - PROCESS | 3560 | Values: 70.0 73.0 72.0 72.0 71.0 73.0 71.0 79.0 69.0 70.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 17:29:11 INFO - PROCESS | 3560 | Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 71.0 69.0 69.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:3.24 (3.9%) stddev-sans-first:3.32 17:29:11 INFO - PROCESS | 3560 | Values: 82.0 82.0 83.0 82.0 85.0 83.0 84.0 92.0 83.0 88.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.50 stddev:7.14 (5.5%) stddev-sans-first:7.37 17:29:11 INFO - PROCESS | 3560 | Values: 123.0 122.0 131.0 128.0 141.0 122.0 134.0 121.0 120.0 134.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:149.50 stddev:7.38 (4.9%) stddev-sans-first:7.43 17:29:11 INFO - PROCESS | 3560 | Values: 142.0 158.0 148.0 148.0 150.0 151.0 160.0 134.0 149.0 146.0 17:29:11 INFO - PROCESS | 3560 | 17:29:11 INFO - PROCESS | 3560 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:3.21 (4.4%) stddev-sans-first:3.32 17:29:11 INFO - PROCESS | 3560 | Values: 75.0 71.0 69.0 73.0 70.0 73.0 77.0 79.0 71.0 71.0 17:29:11 INFO - PROCESS | 3560 | -------- Summary: end -------- 17:29:11 INFO - PROCESS | 3560 | 17:29:12 INFO - TEST-INFO | 3560: exit 0 17:29:12 INFO - TEST-OK | kraken | took 61415ms 17:29:12 INFO - TEST-START | v8_7 17:29:12 INFO - operating with platform_type : linux_ 17:29:12 INFO - Initialising browser for v8_7 test... 17:29:12 INFO - TEST-INFO | started process 3846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIwVi9/profile http://localhost:39234/getInfo.html) 17:29:16 INFO - PROCESS | 3846 | 17:29:16 INFO - PROCESS | 3846 | (process:3914): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:16 INFO - PROCESS | 3846 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:29:17 INFO - PROCESS | 3846 | __metrics Screen width/height:1600/1200 17:29:17 INFO - PROCESS | 3846 | colorDepth:24 17:29:17 INFO - PROCESS | 3846 | Browser inner width/height: 1024/697 17:29:17 INFO - PROCESS | 3846 | __metrics 17:29:17 INFO - PROCESS | 3846 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:29:18 INFO - TEST-INFO | 3846: exit 0 17:29:18 INFO - Browser initialized. 17:29:18 INFO - Running cycle 1/1 for v8_7 test... 17:29:18 INFO - TEST-INFO | started process 3963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIwVi9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:19 INFO - PROCESS | 3963 | 17:29:19 INFO - PROCESS | 3963 | (process:4022): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:30 INFO - PROCESS | 3963 | RSS: Main: 150560768 17:29:30 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | Cycle 1(1): loaded http://localhost:39234/tests/v8_7/run.html (next: http://localhost:39234/tests/v8_7/run.html) 17:29:52 INFO - PROCESS | 3963 | RSS: Main: 146042880 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | __start_tp_report 17:29:52 INFO - PROCESS | 3963 | _x_x_mozilla_page_load 17:29:52 INFO - PROCESS | 3963 | _x_x_mozilla_page_load_details 17:29:52 INFO - PROCESS | 3963 | |i|pagename|runs| 17:29:52 INFO - PROCESS | 3963 | |0;Richards;167.02856188408217 17:29:52 INFO - PROCESS | 3963 | |1;DeltaBlue;185.8390633711206 17:29:52 INFO - PROCESS | 3963 | |2;Encrypt;280.42624789680315 17:29:52 INFO - PROCESS | 3963 | |3;Decrypt;5261.780104712042 17:29:52 INFO - PROCESS | 3963 | |4;RayTrace;1097.694840834248 17:29:52 INFO - PROCESS | 3963 | |5;Earley;725.1631617113851 17:29:52 INFO - PROCESS | 3963 | |6;Boyer;12721.518987341773 17:29:52 INFO - PROCESS | 3963 | |7;RegExp;43595.744680851065 17:29:52 INFO - PROCESS | 3963 | |8;Splay;594.3060498220641 17:29:52 INFO - PROCESS | 3963 | |9;NavierStokes;4835.748792270531 17:29:52 INFO - PROCESS | 3963 | __end_tp_report 17:29:52 INFO - PROCESS | 3963 | __startTimestamp1452475792911__endTimestamp 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | ------- Summary: start ------- 17:29:52 INFO - PROCESS | 3963 | Number of tests: 10 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 167.0 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#1] DeltaBlue Cycles:1 Average:185.84 Median:185.84 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 185.8 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 280.4 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 5261.8 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 1097.7 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#5] Earley Cycles:1 Average:725.16 Median:725.16 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 725.2 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#6] Boyer Cycles:1 Average:12721.52 Median:12721.52 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 12721.5 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#7] RegExp Cycles:1 Average:43595.74 Median:43595.74 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 43595.7 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#8] Splay Cycles:1 Average:594.31 Median:594.31 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 594.3 17:29:52 INFO - PROCESS | 3963 | 17:29:52 INFO - PROCESS | 3963 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:29:52 INFO - PROCESS | 3963 | Values: 4835.7 17:29:52 INFO - PROCESS | 3963 | -------- Summary: end -------- 17:29:52 INFO - PROCESS | 3963 | 17:29:53 INFO - TEST-INFO | 3963: exit 0 17:29:53 INFO - TEST-OK | v8_7 | took 41108ms 17:29:53 INFO - SUITE-END | took 1216s 17:29:53 INFO - Completed test suite (00:20:16) 17:29:53 INFO - Working with test: dromaeo_css 17:29:53 INFO - Generating results file: dromaeo_css 17:29:53 INFO - Working with test: kraken 17:29:53 INFO - Generating results file: kraken 17:29:53 INFO - javascript benchmark 17:29:53 INFO - Working with test: v8_7 17:29:53 INFO - Generating results file: v8_7 17:29:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 17:29:53 INFO - process_Request line: dromaeo_css 6217.27 graph.html#tests=[[72,94,43]] 17:29:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:53 INFO - process_Request line: kraken 1547.40 graph.html#tests=[[232,94,43]] 17:29:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:53 INFO - process_Request line: v8_7 20127.76 graph.html#tests=[[230,94,43]] 17:29:53 INFO - RETURN: dromaeo_css: 6217.27 17:29:53 INFO - RETURN: kraken: 1547.40 17:29:53 INFO - RETURN: v8_7: 20127.76 17:29:53 INFO - javascript benchmark 17:29:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2598.714141444441, 2648.801339899508, 2678.866056697165, 2691.475162343344, 2692.8518931458766, 4411.205982923073, 4519.435070616169, 4586.197415452295, 4602.930956035654, 4632.166210082188, 4469.351943968123, 4491.326301054835, 4549.24937385331, 4646.488886222522, 4648.697834640746, 4238.66090712743, 4304.892377690551, 4350.847720329789, 4364.345348197764, 4399.274119770234, 4265.338872474771, 4268.551802060785, 4342.370356298335, 4342.67429942754, 4360.14977079468, 4083.775392353419, 4156.896077598054, 4168.43726096976, 4182.707210495267, 4184.686148538842, 4264.104538047014, 4274.059706864485, 4282.528921818597, 4282.892927676802, 4293.677974151919, 4239.258129827268, 4244.702870799046, 4264.168487145008, 4289.957100428987, 4300.6989510734265, 4325.52419233884, 4389.539098394686, 4442.111577684476, 4493.730376177407, 4531.410916580823, 4864.8297309594345, 4873.366462359906, 4882.609391248727, 4893.217085266376, 4906.460289368167, 4843.321934929113, 4874.341963834872, 4877.292792545097, 4908.337374454439, 4933.506649335073, 4428.402165707653, 4522.819087236539, 4565.474970378383, 4567.406237189178, 4660.627149828006, 4952.47998960104, 4956.330895329084, 4979.278004689299, 4995.432520454388, 5014.774335154927, 4788.449328327218, 4798.760061996886, 4799.688020278671, 4815.277708343777, 4865.294532292798, 4706.929396059062, 4805.8077676892535, 4812.639052071108, 4931.950680493221, 4993.650444468853, 4782.450018247877, 4790.760461976957, 4805.975970120127, 4808.773762690562, 4854.271859221074, 4652.976735116303, 4801.95198048022, 4814.277858321279, 4824.372831531879, 4838.7338696372035, 4062.7156099073372, 4064.878053658395, 4067.0, 4075.5109386873764, 4089.672826173899, 3603.7117030637487, 3628.3650361186687, 3653.5798383185743, 3685.3919103348185, 3700.3339398908456, 4239.109786944715, 4264.829406823755, 4268.0183557781265, 4272.594103560157, 4283.421738065384, 4683.976580117078, 4760.809567617326, 4923.187674033816, 4943.950560494349, 5016.54851063406, 4173.311403618369, 4232.809523571446, 4242.893927651833, 4263.275243208662, 4274.016976095515, 4364.3017117261725, 4399.934000989988, 4406.427164468599, 4407.228734971367, 4418.80115394808, 4443.089166720879, 4562.749048802348, 4654.557817007379, 4677.508861569554, 4722.220833562424, 4945.455999840086, 4966.577840883565, 4969.0807200668, 4976.651634385703, 4984.02811451778, 4687.67186296956, 4701.858944231679, 4703.623710103115, 4742.573168414721, 4749.572538471554, 4654.720716757005, 4791.353167322367, 4806.8798280043275, 4878.243872199815, 4899.412070551557, 4845.927311090407, 4854.78153483087, 4856.781444835062, 4859.878503037452, 4911.877203069809, 4657.86026419208, 4678.508756580646, 4685.437747470325, 4692.648051396227, 4748.430188377417, 4574.5425457453985, 4671.85984420468, 4716.882077948078, 4820.517948205292, 4855.805767769391, 4608.700434471749, 4634.490206077397, 4637.83767568147, 4646.210144275549, 4693.624510039121, 4639.837605683785, 4752.667313288037, 4762.642801789811, 4769.332293478847, 4775.785089670903, 4588.059447813257, 4604.1252162089095, 4607.331936869202, 4610.170169369546, 4673.3457315976475], "unit": "score", "name": "dojo.html", "value": 4488.875502827634}, {"lowerIsBetter": false, "replicates": [490.7717911171307, 510.4538144185723, 527.4698927577784, 530.9681419114853, 531.9654222475539, 31986.68013319866, 32849.01452956409, 32894.0, 32903.83548082256, 32907.67092329076, 36048.0, 36055.278894422096, 36568.45147322792, 36604.0, 36636.26727465449, 7632.236776322379, 7779.922200777976, 7828.80427989302, 7836.921630783676, 7842.098158711736, 7549.169591344948, 7636.770896873075, 7689.231076892322, 7822.061352637691, 7827.921720782805, 7823.3350165236025, 7905.920940790605, 7911.683532658687, 7913.248241417056, 7923.524588524678, 7718.266764657376, 7837.020372453443, 7851.136374998746, 7871.134175240719, 7901.683932642687, 7718.652660630285, 7844.49010814301, 7851.725189618393, 7858.0570331560575, 7867.449278550504, 37872.242555149016, 38227.80886095552, 38256.42615360772, 38286.425703614186, 38297.234055319015, 2950.660674022472, 2983.3138378173144, 3052.664206937235, 3064.877404903801, 3090.273785660368, 28256.576151357745, 28493.715062849315, 28554.714452855413, 28641.28396790076, 28731.0, 3381.2730262993327, 3455.861765529401, 3494.0, 3549.1482044309437, 3553.3603951288756, 214042.0, 215087.0, 215906.0, 216648.0, 216816.99999999843, 47364.0, 48306.27540586894, 56260.03089891916, 56423.43576564182, 56615.0, 62073.37926620676, 62974.370256296854, 62977.370226298066, 63006.0, 63033.0, 12944.805827912589, 13193.93403032998, 13206.207627542379, 13259.535916242885, 13340.933295333462, 9842.704718858446, 9940.552675129637, 9947.0, 9988.850167247498, 9995.250356223312, 18772.906135469235, 19009.714854277197, 19113.139908703863, 19859.0, 19867.205311787366, 7699.345555627722, 7971.322437592754, 8020.11778704342, 8034.799130021679, 8140.226678465537, 818.7953011747063, 848.3382961290204, 954.61815273891, 997.8553109799038, 1032.9845052324222, 26188.60717089245, 26724.064657736886, 26738.331541711224, 26793.464130717275, 26948.461030779275, 918.4994178172911, 923.6582464488182, 923.787528868364, 959.0840747086515, 1060.1624716474053, 13672.179669219879, 13872.375743091585, 14145.434182632785, 14170.929145354414, 14212.64468388278, 255369.0, 263040.0, 263942.0, 264930.0, 265045.0, 46552.7672361636, 46880.29679554809, 47290.5270947293, 47343.763281183376, 47369.52630473651, 1221.773971815217, 1238.6655602987144, 1246.6197809667956, 1251.5619533163501, 1251.8560365558078, 25167.37081572975, 25320.873395632905, 25494.107706230192, 25738.485230294915, 26024.8698756505, 40962.0, 40969.79515102405, 40971.38542921918, 41220.351185952226, 41335.1732965345, 239538.0, 241953.0, 242030.0, 242461.0, 243087.0, 29176.47764596491, 39666.206675865746, 40626.79686601548, 40860.79569602133, 40909.590904090575, 34940.12649683778, 36215.0, 36373.636263637025, 38843.64047258333, 39434.80282598684, 32993.67006330002, 33606.0, 33668.49497257592, 33945.32109357848, 34161.82919085389, 36426.45360319544, 37511.2497750038, 38017.61982380141, 38345.0, 38975.41536877006, 33636.1590960228, 33658.49512257269, 33857.66142338545, 34554.13614659654, 34573.65426345704, 35469.46795798116, 36113.458298126076, 36502.0, 36503.0, 36795.44806827953, 27788.861055694593, 28671.283217918884, 29390.265243369086, 29828.552571711007, 29921.551176732803], "unit": "score", "name": "ext.html", "value": 17118.980342983345}, {"lowerIsBetter": false, "replicates": [335.1687814220733, 337.5830848901606, 343.0737010072804, 343.4384780883255, 344.3148135210931, 14353.35409906554, 14536.41854325827, 14915.179665118414, 15743.84256157438, 15760.605984850385, 10418.114460270866, 10834.945825270883, 13441.0, 15447.073175609443, 15448.845511544881, 4605.930911036337, 4726.267428548564, 4814.422269327668, 5082.186850103984, 5085.745712714368, 5008.39899212095, 5088.363954505687, 5112.744362781865, 5113.411957624883, 5125.12872811621, 4760.690555113906, 4837.911469919275, 4854.393200849894, 5077.136886729247, 5082.0, 4874.731889746063, 4964.751762411883, 4968.925466118011, 4986.5761410280165, 5225.2162175673575, 5040.5463508284065, 5066.164082926312, 5069.9746501267255, 5070.2141168119, 5082.390113186441, 11404.885951140466, 16387.262573184234, 17292.65414691699, 17987.19057642409, 18103.0, 1849.7410362549253, 1859.6466671332403, 1872.8408085312765, 1898.6582415165265, 1930.1893204853995, 8619.310455163572, 8839.0, 8942.061083586195, 8965.193132618097, 9344.15902568772, 1742.8954262744148, 1748.7464317673866, 1751.6321572469797, 1765.761622181002, 1803.2065891007915, 48406.757966209945, 49806.7509662453, 49851.2522312162, 50302.496975030146, 50414.7479262605, 9471.242300615933, 9640.276979226446, 9759.26805489591, 9768.853467197998, 9844.261680374, 12272.938635306766, 12337.753244935051, 12375.75248495025, 12378.81431778524, 12462.189957652723, 6821.590704557742, 6888.586684798928, 6919.204291506541, 6932.688029038705, 6981.5112942093565, 6489.643069631215, 6492.318306577741, 6494.772682956074, 6523.24982627004, 6529.412352888168, 4119.464469618991, 4150.418941348214, 4207.116505533811, 4216.2832318505925, 4232.809523571385, 1606.5742578216782, 1754.2719771295026, 1788.9910550447164, 1789.1590952252682, 1804.9278028878698, 771.4368510987011, 820.5609998650693, 904.7195369435497, 996.4071377530503, 1001.2990906365574, 13937.651558711113, 14459.204743738985, 14459.27703614815, 15060.171690556905, 15545.922270388575, 777.366446346226, 817.4237162800212, 851.527402291734, 872.0843114729508, 929.1126973740062, 8312.625931833081, 8425.95787021061, 8477.533735644598, 8523.678829781395, 8627.654893804178, 406217.0, 422571.0, 424034.0, 430655.0, 431252.0, 60689.696551517845, 62333.0, 62698.0, 62870.68564657147, 63022.36977630165, 1007.2294694558668, 1010.6816352848829, 1038.4184856480395, 1039.1894322428518, 1041.4584416103585, 13027.47890084386, 13807.654808629462, 14050.156990580597, 14326.856731432552, 14669.193194374411, 30448.391032179676, 30827.691723082484, 31041.534376983913, 31301.686983129875, 31452.370952581277, 37202.0, 37306.25387492289, 37500.24999500049, 37667.24665506729, 39968.60031399765, 6523.4128928394775, 6690.330966903271, 6769.120014398097, 6777.051212830109, 6872.793816185523, 8866.33502487329, 9036.186743193144, 10047.899521004989, 10367.170626350025, 10490.94754526253, 7963.243491868263, 8197.139300373614, 8410.201030902055, 8522.27560657351, 8567.100454452193, 8533.701320453754, 8623.956880215559, 8675.91324086751, 8918.86621700662, 9089.545522723705, 8291.58542072906, 8453.915460845314, 8495.830083398421, 8574.399792014749, 8644.56777161152, 6793.0, 6975.058367120577, 7015.088038554955, 7025.758785942451, 7026.367626913602, 8444.577771111542, 8486.618102185294, 8521.233089022018, 8524.0, 8691.739247822576], "unit": "score", "name": "jquery.html", "value": 7406.8974118911965}, {"lowerIsBetter": false, "replicates": [1384.3493558027726, 1426.4935947738556, 1560.3290585048424, 1742.5120966129489, 1762.0132725673623, 6171.876562468759, 6264.31092579817, 7003.579785212891, 7122.074130363052, 7159.928400715991, 7263.0921134858145, 7378.262173782632, 7468.813279668011, 7479.139898911627, 7488.737894173705, 2036.4806974221553, 2084.98957505213, 2091.801278878504, 2094.235604004535, 2104.221438067917, 2068.989655051723, 2090.9163633454646, 2101.558672678739, 2128.936131916045, 2132.8507004509693, 2041.2447394464068, 2090.790920907912, 2095.685647152924, 2096.8427367947465, 2119.501917049492, 2111.767705552388, 2114.7568029676554, 2125.6598944169014, 2125.95748085039, 2128.404046866872, 2102.9948722041595, 2117.9682304765442, 2121.9257325993517, 2127.308624696964, 2130.648443006902, 7615.200403957616, 7647.808804779869, 7660.348870346027, 7678.769636910902, 7698.538087714755, 3577.874774382884, 3680.190358121209, 4250.91498170038, 4414.3157810539415, 4421.557844215585, 2784.763295119917, 2812.9859350703114, 2826.0, 2826.067397758735, 2864.9856750716112, 926.0554234680656, 940.5203346293371, 966.4249771386014, 977.2768151567789, 984.6799790068185, 9931.0, 10067.748306292327, 10099.39403635777, 10122.987701229891, 10135.695929122065, 3934.2328245991757, 4051.7974101294817, 4080.9387859182134, 4081.755094694328, 4087.4890638670167, 9142.725718228463, 9186.0, 9231.630734770533, 9245.861312080324, 9252.768680783034, 4523.5024147343765, 4538.795754191069, 4550.362949187116, 4577.404937358188, 4578.88552786183, 4068.349064149722, 4085.428040074392, 4085.550589435219, 4115.6295933365545, 4120.464339635828, 3417.333619944087, 3424.6061702904485, 3443.9827800860835, 3472.808995505221, 3474.7567670263343, 1035.7565971996576, 1045.2683121814607, 1045.2839804733783, 1052.6684094510206, 1055.5830446973403, 929.697848199338, 951.5480146930153, 951.752544338477, 989.5497548615363, 1187.2994932989577, 6912.4815638826285, 6956.826079348057, 6970.059042029363, 7001.124859392576, 7003.089598352181, 446.6850870136546, 451.3162558723536, 482.36568911880767, 486.25602827673714, 486.4308758752198, 5472.2338872557875, 5491.093969495068, 5536.612437129363, 5541.168824676331, 5541.722913854291, 9267.212286955684, 9440.433573985583, 9455.29085318604, 9528.094830991045, 9624.807503850025, 9284.071592840663, 9310.394824336396, 9357.0, 9369.437833729999, 9405.858912116324, 6811.9659401702675, 6889.586624802528, 6906.965465172642, 6911.412529934912, 6978.371946524837, 7100.325469080429, 7117.679704413417, 7165.713371465083, 7178.641067946477, 7219.927800721925, 8063.629183039015, 8206.876896846432, 8237.629306681094, 8283.50298982063, 8310.958445207736, 8405.453645513022, 8432.662693492191, 8446.577671116542, 8468.3648726347, 8544.102869198645, 6738.427233685192, 6832.316768323327, 6838.692258848463, 6840.0, 6886.965565172142, 7077.610731409822, 7133.037039999534, 7154.069970903749, 7176.0, 7190.280971902977, 6794.456443484608, 6909.827254318481, 6985.5808651481075, 7014.333638304353, 7048.682809273492, 6827.317268273133, 6840.965795170992, 6883.0, 6942.375186233263, 6973.267806880204, 6935.063766391472, 6980.092587963735, 7035.753748618774, 7058.047163633049, 7070.71717131309, 6205.6586887721605, 6220.315765265907, 6266.717997690206, 6297.52768542352, 6310.958691815983, 5338.893222135458, 5710.914336284876, 6231.906521402273, 6275.246970363585, 6337.144485494399], "unit": "score", "name": "mootools.html", "value": 4182.119431188706}, {"lowerIsBetter": false, "replicates": [309.4955222986532, 320.608857194223, 320.99839500802494, 321.4278584120266, 321.76028858500405, 5485.6982865942355, 5547.583931205156, 5674.602777805555, 5680.545556355492, 5683.374828768832, 5488.890222195564, 5528.087865502197, 5560.138178582316, 5564.276644036279, 5570.108782594785, 4149.585041495857, 4222.662187025046, 4238.173556156551, 4307.870763877088, 4311.956880431203, 4194.4337514435465, 4218.873433796975, 4249.44757181566, 4265.9786701066605, 4272.487301523806, 4218.97890510547, 4232.703710740249, 4234.322508398657, 4238.279492486269, 4240.512341080769, 4244.660427165819, 4248.256555102845, 4250.319948808206, 4252.128313695685, 4252.87241382759, 3699.2971335446177, 3699.408094704834, 3703.7407381483035, 3707.277080969212, 3709.4806727058235, 5159.845204643867, 5255.421903590602, 5306.628536002481, 5311.814086506993, 5323.760430780624, 4863.440704319013, 4867.075255701406, 4868.902621947576, 4871.537203965653, 4886.096072226649, 5778.711064446761, 5785.62393444429, 5787.739551720183, 5799.623024503394, 5804.2744656917885, 3973.086190176247, 3989.3018721723583, 3992.061865461614, 3995.6603688686496, 4019.738716983387, 5887.293524777011, 6037.0, 6080.635161890256, 6117.816465505997, 6119.204503414528, 4078.34746440574, 4095.877123686294, 4105.753654780723, 4107.240160570304, 4114.362273847559, 4145.067359844072, 4151.045259590311, 4162.62536371728, 4172.687048471316, 4186.455760751083, 4791.856244312677, 4797.424309082932, 4816.638752093607, 4817.373741413594, 4818.084563932842, 5649.406812284733, 5804.187413762077, 5807.448292412214, 5807.477327040587, 5819.505342045889, 1465.0623600895435, 1487.4719474586366, 1488.761798112297, 1489.858463445971, 1490.4261859184292, 993.7764003099245, 1005.8994100589882, 1010.8079464901792, 1022.0188618925766, 1022.4529876516028, 4990.451050384455, 5037.420696619935, 5037.722925239073, 5038.370203724535, 5040.924386134211, 5790.536757059425, 5921.5558833086825, 5968.37332080134, 6026.397360264026, 6048.818535443944, 5026.773795179226, 5052.469490703496, 5068.949310506921, 5074.416442109205, 5087.3386459759995, 3237.530558069114, 3268.5587445695, 3273.06717585487, 3276.3283526876935, 3278.0821370016433, 5650.660960342392, 5705.800296989585, 5706.514946229534, 5708.429157084258, 5742.799002034909, 6223.906641400383, 6227.0, 6234.1583886175695, 6243.531735119885, 6256.874862502725, 5734.455226753452, 5742.598018138774, 5742.712864356766, 5761.135829625589, 5800.6809625471005, 6061.605995610271, 6067.635941843503, 6070.666113363631, 6072.817815465543, 6086.847828804315, 5748.48263656273, 5900.793472228452, 5905.232319798571, 5918.852028699317, 5935.851603709942, 5695.231143795535, 5724.742386592697, 5741.397153299011, 5744.942550574441, 5755.510781583444, 4132.834686612622, 4155.750654960712, 4161.854335098257, 4178.101708132766, 4186.079062606222, 5915.053591425351, 6029.75880964774, 6044.576879618385, 6060.2424696912885, 6079.452849243412, 5811.0, 5811.501054546586, 5815.66239764848, 5824.854378640568, 5833.125031245348, 5815.273090863642, 5829.7085145743395, 5836.153757705194, 5836.912446313394, 5847.5906686533235, 5574.386817449996, 5663.1788390682295, 5671.688057156896, 5677.233573467694, 5712.0860662293835, 5853.94146058551, 5854.297484301741, 5857.677827719516, 5859.707014649165, 5860.355360910211, 5542.140968149944, 5685.403032681509, 5697.4302569742695, 5712.314522257356, 5732.828015159552], "unit": "score", "name": "prototype.html", "value": 4355.709288608724}, {"lowerIsBetter": false, "replicates": [675.3314218923265, 729.58049121755, 761.8400135971444, 776.5263189454429, 816.3917881178523, 10705.25063245573, 10773.138148948085, 10976.067034302074, 11007.669769906895, 11026.834597481035, 12692.619221423349, 13056.804147937764, 13059.216447013187, 13069.08516403852, 13071.08502404832, 619.8109576579142, 619.8884200843846, 778.2023425988378, 782.6321628834439, 788.3259812860008, 775.5269285735696, 782.3936449251847, 784.7214238945178, 785.8939043229177, 790.0677200902933, 816.0615292413712, 822.0341099208437, 825.8183199696088, 827.93790465715, 833.9249467547919, 812.544974814106, 812.8577498937663, 814.8573999550084, 821.2813787935556, 826.450410477032, 607.0772425912633, 608.8143116349512, 613.0773186354553, 614.3733391940241, 614.6926536731634, 12127.151099423045, 12152.21010634306, 12211.511539538407, 12226.75546489074, 12254.693632659166, 11050.281731687415, 11229.3262404256, 11300.378479183642, 11303.321800691903, 11748.941255293754, 9226.81546369069, 9259.814803703955, 9294.163525282689, 9346.065393460667, 9415.482148481831, 3023.0930720783895, 3045.345250771095, 3084.6761090085665, 3094.8607312670983, 3126.374725054998, 38571.22857542834, 38912.80543597292, 38945.41581876274, 38989.415158772645, 39007.21985560301, 8643.611037503328, 8785.385023048326, 8848.07095254989, 8933.419327743675, 9107.134822191882, 15714.21428928549, 15762.39920413142, 15787.447439339798, 15813.68372632541, 16293.34826606946, 5633.0, 5739.713014349266, 5747.1379293106365, 5782.450667186695, 5823.854403639943, 3569.4824250484053, 3576.2847430514003, 3612.313660404515, 3629.872954446582, 3652.3790955537625, 2583.8191326606957, 2606.1139212667786, 2613.5948927915824, 2624.317677403889, 2625.921222363332, 480.0974168563079, 485.9514048595183, 486.34829328699715, 497.5522030172801, 500.01746567994064, 407.38078121255523, 420.0969607677227, 461.31034104014043, 505.37333706204777, 577.1487056591494, 6903.827404314932, 7158.355747982707, 7196.0, 7426.480146389809, 7489.101307842985, 477.0982842427814, 583.6993948116723, 587.8566188762901, 590.9097714716341, 617.9104029915637, 3670.2292518570866, 3705.5182826232417, 3709.8330575124182, 3749.343864823645, 3768.246350729865, 41681.37477937833, 41945.79027104906, 42067.7896610515, 42270.0, 45570.772146139054, 41862.79068604638, 42583.14833703308, 43239.0, 43997.78001110038, 44086.7795661026, 36897.26205475876, 38158.61841381551, 38826.6117338823, 38911.80544097262, 39779.40330894981, 8063.233992770677, 8093.5953202340825, 8104.068032176139, 8205.0, 8465.83068338642, 29134.7086529132, 29417.85291073531, 29967.0, 29971.0, 32280.838595806872, 36412.635873641986, 36956.44565331576, 37187.25625487421, 38970.220595587365, 39060.41409378805, 9813.509324533887, 10030.949845250727, 10051.447170405698, 10086.646967356108, 10145.289829712145, 11141.610043648434, 11367.715807104889, 11444.771104578029, 11463.0, 12144.817827732415, 10362.792744145225, 10544.26190166681, 10595.311304765166, 10665.680029599125, 10723.088537474401, 10086.445245511273, 10225.846612300673, 10674.733131671459, 10722.410267435054, 10790.946045269724, 8926.06276340975, 9378.859317110113, 10363.948180259353, 10375.740606484898, 10825.188110891557, 8669.60986755585, 8845.4250473719, 9005.187641266164, 9039.548022598976, 9057.77355566116, 8424.747257582283, 9085.2731781456, 9095.909040909506, 9170.541472926194, 9191.080891910755], "unit": "score", "name": "yui.html", "value": 5569.876670771357}], "name": "dromaeo_css", "value": 6217.263932906279}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 112.0, 113.0, 112.0, 125.0, 113.0, 112.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [154.0, 141.0, 154.0, 171.0, 132.0, 153.0, 156.0, 138.0, 172.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 164.0, 163.0, 166.0, 167.0, 167.0, 164.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 73.0, 133.0, 72.0, 72.0, 72.0, 73.0, 92.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 137.0, 97.0, 99.0, 98.0, 136.0, 98.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 72.0, 72.0, 71.0, 73.0, 71.0, 79.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 82.0, 85.0, 83.0, 84.0, 92.0, 83.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 131.0, 128.0, 141.0, 122.0, 134.0, 121.0, 120.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [142.0, 158.0, 148.0, 148.0, 150.0, 151.0, 160.0, 134.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 69.0, 73.0, 70.0, 73.0, 77.0, 79.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.9}], "name": "kraken", "value": 1547.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [185.8390633711206], "unit": "score", "name": "DeltaBlue", "value": 355.78095800000017}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [725.1631617113851], "unit": "score", "name": "Earley", "value": 919.0524770000003}, {"lowerIsBetter": false, "replicates": [12721.518987341773], "unit": "score", "name": "Boyer", "value": 52.38863383084579}, {"lowerIsBetter": false, "replicates": [43595.744680851065], "unit": "score", "name": "RegExp", "value": 20.896190824792566}, {"lowerIsBetter": false, "replicates": [594.3060498220641], "unit": "score", "name": "Splay", "value": 137.11958682634727}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20127.756651494077}]} 17:29:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20127.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1547.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6217.27"}}} 17:29:54 INFO - Return code: 0 17:29:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:54 INFO - # TBPL SUCCESS # 17:29:54 INFO - Running post-action listener: _resource_record_post_action 17:29:54 INFO - Running post-run listener: _resource_record_post_run 17:29:55 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 550006784; Read time: 0; Write time: 541868 17:29:55 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 231235584; Read time: 0; Write time: 316320 17:29:55 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 318771200; Read time: 0; Write time: 225548 17:29:55 INFO - Running post-run listener: _upload_blobber_files 17:29:55 INFO - Blob upload gear active. 17:29:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:55 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 17:29:55 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'] 17:29:55 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 17:29:55 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:56 INFO - (blobuploader) - INFO - Done attempting. 17:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:57 INFO - (blobuploader) - INFO - Done attempting. 17:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:57 INFO - Return code: 0 17:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55f280e274274a2e834800b9563bb263720c81220205beeeb193ad3370a341cb134df2576d816a510d035b177e5adeee5b1d628a9d8d8d1d7e4088062073b0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04749fc9a90c0d23f92331e3a5fcc7901fcd886e5df2dfae557aab49c1689fe94ec39ab4375adba86ec6dfeaadcbfa74a4aac50bd52202d09ffd1b72996408e4"} 17:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:57 INFO - Contents: 17:29:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55f280e274274a2e834800b9563bb263720c81220205beeeb193ad3370a341cb134df2576d816a510d035b177e5adeee5b1d628a9d8d8d1d7e4088062073b0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04749fc9a90c0d23f92331e3a5fcc7901fcd886e5df2dfae557aab49c1689fe94ec39ab4375adba86ec6dfeaadcbfa74a4aac50bd52202d09ffd1b72996408e4"} 17:29:57 INFO - Copying logs to upload dir... 17:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.432978 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-10 17:29:56.566934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:29:56.570206) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55f280e274274a2e834800b9563bb263720c81220205beeeb193ad3370a341cb134df2576d816a510d035b177e5adeee5b1d628a9d8d8d1d7e4088062073b0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04749fc9a90c0d23f92331e3a5fcc7901fcd886e5df2dfae557aab49c1689fe94ec39ab4375adba86ec6dfeaadcbfa74a4aac50bd52202d09ffd1b72996408e4"} build_url:https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/KLSKCJbQTYuH6mj7EITRUA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55f280e274274a2e834800b9563bb263720c81220205beeeb193ad3370a341cb134df2576d816a510d035b177e5adeee5b1d628a9d8d8d1d7e4088062073b0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04749fc9a90c0d23f92331e3a5fcc7901fcd886e5df2dfae557aab49c1689fe94ec39ab4375adba86ec6dfeaadcbfa74a4aac50bd52202d09ffd1b72996408e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:29:56.597573) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:29:56.597927) ========= 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=62c568580acbfdaac3eec7be000001dc-1452474521.33827-219901865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:29:56.678939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:29:56.679292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:29:56.679661) ========= ========= Total master_lag: 0.23 =========