builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1452682224.78 results: success (0) buildid: 20160113013051 builduid: 092652bb562b46ea8e401fd17f66898f revision: 7737b44d63eea024ded2751ae8d92cb72ac741f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.784600) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.785036) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.785375) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006542 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.817990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.818323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.833011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.833324) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.884453) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.884762) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.885185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:24.885497) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 02:50:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.0M=0s 2016-01-13 02:50:26 (83.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.415985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.317598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.317894) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.368363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.368703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7737b44d63eea024ded2751ae8d92cb72ac741f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7737b44d63eea024ded2751ae8d92cb72ac741f9 --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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 02:50:26,143 truncating revision to first 12 chars 2016-01-13 02:50:26,143 Setting DEBUG logging. 2016-01-13 02:50:26,143 attempt 1/10 2016-01-13 02:50:26,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7737b44d63ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 02:50:26,403 unpacking tar archive at: fx-team-7737b44d63ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.952953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.953250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.963765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.964022) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 02:50:25.964437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 02:50:25.964723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:50:26 INFO - MultiFileLogger online at 20160113 02:50:26 in /builds/slave/test 02:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:26 INFO - {'append_to_log': False, 02:50:26 INFO - 'base_work_dir': '/builds/slave/test', 02:50:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:26 INFO - 'config_files': ('talos/linux_config.py',), 02:50:26 INFO - 'default_actions': ('clobber', 02:50:26 INFO - 'read-buildbot-config', 02:50:26 INFO - 'download-and-extract', 02:50:26 INFO - 'populate-webroot', 02:50:26 INFO - 'create-virtualenv', 02:50:26 INFO - 'install', 02:50:26 INFO - 'run-tests'), 02:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:26 INFO - 'download_minidump_stackwalk': True, 02:50:26 INFO - 'download_symbols': 'ondemand', 02:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:26 INFO - 'installer_path': 'installer.exe', 02:50:26 INFO - 'log_level': 'info', 02:50:26 INFO - 'log_name': 'talos', 02:50:26 INFO - 'log_to_console': True, 02:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:50:26 INFO - 'opt_config_files': (), 02:50:26 INFO - 'pip_index': False, 02:50:26 INFO - 'sps_profile': False, 02:50:26 INFO - 'sps_profile_interval': 0, 02:50:26 INFO - 'suite': 'dromaeojs-e10s', 02:50:26 INFO - 'system_bits': '32', 02:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:26 INFO - 'title': 'talos-linux64-ix-010', 02:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:26 INFO - 'use_talos_json': True, 02:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:26 INFO - 'work_dir': 'build'} 02:50:26 INFO - ##### 02:50:26 INFO - ##### Running clobber step. 02:50:26 INFO - ##### 02:50:26 INFO - Running pre-action listener: _resource_record_pre_action 02:50:26 INFO - Running main action method: clobber 02:50:26 INFO - rmtree: /builds/slave/test/build 02:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:27 INFO - Running post-action listener: _resource_record_post_action 02:50:27 INFO - ##### 02:50:27 INFO - ##### Running read-buildbot-config step. 02:50:27 INFO - ##### 02:50:27 INFO - Running pre-action listener: _resource_record_pre_action 02:50:27 INFO - Running main action method: read_buildbot_config 02:50:27 INFO - Using buildbot properties: 02:50:27 INFO - { 02:50:27 INFO - "project": "", 02:50:27 INFO - "product": "firefox", 02:50:27 INFO - "script_repo_revision": "production", 02:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:50:27 INFO - "repository": "", 02:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:50:27 INFO - "buildid": "20160113013051", 02:50:27 INFO - "pgo_build": "False", 02:50:27 INFO - "basedir": "/builds/slave/test", 02:50:27 INFO - "buildnumber": 948, 02:50:27 INFO - "slavename": "talos-linux64-ix-010", 02:50:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:50:27 INFO - "platform": "ubuntu64_hw", 02:50:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:50:27 INFO - "branch": "fx-team", 02:50:27 INFO - "repo_path": "integration/fx-team", 02:50:27 INFO - "revision": "7737b44d63eea024ded2751ae8d92cb72ac741f9", 02:50:27 INFO - "stage_platform": "linux64", 02:50:27 INFO - "builduid": "092652bb562b46ea8e401fd17f66898f", 02:50:27 INFO - "slavebuilddir": "test" 02:50:27 INFO - } 02:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:50:27 INFO - Running post-action listener: _resource_record_post_action 02:50:27 INFO - ##### 02:50:27 INFO - ##### Running download-and-extract step. 02:50:27 INFO - ##### 02:50:27 INFO - Running pre-action listener: _resource_record_pre_action 02:50:27 INFO - Running main action method: download_and_extract 02:50:27 INFO - mkdir: /builds/slave/test/build/tests 02:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:27 INFO - https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/test_packages.json 02:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/test_packages.json 02:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:50:35 INFO - Downloaded 1302 bytes. 02:50:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:50:36 INFO - Using the following test package requirements: 02:50:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:50:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'jsshell-linux-x86_64.zip'], 02:50:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:50:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:50:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:50:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:50:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:50:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:50:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:50: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')]} 02:50:36 INFO - https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:44 INFO - Downloaded 22758864 bytes. 02:50:44 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 02:50:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:44 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 02:50:45 INFO - Return code: 0 02:50:45 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 02:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:45 INFO - https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:49 INFO - Downloaded 22758864 bytes. 02:50:49 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 02:50:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:50:49 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 02:50:50 INFO - Return code: 0 02:50:50 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')]} 02:50:50 INFO - https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:53 INFO - Downloaded 11132285 bytes. 02:50:53 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 02:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:50:53 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 02:50:54 INFO - Return code: 0 02:50: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')]} 02:50:54 INFO - https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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 02:51:01 INFO - Downloaded 53855457 bytes. 02:51:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:51:01 INFO - mkdir: /builds/slave/test/properties 02:51:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:01 INFO - Contents: 02:51:01 INFO - build_url:https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:51:01 INFO - Running post-action listener: _resource_record_post_action 02:51:01 INFO - Running post-action listener: set_extra_try_arguments 02:51:01 INFO - ##### 02:51:01 INFO - ##### Running populate-webroot step. 02:51:01 INFO - ##### 02:51:01 INFO - Running pre-action listener: _resource_record_pre_action 02:51:01 INFO - Running main action method: populate_webroot 02:51:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:01 INFO - '--tppagecycles', 02:51:01 INFO - '7'], 02:51:01 INFO - 'tests': ['tsvgm']}}, 02:51:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:51:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:51:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:51:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'tests': ['damp', 'tps']}, 02:51:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['damp', 'tps']}, 02:51:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:51:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:01 INFO - 'other': {'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'other_l64': {'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'other_nol64': {'tests': ['a11yr', 02:51:01 INFO - 'ts_paint', 02:51:01 INFO - 'tpaint', 02:51:01 INFO - 'sessionrestore', 02:51:01 INFO - 'sessionrestore_no_auto_restore']}, 02:51:01 INFO - 'svgr': {'tests': ['tsvgx', 02:51:01 INFO - 'tsvgr_opacity', 02:51:01 INFO - 'tart', 02:51:01 INFO - 'tscrollx', 02:51:01 INFO - 'cart']}, 02:51:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['tsvgx', 02:51:01 INFO - 'tsvgr_opacity', 02:51:01 INFO - 'tart', 02:51:01 INFO - 'tscrollx', 02:51:01 INFO - 'cart']}, 02:51:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'tests': ['tp5o']}, 02:51:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'talos_options': ['--e10s'], 02:51:01 INFO - 'tests': ['tp5o']}, 02:51:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'talos_options': ['--xperf_path', 02:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:01 INFO - 'tests': ['tp5n']}, 02:51:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:01 INFO - 'talos_options': ['--e10s', 02:51:01 INFO - '--xperf_path', 02:51:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:01 INFO - 'tests': ['tp5n']}}, 02:51:01 INFO - 'talos.zip': {'path': '', 02:51:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:01 INFO - Running post-action listener: _resource_record_post_action 02:51:01 INFO - ##### 02:51:01 INFO - ##### Running create-virtualenv step. 02:51:01 INFO - ##### 02:51:01 INFO - Running pre-action listener: _resource_record_pre_action 02:51:01 INFO - Running main action method: create_virtualenv 02:51:01 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:01 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 02:51:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:01 INFO - Using real prefix '/usr' 02:51:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:03 INFO - Installing pip.................done. 02:51:03 INFO - Return code: 0 02:51:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:03 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')]} 02:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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')]} 02:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:03 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 02:51:03 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 02:51:03 INFO - Using env: {'DISPLAY': ':0', 02:51:03 INFO - 'HOME': '/home/cltbld', 02:51:03 INFO - 'LANG': 'en_US.UTF-8', 02:51:03 INFO - 'LANGUAGE': 'en_US:en', 02:51:03 INFO - 'LOGNAME': 'cltbld', 02:51:03 INFO - 'MAIL': '/var/mail/cltbld', 02:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:03 INFO - 'MOZ_NO_REMOTE': '1', 02:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:03 INFO - 'NO_EM_RESTART': '1', 02:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:03 INFO - 'PWD': '/builds/slave/test', 02:51:03 INFO - 'SHELL': '/bin/bash', 02:51:03 INFO - 'SHLVL': '1', 02:51:03 INFO - 'TERM': 'linux', 02:51:03 INFO - 'TMOUT': '86400', 02:51:03 INFO - 'USER': 'cltbld', 02:51:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:03 INFO - '_': '/tools/buildbot/bin/python'} 02:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:03 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 02:51:03 INFO - Cleaning up... 02:51:03 INFO - Return code: 0 02:51:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:03 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')]} 02:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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')]} 02:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:03 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:03 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 02:51:03 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 02:51:03 INFO - Using env: {'DISPLAY': ':0', 02:51:03 INFO - 'HOME': '/home/cltbld', 02:51:03 INFO - 'LANG': 'en_US.UTF-8', 02:51:03 INFO - 'LANGUAGE': 'en_US:en', 02:51:03 INFO - 'LOGNAME': 'cltbld', 02:51:03 INFO - 'MAIL': '/var/mail/cltbld', 02:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:03 INFO - 'MOZ_NO_REMOTE': '1', 02:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:03 INFO - 'NO_EM_RESTART': '1', 02:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:03 INFO - 'PWD': '/builds/slave/test', 02:51:03 INFO - 'SHELL': '/bin/bash', 02:51:03 INFO - 'SHLVL': '1', 02:51:03 INFO - 'TERM': 'linux', 02:51:03 INFO - 'TMOUT': '86400', 02:51:03 INFO - 'USER': 'cltbld', 02:51:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:03 INFO - '_': '/tools/buildbot/bin/python'} 02:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:04 INFO - Downloading/unpacking psutil>=0.7.1 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:05 INFO - Installing collected packages: psutil 02:51:05 INFO - Running setup.py install for psutil 02:51:05 INFO - building 'psutil._psutil_linux' extension 02:51:05 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 02:51:06 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 02:51:06 INFO - building 'psutil._psutil_posix' extension 02:51:06 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 02:51:06 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 02:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:06 INFO - Successfully installed psutil 02:51:06 INFO - Cleaning up... 02:51:06 INFO - Return code: 0 02:51:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51:06 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')]} 02:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:06 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')]} 02:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:06 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:06 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 02:51:06 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 02:51:06 INFO - Using env: {'DISPLAY': ':0', 02:51:06 INFO - 'HOME': '/home/cltbld', 02:51:06 INFO - 'LANG': 'en_US.UTF-8', 02:51:06 INFO - 'LANGUAGE': 'en_US:en', 02:51:06 INFO - 'LOGNAME': 'cltbld', 02:51:06 INFO - 'MAIL': '/var/mail/cltbld', 02:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:06 INFO - 'MOZ_NO_REMOTE': '1', 02:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:06 INFO - 'NO_EM_RESTART': '1', 02:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:06 INFO - 'PWD': '/builds/slave/test', 02:51:06 INFO - 'SHELL': '/bin/bash', 02:51:06 INFO - 'SHLVL': '1', 02:51:06 INFO - 'TERM': 'linux', 02:51:06 INFO - 'TMOUT': '86400', 02:51:06 INFO - 'USER': 'cltbld', 02:51:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:06 INFO - '_': '/tools/buildbot/bin/python'} 02:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:51:08 INFO - Installing collected packages: mozsystemmonitor 02:51:08 INFO - Running setup.py install for mozsystemmonitor 02:51:08 INFO - Successfully installed mozsystemmonitor 02:51:08 INFO - Cleaning up... 02:51:08 INFO - Return code: 0 02:51:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:08 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')]} 02:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:08 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')]} 02:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:08 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:08 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 02:51:08 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 02:51:08 INFO - Using env: {'DISPLAY': ':0', 02:51:08 INFO - 'HOME': '/home/cltbld', 02:51:08 INFO - 'LANG': 'en_US.UTF-8', 02:51:08 INFO - 'LANGUAGE': 'en_US:en', 02:51:08 INFO - 'LOGNAME': 'cltbld', 02:51:08 INFO - 'MAIL': '/var/mail/cltbld', 02:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:08 INFO - 'MOZ_NO_REMOTE': '1', 02:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:08 INFO - 'NO_EM_RESTART': '1', 02:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:08 INFO - 'PWD': '/builds/slave/test', 02:51:08 INFO - 'SHELL': '/bin/bash', 02:51:08 INFO - 'SHLVL': '1', 02:51:08 INFO - 'TERM': 'linux', 02:51:08 INFO - 'TMOUT': '86400', 02:51:08 INFO - 'USER': 'cltbld', 02:51:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:08 INFO - '_': '/tools/buildbot/bin/python'} 02:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:08 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 02:51:08 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 02:51:08 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 02:51:08 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 02:51:08 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 02:51:08 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 02:51:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:10 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 02:51:11 INFO - Downloading docopt-0.6.1.tar.gz 02:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:11 INFO - Running setup.py install for blobuploader 02:51:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:11 INFO - Running setup.py install for requests 02:51:11 INFO - Running setup.py install for docopt 02:51:11 INFO - Successfully installed blobuploader requests docopt 02:51:11 INFO - Cleaning up... 02:51:11 INFO - Return code: 0 02:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:11 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:11 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 02:51:11 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 02:51:11 INFO - Using env: {'DISPLAY': ':0', 02:51:11 INFO - 'HOME': '/home/cltbld', 02:51:11 INFO - 'LANG': 'en_US.UTF-8', 02:51:11 INFO - 'LANGUAGE': 'en_US:en', 02:51:11 INFO - 'LOGNAME': 'cltbld', 02:51:11 INFO - 'MAIL': '/var/mail/cltbld', 02:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:11 INFO - 'MOZ_NO_REMOTE': '1', 02:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:11 INFO - 'NO_EM_RESTART': '1', 02:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:11 INFO - 'PWD': '/builds/slave/test', 02:51:11 INFO - 'SHELL': '/bin/bash', 02:51:11 INFO - 'SHLVL': '1', 02:51:11 INFO - 'TERM': 'linux', 02:51:11 INFO - 'TMOUT': '86400', 02:51:11 INFO - 'USER': 'cltbld', 02:51:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:11 INFO - '_': '/tools/buildbot/bin/python'} 02:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:12 INFO - Running setup.py (path:/tmp/pip-yiObd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:12 INFO - Running setup.py (path:/tmp/pip-bDUUom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:12 INFO - Running setup.py (path:/tmp/pip-5bELX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:12 INFO - Running setup.py (path:/tmp/pip-M_JyLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:12 INFO - Running setup.py (path:/tmp/pip-GD2lmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:12 INFO - Running setup.py (path:/tmp/pip-LOrN2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:12 INFO - Running setup.py (path:/tmp/pip-JI35Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:12 INFO - Running setup.py (path:/tmp/pip-hJKClc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:12 INFO - Running setup.py (path:/tmp/pip-NLlbFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:12 INFO - Running setup.py (path:/tmp/pip-N7wf4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:12 INFO - Running setup.py (path:/tmp/pip-qBNhjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:12 INFO - Running setup.py (path:/tmp/pip-2kzeDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:12 INFO - Running setup.py (path:/tmp/pip-tjvFQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:12 INFO - Running setup.py (path:/tmp/pip-RBfjcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:13 INFO - Running setup.py (path:/tmp/pip-pVE3wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:13 INFO - Running setup.py (path:/tmp/pip-bidmvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:13 INFO - Running setup.py (path:/tmp/pip-QkfN6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:13 INFO - Running setup.py install for manifestparser 02:51:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Running setup.py install for mozcrash 02:51:13 INFO - Running setup.py install for mozdebug 02:51:13 INFO - Running setup.py install for mozdevice 02:51:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Running setup.py install for mozfile 02:51:13 INFO - Running setup.py install for mozhttpd 02:51:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Running setup.py install for mozinfo 02:51:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:13 INFO - Running setup.py install for mozInstall 02:51:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Running setup.py install for mozleak 02:51:14 INFO - Running setup.py install for mozlog 02:51:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Running setup.py install for moznetwork 02:51:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Running setup.py install for mozprocess 02:51:14 INFO - Running setup.py install for mozprofile 02:51:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Running setup.py install for mozrunner 02:51:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Running setup.py install for mozscreenshot 02:51:14 INFO - Running setup.py install for moztest 02:51:14 INFO - Running setup.py install for mozversion 02:51:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:14 INFO - Cleaning up... 02:51:14 INFO - Return code: 0 02:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:15 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 02:51:15 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 02:51:15 INFO - Using env: {'DISPLAY': ':0', 02:51:15 INFO - 'HOME': '/home/cltbld', 02:51:15 INFO - 'LANG': 'en_US.UTF-8', 02:51:15 INFO - 'LANGUAGE': 'en_US:en', 02:51:15 INFO - 'LOGNAME': 'cltbld', 02:51:15 INFO - 'MAIL': '/var/mail/cltbld', 02:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:15 INFO - 'MOZ_NO_REMOTE': '1', 02:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:15 INFO - 'NO_EM_RESTART': '1', 02:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:15 INFO - 'PWD': '/builds/slave/test', 02:51:15 INFO - 'SHELL': '/bin/bash', 02:51:15 INFO - 'SHLVL': '1', 02:51:15 INFO - 'TERM': 'linux', 02:51:15 INFO - 'TMOUT': '86400', 02:51:15 INFO - 'USER': 'cltbld', 02:51:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:15 INFO - '_': '/tools/buildbot/bin/python'} 02:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:15 INFO - Running setup.py (path:/tmp/pip-_kwdvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:15 INFO - Running setup.py (path:/tmp/pip-aL_tuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:15 INFO - Running setup.py (path:/tmp/pip-3vjFFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:15 INFO - Running setup.py (path:/tmp/pip-DBacd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:15 INFO - Running setup.py (path:/tmp/pip-JXhk7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:15 INFO - Running setup.py (path:/tmp/pip-m28ajY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:15 INFO - Running setup.py (path:/tmp/pip-t3xVp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:15 INFO - Running setup.py (path:/tmp/pip-x9YxWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:15 INFO - Running setup.py (path:/tmp/pip-UjEHA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:15 INFO - Running setup.py (path:/tmp/pip-nLcfSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:15 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)) 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:15 INFO - Running setup.py (path:/tmp/pip-U7Ih6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:16 INFO - Running setup.py (path:/tmp/pip-0mMhqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:16 INFO - Running setup.py (path:/tmp/pip-iSCAL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:16 INFO - Running setup.py (path:/tmp/pip-IQsM9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:16 INFO - Running setup.py (path:/tmp/pip-W5m4K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:16 INFO - Running setup.py (path:/tmp/pip-H_6BBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:16 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)) 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:16 INFO - Running setup.py (path:/tmp/pip-LjpxY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:16 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)) 02:51:16 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)) 02:51:16 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)) 02:51:16 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)) 02:51:16 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)) 02:51:16 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)) 02:51:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:18 INFO - Downloading blessings-1.5.1.tar.gz 02:51:18 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 02:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:18 INFO - Installing collected packages: blessings 02:51:18 INFO - Running setup.py install for blessings 02:51:18 INFO - Successfully installed blessings 02:51:18 INFO - Cleaning up... 02:51:18 INFO - Return code: 0 02:51:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:18 INFO - Reading from file tmpfile_stdout 02:51:18 INFO - Current package versions: 02:51:18 INFO - argparse == 1.2.1 02:51:18 INFO - blessings == 1.5.1 02:51:18 INFO - blobuploader == 1.2.4 02:51:18 INFO - docopt == 0.6.1 02:51:18 INFO - manifestparser == 1.1 02:51:18 INFO - mozInstall == 1.12 02:51:18 INFO - mozcrash == 0.16 02:51:18 INFO - mozdebug == 0.1 02:51:18 INFO - mozdevice == 0.47 02:51:18 INFO - mozfile == 1.2 02:51:18 INFO - mozhttpd == 0.7 02:51:18 INFO - mozinfo == 0.9 02:51:18 INFO - mozleak == 0.1 02:51:18 INFO - mozlog == 3.1 02:51:18 INFO - moznetwork == 0.27 02:51:18 INFO - mozprocess == 0.22 02:51:18 INFO - mozprofile == 0.28 02:51:18 INFO - mozrunner == 6.11 02:51:18 INFO - mozscreenshot == 0.1 02:51:18 INFO - mozsystemmonitor == 0.0 02:51:18 INFO - moztest == 0.7 02:51:18 INFO - mozversion == 1.4 02:51:18 INFO - psutil == 3.1.1 02:51:18 INFO - requests == 1.2.3 02:51:18 INFO - wsgiref == 0.1.2 02:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:18 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:18 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 02:51:18 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 02:51:18 INFO - Using env: {'DISPLAY': ':0', 02:51:18 INFO - 'HOME': '/home/cltbld', 02:51:18 INFO - 'LANG': 'en_US.UTF-8', 02:51:18 INFO - 'LANGUAGE': 'en_US:en', 02:51:18 INFO - 'LOGNAME': 'cltbld', 02:51:18 INFO - 'MAIL': '/var/mail/cltbld', 02:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:18 INFO - 'MOZ_NO_REMOTE': '1', 02:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:18 INFO - 'NO_EM_RESTART': '1', 02:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:18 INFO - 'PWD': '/builds/slave/test', 02:51:18 INFO - 'SHELL': '/bin/bash', 02:51:18 INFO - 'SHLVL': '1', 02:51:18 INFO - 'TERM': 'linux', 02:51:18 INFO - 'TMOUT': '86400', 02:51:18 INFO - 'USER': 'cltbld', 02:51:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:18 INFO - '_': '/tools/buildbot/bin/python'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 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)) 02:51:19 INFO - Cleaning up... 02:51:19 INFO - Return code: 0 02:51:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:19 INFO - Using env: {'DISPLAY': ':0', 02:51:19 INFO - 'HOME': '/home/cltbld', 02:51:19 INFO - 'LANG': 'en_US.UTF-8', 02:51:19 INFO - 'LANGUAGE': 'en_US:en', 02:51:19 INFO - 'LOGNAME': 'cltbld', 02:51:19 INFO - 'MAIL': '/var/mail/cltbld', 02:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:19 INFO - 'MOZ_NO_REMOTE': '1', 02:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:19 INFO - 'NO_EM_RESTART': '1', 02:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:19 INFO - 'PWD': '/builds/slave/test', 02:51:19 INFO - 'SHELL': '/bin/bash', 02:51:19 INFO - 'SHLVL': '1', 02:51:19 INFO - 'TERM': 'linux', 02:51:19 INFO - 'TMOUT': '86400', 02:51:19 INFO - 'USER': 'cltbld', 02:51:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:19 INFO - '_': '/tools/buildbot/bin/python'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 INFO - Downloading/unpacking jsonschema 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:20 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 02:51:20 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:21 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:21 INFO - warning: no files found matching '*.txt' 02:51:21 INFO - no previously-included directories found matching 'build' 02:51:21 INFO - no previously-included directories found matching 'dist' 02:51:21 INFO - no previously-included directories found matching '.git*' 02:51:21 INFO - Installing collected packages: jsonschema, functools32 02:51:21 INFO - Running setup.py install for functools32 02:51:21 INFO - warning: no files found matching '*.txt' 02:51:21 INFO - no previously-included directories found matching 'build' 02:51:21 INFO - no previously-included directories found matching 'dist' 02:51:21 INFO - no previously-included directories found matching '.git*' 02:51:21 INFO - Successfully installed jsonschema functools32 02:51:21 INFO - Cleaning up... 02:51:21 INFO - Return code: 0 02:51:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:21 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')]} 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 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')]} 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:21 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 0x7f7185802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf12dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, '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': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', '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 02:51:21 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 02:51:21 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 02:51:21 INFO - Using env: {'DISPLAY': ':0', 02:51:21 INFO - 'HOME': '/home/cltbld', 02:51:21 INFO - 'LANG': 'en_US.UTF-8', 02:51:21 INFO - 'LANGUAGE': 'en_US:en', 02:51:21 INFO - 'LOGNAME': 'cltbld', 02:51:21 INFO - 'MAIL': '/var/mail/cltbld', 02:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:21 INFO - 'MOZ_NO_REMOTE': '1', 02:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:21 INFO - 'NO_EM_RESTART': '1', 02:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:21 INFO - 'PWD': '/builds/slave/test', 02:51:21 INFO - 'SHELL': '/bin/bash', 02:51:21 INFO - 'SHLVL': '1', 02:51:21 INFO - 'TERM': 'linux', 02:51:21 INFO - 'TMOUT': '86400', 02:51:21 INFO - 'USER': 'cltbld', 02:51:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:21 INFO - '_': '/tools/buildbot/bin/python'} 02:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:21 INFO - Downloading/unpacking flake8 02:51:21 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 02:51:21 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 02:51:21 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 02:51:21 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 02:51:21 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 02:51:21 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 02:51:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:23 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 02:51:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:23 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 02:51:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 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 02:51:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:23 INFO - no previously-included directories found matching 'docs/_build' 02:51:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:24 INFO - Running setup.py install for pep8 02:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:24 INFO - no previously-included directories found matching 'docs/_build' 02:51:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:24 INFO - Cleaning up... 02:51:24 INFO - Return code: 0 02:51:24 INFO - Running post-action listener: _resource_record_post_action 02:51:24 INFO - Running post-action listener: _start_resource_monitoring 02:51:24 INFO - Starting resource monitoring. 02:51:24 INFO - ##### 02:51:24 INFO - ##### Running install step. 02:51:24 INFO - ##### 02:51:24 INFO - Running pre-action listener: _resource_record_pre_action 02:51:24 INFO - Running main action method: install 02:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:24 INFO - Reading from file tmpfile_stdout 02:51:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:24 INFO - Reading from file tmpfile_stdout 02:51:24 INFO - Output received: 02:51:24 INFO - Usage: mozinstall [options] installer 02:51:24 INFO - Options: 02:51:24 INFO - -h, --help show this help message and exit 02:51:24 INFO - -d DEST, --destination=DEST 02:51:24 INFO - Directory to install application into. [default: 02:51:24 INFO - "/builds/slave/test"] 02:51:24 INFO - --app=APP Application being installed. [default: firefox] 02:51:24 INFO - mkdir: /builds/slave/test/build/application 02:51:24 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'] 02:51:24 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 02:51:40 INFO - Reading from file tmpfile_stdout 02:51:40 INFO - Output received: 02:51:40 INFO - /builds/slave/test/build/application/firefox/firefox 02:51:40 INFO - Running post-action listener: _resource_record_post_action 02:51:40 INFO - ##### 02:51:40 INFO - ##### Running run-tests step. 02:51:40 INFO - ##### 02:51:40 INFO - Running pre-action listener: _resource_record_pre_action 02:51:40 INFO - Running main action method: run_tests 02:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:51:40 INFO - Python 2.7.3 02:51:40 INFO - Return code: 0 02:51:40 INFO - grabbing minidump binary from tooltool 02:51:40 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')]} 02:51:40 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 0xfa53d0>, '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 0xf10ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf11360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:51:40 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 02:51:40 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 02:51:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:51:40 INFO - Return code: 0 02:51:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:51:41 INFO - Return code: 0 02:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 02:51:41 INFO - Using env: {'DISPLAY': ':0', 02:51:41 INFO - 'HOME': '/home/cltbld', 02:51:41 INFO - 'LANG': 'en_US.UTF-8', 02:51:41 INFO - 'LANGUAGE': 'en_US:en', 02:51:41 INFO - 'LOGNAME': 'cltbld', 02:51:41 INFO - 'MAIL': '/var/mail/cltbld', 02:51:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:51:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:41 INFO - 'MOZ_NO_REMOTE': '1', 02:51:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:41 INFO - 'NO_EM_RESTART': '1', 02:51:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:41 INFO - 'PWD': '/builds/slave/test', 02:51:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:51:41 INFO - 'SHELL': '/bin/bash', 02:51:41 INFO - 'SHLVL': '1', 02:51:41 INFO - 'TERM': 'linux', 02:51:41 INFO - 'TMOUT': '86400', 02:51:41 INFO - 'USER': 'cltbld', 02:51:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956', 02:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:41 INFO - '_': '/tools/buildbot/bin/python'} 02:51:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:51:41 INFO - mozversion application_buildid: 20160113013051 02:51:41 INFO - mozversion application_changeset: 7737b44d63eea024ded2751ae8d92cb72ac741f9 02:51:41 INFO - mozversion application_display_name: Nightly 02:51:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:51:41 INFO - mozversion application_name: Firefox 02:51:41 INFO - mozversion application_remotingname: firefox 02:51:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:51:41 INFO - mozversion application_vendor: Mozilla 02:51:41 INFO - mozversion application_version: 46.0a1 02:51:41 INFO - mozversion platform_buildid: 20160113013051 02:51:41 INFO - mozversion platform_changeset: 7737b44d63eea024ded2751ae8d92cb72ac741f9 02:51:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:51:41 INFO - mozversion platform_version: 46.0a1 02:51:41 INFO - using testdate: 1452682301 02:51:41 INFO - actual date: 1452682301 02:51:41 INFO - starting webserver on 'localhost:37710' 02:51:41 INFO - SUITE-START | Running 3 tests 02:51:41 INFO - TEST-START | dromaeo_css 02:51:41 INFO - operating with platform_type : linux_ 02:51:41 INFO - Initialising browser for dromaeo_css test... 02:51:41 INFO - TEST-INFO | started process 31489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzF6QQU/profile http://localhost:37710/getInfo.html) 02:51:45 INFO - PROCESS | 31489 | 02:51:45 INFO - PROCESS | 31489 | (process:31572): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:51:46 INFO - PROCESS | 31489 | __metrics Screen width/height:1600/1200 02:51:46 INFO - PROCESS | 31489 | colorDepth:24 02:51:46 INFO - PROCESS | 31489 | Browser inner width/height: 1024/697 02:51:46 INFO - PROCESS | 31489 | __metrics 02:51:46 INFO - PROCESS | 31489 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:51:46 INFO - PROCESS | 31489 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:51:47 INFO - TEST-INFO | 31489: exit 0 02:51:47 INFO - Browser initialized. 02:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 02:51:47 INFO - TEST-INFO | started process 31622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzF6QQU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:49 INFO - PROCESS | 31622 | 02:51:49 INFO - PROCESS | 31622 | (process:31680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:51:59 INFO - PROCESS | 31622 | RSS: Main: 149454848 02:51:59 INFO - PROCESS | 31622 | 02:52:49 INFO - PROCESS | 31622 | 1452682369370 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] 02:55:00 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37710/tests/dromaeo/cssquery-ext.html) 02:55:01 INFO - PROCESS | 31622 | RSS: Main: 153288704 02:55:01 INFO - PROCESS | 31622 | 02:58:03 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-ext.html (next: http://localhost:37710/tests/dromaeo/cssquery-jquery.html) 02:58:04 INFO - PROCESS | 31622 | RSS: Main: 150802432 02:58:04 INFO - PROCESS | 31622 | 03:01:06 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37710/tests/dromaeo/cssquery-mootools.html) 03:01:06 INFO - PROCESS | 31622 | RSS: Main: 152367104 03:01:06 INFO - PROCESS | 31622 | 03:04:08 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37710/tests/dromaeo/cssquery-prototype.html) 03:04:09 INFO - PROCESS | 31622 | RSS: Main: 149610496 03:04:09 INFO - PROCESS | 31622 | 03:07:11 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37710/tests/dromaeo/cssquery-yui.html) 03:07:12 INFO - PROCESS | 31622 | RSS: Main: 150900736 03:07:12 INFO - PROCESS | 31622 | 03:10:14 INFO - PROCESS | 31622 | Cycle 1(1): loaded http://localhost:37710/tests/dromaeo/cssquery-yui.html (next: http://localhost:37710/tests/dromaeo/cssquery-dojo.html) 03:10:15 INFO - PROCESS | 31622 | RSS: Main: 153227264 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | __start_tp_report 03:10:15 INFO - PROCESS | 31622 | _x_x_mozilla_page_load 03:10:15 INFO - PROCESS | 31622 | _x_x_mozilla_page_load_details 03:10:15 INFO - PROCESS | 31622 | |i|pagename|runs| 03:10:15 INFO - PROCESS | 31622 | |0;dojo.html;2604.518164139634;2642.2469596165097;2670.279024663341;2686.0733047098743;2691.8923243070285;4375.934360984587;4523.434570678665;4528.320751887219;4574.405327307453;4577;4484.708493947899;4491.6182124519455;4557.954420455794;4561.384213131227;4588.357629931812;4184.330507118869;4220.620144187023;4282.486101667804;4285.678574106939;4285.849995250167;4154.335306350969;4244;4255.340422234559;4263.104748002907;4309;4013.6387725104883;4072.2669919414493;4133.0700592366775;4176.477940257452;4197.328427451593;4164.437800896871;4170.874873753793;4176.519700234481;4185.393117997874;4206.348016057516;4141.130362623852;4153.833846646131;4155.002799328139;4179.853705120307;4188.392683060939;4330.805113769888;4453.064856380164;4474.7986340614425;4523.389342438794;4553.704009239389;4849.224124140121;4859.441164266084;4871.975640121812;4898.044881248158;4931.679440836334;4753.263244197155;4899.632527560448;4904.852854414337;4906.264060390934;4954.20732682769;4439.999999999967;4473.060657261979;4478.910421791546;4486.506484286726;4533.659975501784;5006.4492905780335;5009.198528235464;5031.874203144877;5037.319961805109;5080.212567052113;4731.834385796481;4812.085703716282;4818.277258411266;4829.517048295143;4874.780634871439;4730.148573256778;4752.334673145762;4792.520747925249;4809.807607695723;4828.130936431476;4777.211760059551;4784.234522476387;4785.994941062416;4802.135615589227;4831.73425461603;4702.27114797207;4762.59517940972;4768.546988036131;4781.043791241766;4825.179719447702;4053.858114965962;4078.9184216315507;4091.509018917749;4111.1366613011605;4126.814293356806;3559.2525569630666;3569.4824250483534;3583.498310236569;3617.5297211362354;3621.9315301985976;4152.1695660867945;4214.220369231702;4250.404943307939;4273.636740876998;4289.1850548395705;4795.136875362468;4837.250226214942;4862.416510018749;4873.147199240118;4878.780454879539;4184.497860256728;4207.833319230933;4209.326507758805;4209.831606735757;4265.4881414230495;4257.3613957905945;4265.360195970629;4277.486701595828;4329.437173167468;4356.455443069616;4602.631789456902;4615.653825963066;4623.907521849612;4645.256758918556;4694.084653492536;4840.709557426566;4854.126257273725;4863;4868.683535570177;4907.043126590281;4485.618722408632;4528;4562.452505699337;4564.201264778584;4577.908441831211;4783.856484305476;4805.687630304019;4812.085703716422;4827.42070951488;4861.586765125004;4770.236762118045;4852.951470485391;4877.195262781744;4893.119238537098;4918.532739389752;4615.2154133798;4651.162790697707;4666.160091183484;4677.555632214934;4740.905181896412;4676.134915040592;4710.4347478302825;4712.905741885074;4717.504662010577;4750.38245028158;4492.2363198255725;4561.49823519406;4615.446146462446;4624.260118381043;4644.883877903079;4766.737829419415;4768;4780.665353425227;4793.520647935178;4849.418069831501;4654.976725116353;4663.673542851968;4668.463126740333;4690.273007683814;4713.57577817998 03:10:15 INFO - PROCESS | 31622 | |1;ext.html;477.2840738891662;485.0662474736132;531.7181893596394;538.8868337649094;542.1434134068172;24722.381940451476;32634.836825815866;32813.17967050825;33122.17194570137;33203.833980830095;35723.82138089306;36062.459063114075;36382.81808590953;36450.63549364506;36526.452103218406;7706.075270967492;7836.608169591526;7867.488613240121;7869.134395216522;7873.763787086396;7702.845943081135;7823.256790604912;7861.4103942204565;7865.449418540705;7880.4089693272945;7841.411894107936;7930.881036784453;7936.801579960518;7942.6425810838655;7955.960220198891;7794.610269486531;7797.532148071134;7886.329661978739;8060.710286354155;8063.677452901877;7692.153863075057;7857;7874.842503149962;7881.96059019707;7889.408294377945;36809.631903681155;37208.813955930316;37273.81363093167;37331.44002839959;37491.06272343186;2787.3449739311245;2807.284142543638;2849.2307077089276;3335.397725865201;3535.7171426285836;27993.30016749577;28236.717632823613;28307.433851322858;28927.276818079506;29279.414411711645;3378.3918894598964;3441.6730410610953;3454.9481757773656;3488.5988111367265;3613.223157021253;171226;171649;172569;173995.13002435034;174161;38485.615143848765;39026.41460378097;39032.414513782314;49972;50541.49458505442;36409;36790.26419471649;36845.26309473849;36892.262154756754;36921.26157476835;12210.206336588093;12419.254844709347;12419.31693756834;12474;12512.562060327844;9356.906430935604;9358.672446464478;9420.34057615974;9440.480773557383;9489.572969216402;13260.602181934557;13303;13399.799003014963;13480;13489.730205395837;5382.811601593926;5408.242846001563;5433.0763770159165;5438.45615438453;5478.233047373371;738.4166508458366;785.7367781793049;838.5094719588986;859.879616853641;921.9539023048955;25411.11061112889;29889.402211956072;30762.692373076432;30822.229444264074;30852.53721194184;930.776613612728;937.105064663245;976.5751897924425;977.3695966101825;1004.372267332917;13220.810127088609;13291.20252784836;13399.53101641438;13560.254186019863;13667.316634168252;321323;324546;324720;325644;325648;47124.5287547127;47405.288920666215;47747.28379074317;47776.7611161942;47785.5221447788;1185.3065956415421;1202.8436303280519;1210.564196889119;1210.8365370675021;1218.3238302741886;25483.36291592725;25514.872425637754;25980.8700956494;26032.219033429028;26059.73940260649;40262.39606405965;40839.1832163361;41000.58999410087;41118.38322425106;41197.79401102975;249973;251718;252624;252781;252896;29099.272518187216;29501.409971800014;29511;29588;29679.406411872074;38860;38867.80566097151;39243.41134882922;39394;39447.408288876264;32662;32753.672463275063;32797.180070497474;32862.83568582142;33613.83193084019;33555;33572.66427335695;33635.831820840736;33690.66309336973;33827.154321141184;32587.511187331736;33477.832610837766;33986.15034624154;34102.82948585241;34228.31543369069;28175.57736633993;30308.24229394283;30425.695743042284;30544.236394090327;30578.318192499628;23561.175358862358;23752.80630997548;23850.64224036606;24003.759962400152;24023.75976240215 03:10:15 INFO - PROCESS | 31622 | |2;jquery.html;340.5572755417956;343.6031383751767;345.9809710465925;348.11404974340303;348.372928728289;15019.924900375483;15372.92313538432;15472.226388680563;15673.608159795982;16315.592110197236;9933.503324833766;10208.132308753746;12255.325957072357;14781.704365912676;14801.777973330409;4472.463304403476;4655.790489427984;4670.369500117475;5103.540681338679;5324.600654950894;5259.447757985414;5278.340207474066;5283.8150664726745;5307.973460132694;5308.150695888658;5194.480551944813;5977.31260904995;6286.654234017127;6506.739730410778;6549.410553050225;6409.134766806468;6545.410913017828;6555.6066636002;6587.209534855824;6749.088873002131;6409.4231519163495;6458.2895881453005;6460.547761656686;6464.095026696266;6474.611523308569;18936.5265868353;19110.23559057636;19533.9023304884;19625.9018704907;19926.90036549808;1824.1335365701318;1927.1231589626686;1931.3916116423422;1951.5706544560173;2050.641137800879;12538.498460061586;12584.244945303311;12679.619611411672;12855.22868627876;12898.161619494704;1786.6158775863253;1812.047424211459;1828.8719789614731;1862.2364830419463;1908.6182763447366;52843;53796;55529.167062494096;56320;57034.14448783272;14446;14546;14549.78175327371;14598.63503412402;14646.853531464549;22086.447838803837;22089.005994729956;22109.66835497469;22193.667094993587;22235.77764222337;8126.593670316461;8148.918510814816;8156.1028286888395;8217.219364160395;8232.259096681328;6790.7623233186605;6848.7260509580055;6855.177378714586;6858.485613578901;6869.622170780655;7152.606606636581;7245.094363204599;7255.56466612005;7307.963460182665;7325.4872158948365;1705.3349193814422;1742.8779985401154;2898.449294634055;2945.3520225550346;2947.7494412974706;375.89850740299966;378.6043584454252;775.856466553678;806.899137607799;862.6937437209825;9374.812503749887;9421.623135074657;9734.902650973541;9740.415575065519;10008.249381296431;375.9060234941265;385.17572395074563;400.77957123582496;410.99383509247383;437.31996745061736;5130.7947682093045;5342.171963345688;8763.605637746317;9175.22010629104;9318.534073296443;426150;426683;427334;445165;456495;58808.41191588115;62371.376286236555;62863;63336.68331658312;64520.67739661365;1052.1845569683555;1081.216118314216;1100.5542755184163;1101.438266484099;1105.690406686129;13502.459901603826;13617.182969021891;13762.380692868644;13780.931095344458;13881.930590346983;29224.41551168922;29932.700672992993;30333.393332133674;30453.847730761205;31016.379672406878;39516.60483395129;40509;40560.1887962245;40661.59338406696;40726.18547628971;2659.1490722968465;5410.917816436807;6466.482681385572;6498.350164983463;6546.541742078009;9423;9427;9850.408975461496;10259.58961641526;10368.53341599645;8014.639341229776;8281.503109813431;8378.287845533197;8440.915590844013;8518.361122915681;2556.70597881246;2573.125137453275;7273.927260727325;8683.131686831266;8910.599023044108;8546.700865469678;8573.699920502753;8707.564621769014;8778.517181555077;8802.33982451306;6424.51816113784;6802.455803535607;6850.623215723183;6913.930860691329;6926.134233220848;6407.263164736115;6570.671466426755;6653.9667301663185;6810.5913645181445;8225.42422030476 03:10:15 INFO - PROCESS | 31622 | |3;mootools.html;1389.3817251323162;1402.4320150339113;1544.760562112872;1738.5305967388797;1765.0556952030665;6197.287311959126;6302.684865756717;7138.535995160311;7367.079115110611;7370.631468426584;6804.48966327525;6831.419329357011;6946.6179360135175;6947.965260173692;6958.443324534038;2169.4142581502947;2195.2755590655124;2202.031106313225;2202.2072054060527;2210.027587861336;2118.5233322502468;2124.1184908263053;2127.702121702963;2140.8287337013003;2148.291063948901;2094.3193462124796;2113.4610674278038;2119.607872543577;2121.968170477436;2150.3226483657677;2156.9784302157013;2159.36298791856;2167.2089687264192;2170.2295685031822;2170.522485053286;2084.3538503064096;2125.787421257877;2127.117246342766;2132.1577976699273;2132.701421800949;7229.132504099489;7241.818954526127;7267.600281984489;7270.854582908365;7280.053593032925;4215.557366476506;4322.243607368698;4341.240282950471;4349.978250108729;4358.128374325116;2760.2961244882426;2781.986090069557;2886.047604290579;2907.86914588844;2918.7373136417823;835.1982097186708;855.3670283989865;868.9565521723952;886.2909672262165;896.2650626486284;9704.61181552737;9737.610495580167;9759;9796.412215267035;9813.165880900133;3979.1245925896255;4015.19696060789;4025.3961905714377;4055.229506393776;4073.165001174752;8401.747947561584;8411.621477033548;8425.241728244488;8425.831483370299;8476.660933562713;4324.416203812508;4325.870223893288;4332.848350307724;4344.630706389929;4349.434573505488;3362.394768941614;3402.8468718907707;3723.1995121049104;3927.430522574268;3935.134270460494;3333.1500467381147;3356.8657253710066;3360.5799275090612;3371.561696979377;3386.6274709781906;1091.5633746501462;1101.0695961912172;1101.9669409917715;1108.539955918301;1108.894655007773;896.0233345653269;916.083916083916;917.6788124156492;925.6204955968021;1187.7861984842812;6793.72825086991;6848.863022739517;6852.972054191911;6862.622555759481;6884.965575172192;444.6154076723611;445.54554354558167;446.2235709864812;457.9931301030487;458.456728776401;5153.1497302945345;5174.197999310113;5182.6113041521285;5187.533122019036;5225.059489291964;8277.213664701843;8446.873296900552;8531.360147988802;8610.13898610134;8879.24526415262;8411.45325553837;8422.915770842335;8439.367047471464;8509.574521274035;8520;6680.565763225375;6785.355391237825;6868.244493105754;7064.646767661597;7064.823379415556;6933.791986240421;7005.859882802213;7020.508564400443;7022.052022976833;7026.824329391601;7732.9226707732205;8159.428839981144;8170.591470426574;8239.423240373117;8273.089960104264;8018.518888866687;8229.79425514367;8322.583870806557;8350.248477637042;8402.579871006548;6279.183706118175;6295.055741638791;6346.682665866596;6349.142865713255;6433.613983160838;6566.737330506726;6571.211454625475;6632.90050649231;6645.435138013129;6673.666316684244;6266.279377871603;6441.871162576628;6445.9033114504255;6533.640649764308;6559.245686745894;5976.103584462366;5979.833932383318;6030.849228769316;6094.603850749687;6216.2540495140875;5954.910676339945;5958.731857066356;5973.49225315853;5980.9401905980385;5998.640081595118;5926;5929.6145750526075;5969.70151492415;5971.462568368867;5972.64164150135;5730.856728581652;5822.7670893163795;5838.766449341979;5844.035734103995;5949.0481522956115 03:10:15 INFO - PROCESS | 31622 | |4;prototype.html;316.1511342046604;316.8083309597693;323.74747696796504;324.1361770880603;324.3593902043464;5518.944810551893;5575.804846830361;5622.803201887935;5637.520810731087;5708.628939118965;5536.723163841802;5555.611107222496;5565.443455654433;5581.330240371151;5582;4091.5499295077516;4176.14389050244;4186.204621121992;4240.766757828318;4251.681123915711;4156.2726522858375;4159.480064991876;4164.396162556428;4183.958160418388;4187.120704652027;4132.2561938850995;4133.462649855514;4133.7106402551835;4136.21411931732;4136.4415803866395;4131;4131.938020929689;4132.73137246078;4147.6474499667565;4151.97924010378;3616.1140520572367;3626.0028492164865;3627.05696518907;3627.3495559520356;3637.0543658648944;5248.257086530519;5287.127623942045;5337.039332920072;5337.359516857963;5359.732013399314;4772.141014617368;4781.306710526954;4791.0178413425165;4796.472388037313;4804.183288840905;5760.308762948473;5764.682942438164;5773.047447171211;5775.249217601685;5785.479306862402;3931.331673615464;3935.60643935607;3941.4481972523868;3942.4086387041884;3942.5071866016747;5898.203742494794;6104.786332478342;6107.664078475682;6109.969450152766;6118.541109416856;3988.880333589997;3991.381335892941;3993.0616305168264;3997.540282867449;4005.539362973237;4050.359604360239;4051.493563304587;4052.392141178788;4054.7972601369815;4054.8175332110127;4688.249880019181;4700.529947005272;4708.976455117771;4732.408448943882;4734.455537613218;5538.861528461821;5742.454466825645;5742.54059675225;5768.855778605568;5785.0454674978155;1442.3076923076983;1467.8678918897351;1472.477270568954;1474.9336279867432;1475.1739026145392;967.1972263021676;978.4129522286571;981.1513041219437;996.2876543271595;996.4270544436978;5098.872528186751;5100.0819852426175;5100.770465329069;5105.132127538327;5107.412647545506;5942.64344139353;6037.034074548139;6155.692215389213;6163.753449862045;6173.81478555644;5129.692218466904;5144.890594856091;5145.76844042019;5156.226566015128;5170.508801663836;3241.9027429177163;3292.4073666739737;3294.901152965415;3299.290652509722;3308.4375656138513;5589.524890384363;5752.9712351437975;5753.165790960287;5753.971230143822;5768.192453056576;6273.498120150377;6286.4342209201395;6292.937070629327;6299.590526615755;6302.401271879165;5740.942590574041;5743.798967036218;5754.884902302014;5775.364709881826;5776.133579962955;6014.578979471395;6099.84750381244;6116.908246376397;6131.110988906673;6137.877242455036;5867.706614669335;5910.408959104056;5936.28764548257;5936.732847021981;5942.702864856827;5690.345610254708;5739.426057394227;5749.453801888814;5759.51044161251;5770.8845823082465;4023.9396409054475;4028.818703158306;4030.979845100756;4039.656629186552;4040.010197501631;5962.940370596412;6067.150598916067;6074.967255566476;6092.482139018233;6100.633961962297;5859.677717725395;5873.619699370559;5879.059350503899;5880.14737863016;5882.911756323573;5846.590738648254;5859.384764599826;5861.35525092231;5863.2670916135485;5886.58793884424;5582.637128586792;5710.114932185518;5725.942740572541;5740.942590574041;5751.1085781703905;5888.205092312483;5890.175375447355;5899.144624029577;5903.91144132847;5929.6145750526075;5616.915746263891;5690.77236910519;5701.458361455655;5703.800366987136;5739.397363276796 03:10:15 INFO - PROCESS | 31622 | |5;yui.html;799.6601444386134;802.0976401548259;804.175719887116;805.9677612895484;833.9999999999998;11044.282121662096;11185.217034807547;11185.217034807567;11226.04578610817;11235.60675376361;10607.204459665536;10843.67468975932;10894.891051089488;12741.108122431433;13038.413271402786;777.2344240922687;785.0892964161588;792.3581898662102;799.588212070784;802.0335495727634;791.6358475101431;791.9643616037264;794.8807678848161;794.9125596184415;795.7135431244748;826.1531929772002;826.5164878546058;826.5454000299841;827.0365024746194;827.3339961331126;820.7127505373131;822.6421506644568;822.847773161961;823.7240524424325;824.47233770387;616.7717944360616;617.3671986214166;617.9969100154516;619.6065498408543;620.8106527509108;11386.54453821846;11435.885641143564;11457.541698332057;11568.305901645928;11572.247803892804;11192.552297908074;11482.138839586982;11486.597969071043;11586.826197607043;11869.643910682693;9184.862227066533;9236.937826585357;9237.214836738885;9242.399244049115;9269.536523173814;3174.3016536361965;3202.151429871086;3212.8232947187894;3249.8050116993054;3253.300540383805;38546.61453385487;38803;39419.60580394188;39844.80077599623;39890;8905.376623636414;8987.730368088967;9122.133397327243;9225.815483690423;9242.907570924339;15083.321250543751;15116.168610726296;15137.924310378598;15189.772153417707;15226.086434813946;5999.400059993965;6006.909896351558;6055.7274922628585;6060.121282414026;6229.844253893598;3652;3652.4886515887797;3675.963240367562;3729.701623870084;3799.9430008549894;2572.691277046729;2640.524705553019;2641.1944356970926;2642.167717169086;2647.695515015798;492.1559525413932;497.5820310938756;503.93700787401576;512.4004914250336;517.350724840323;470.49656867152504;499.47804544251346;558.8794467093452;559.9664020158804;565.3752603373296;6754.5947243165565;6862.588244705334;6926.376626103574;7818.68725250995;8185.754427367188;460.5486623109372;593.3947373678824;606.6542071019477;615.5629503052793;630.3224034163293;3642.4718415829557;3854.6338097880657;3964.2269757397607;3989.5611482736876;4137.338025915839;44213.557864421586;44270.77864610656;44351.33472997908;44360.11279774387;44402;39202;41389.172216555504;42941.57058429376;43525;43727.78136109299;34409.483857742154;34617.30765384729;37920;38177.61822381796;38202.808985955446;7829.530228186327;7895.565743884142;7952.63272540065;8029.919700803151;8232.423730339058;27986.300342491602;28542.85728571344;28608.14175574736;28869.855650721613;29012.27469313284;35687.10782230465;35729.28541429105;35889.82055089708;36853;37056.25887482181;10274.229432792421;10352.585896564053;10511.526981285708;10603.628872989408;10616.787664246518;10964.56141754321;11020.669379918616;11075.612353567587;11076.833847492133;11237.831432528355;10636.52135653882;10738.175282589964;10782.299150555189;10861.185411094042;11331.546738130712;9949.502524873582;10122.240831937781;10159.7460063499;10240.18078553699;10269.691909242734;10370.533326000499;10415.583376665152;10419.53112109972;10682.359058456517;11041.282316649393;8401.175825818198;8506.659733610586;8665.43674661145;8787.428817126865;8981.101889810967;8710.172533609297;8975.28197744192;9012.594433250388;9169.174774270348;9196.540172991457 03:10:15 INFO - PROCESS | 31622 | __end_tp_report 03:10:15 INFO - PROCESS | 31622 | __start_cc_report 03:10:15 INFO - PROCESS | 31622 | _x_x_mozilla_cycle_collect,329 03:10:15 INFO - PROCESS | 31622 | __end_cc_report 03:10:15 INFO - PROCESS | 31622 | __startTimestamp1452683415183__endTimestamp 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | ------- Summary: start ------- 03:10:15 INFO - PROCESS | 31622 | Number of tests: 6 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#0] dojo.html Cycles:165 Average:4485.73 Median:4602.63 stddev:453.20 (9.8%) stddev-sans-first:429.89 03:10:15 INFO - PROCESS | 31622 | Values: 2604.5 2642.2 2670.3 2686.1 2691.9 4375.9 4523.4 4528.3 4574.4 4577.0 4484.7 4491.6 4558.0 4561.4 4588.4 4184.3 4220.6 4282.5 4285.7 4285.8 4154.3 4244.0 4255.3 4263.1 4309.0 4013.6 4072.3 4133.1 4176.5 4197.3 4164.4 4170.9 4176.5 4185.4 4206.3 4141.1 4153.8 4155.0 4179.9 4188.4 4330.8 4453.1 4474.8 4523.4 4553.7 4849.2 4859.4 4872.0 4898.0 4931.7 4753.3 4899.6 4904.9 4906.3 4954.2 4440.0 4473.1 4478.9 4486.5 4533.7 5006.4 5009.2 5031.9 5037.3 5080.2 4731.8 4812.1 4818.3 4829.5 4874.8 4730.1 4752.3 4792.5 4809.8 4828.1 4777.2 4784.2 4786.0 4802.1 4831.7 4702.3 4762.6 4768.5 4781.0 4825.2 4053.9 4078.9 4091.5 4111.1 4126.8 3559.3 3569.5 3583.5 3617.5 3621.9 4152.2 4214.2 4250.4 4273.6 4289.2 4795.1 4837.3 4862.4 4873.1 4878.8 4184.5 4207.8 4209.3 4209.8 4265.5 4257.4 4265.4 4277.5 4329.4 4356.5 4602.6 4615.7 4623.9 4645.3 4694.1 4840.7 4854.1 4863.0 4868.7 4907.0 4485.6 4528.0 4562.5 4564.2 4577.9 4783.9 4805.7 4812.1 4827.4 4861.6 4770.2 4853.0 4877.2 4893.1 4918.5 4615.2 4651.2 4666.2 4677.6 4740.9 4676.1 4710.4 4712.9 4717.5 4750.4 4492.2 4561.5 4615.4 4624.3 4644.9 4766.7 4768.0 4780.7 4793.5 4849.4 4655.0 4663.7 4668.5 4690.3 4713.6 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#1] ext.html Cycles:180 Average:39794.44 Median:18834.99 stddev:67474.75 (358.2%) stddev-sans-first:67599.46 03:10:15 INFO - PROCESS | 31622 | Values: 477.3 485.1 531.7 538.9 542.1 24722.4 32634.8 32813.2 33122.2 33203.8 35723.8 36062.5 36382.8 36450.6 36526.5 7706.1 7836.6 7867.5 7869.1 7873.8 7702.8 7823.3 7861.4 7865.4 7880.4 7841.4 7930.9 7936.8 7942.6 7956.0 7794.6 7797.5 7886.3 8060.7 8063.7 7692.2 7857.0 7874.8 7882.0 7889.4 36809.6 37208.8 37273.8 37331.4 37491.1 2787.3 2807.3 2849.2 3335.4 3535.7 27993.3 28236.7 28307.4 28927.3 29279.4 3378.4 3441.7 3454.9 3488.6 3613.2 171226.0 171649.0 172569.0 173995.1 174161.0 38485.6 39026.4 39032.4 49972.0 50541.5 36409.0 36790.3 36845.3 36892.3 36921.3 12210.2 12419.3 12419.3 12474.0 12512.6 9356.9 9358.7 9420.3 9440.5 9489.6 13260.6 13303.0 13399.8 13480.0 13489.7 5382.8 5408.2 5433.1 5438.5 5478.2 738.4 785.7 838.5 859.9 922.0 25411.1 29889.4 30762.7 30822.2 30852.5 930.8 937.1 976.6 977.4 1004.4 13220.8 13291.2 13399.5 13560.3 13667.3 321323.0 324546.0 324720.0 325644.0 325648.0 47124.5 47405.3 47747.3 47776.8 47785.5 1185.3 1202.8 1210.6 1210.8 1218.3 25483.4 25514.9 25980.9 26032.2 26059.7 40262.4 40839.2 41000.6 41118.4 41197.8 249973.0 251718.0 252624.0 252781.0 252896.0 29099.3 29501.4 29511.0 29588.0 29679.4 38860.0 38867.8 39243.4 39394.0 39447.4 32662.0 32753.7 32797.2 32862.8 33613.8 33555.0 33572.7 33635.8 33690.7 33827.2 32587.5 33477.8 33986.2 34102.8 34228.3 28175.6 30308.2 30425.7 30544.2 30578.3 23561.2 23752.8 23850.6 24003.8 24023.8 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#2] jquery.html Cycles:180 Average:24013.80 Median:5117.17 stddev:71308.26 (1393.5%) stddev-sans-first:71486.14 03:10:15 INFO - PROCESS | 31622 | Values: 340.6 343.6 346.0 348.1 348.4 15019.9 15372.9 15472.2 15673.6 16315.6 9933.5 10208.1 12255.3 14781.7 14801.8 4472.5 4655.8 4670.4 5103.5 5324.6 5259.4 5278.3 5283.8 5308.0 5308.2 5194.5 5977.3 6286.7 6506.7 6549.4 6409.1 6545.4 6555.6 6587.2 6749.1 6409.4 6458.3 6460.5 6464.1 6474.6 18936.5 19110.2 19533.9 19625.9 19926.9 1824.1 1927.1 1931.4 1951.6 2050.6 12538.5 12584.2 12679.6 12855.2 12898.2 1786.6 1812.0 1828.9 1862.2 1908.6 52843.0 53796.0 55529.2 56320.0 57034.1 14446.0 14546.0 14549.8 14598.6 14646.9 22086.4 22089.0 22109.7 22193.7 22235.8 8126.6 8148.9 8156.1 8217.2 8232.3 6790.8 6848.7 6855.2 6858.5 6869.6 7152.6 7245.1 7255.6 7308.0 7325.5 1705.3 1742.9 2898.4 2945.4 2947.7 375.9 378.6 775.9 806.9 862.7 9374.8 9421.6 9734.9 9740.4 10008.2 375.9 385.2 400.8 411.0 437.3 5130.8 5342.2 8763.6 9175.2 9318.5 426150.0 426683.0 427334.0 445165.0 456495.0 58808.4 62371.4 62863.0 63336.7 64520.7 1052.2 1081.2 1100.6 1101.4 1105.7 13502.5 13617.2 13762.4 13780.9 13881.9 29224.4 29932.7 30333.4 30453.8 31016.4 39516.6 40509.0 40560.2 40661.6 40726.2 2659.1 5410.9 6466.5 6498.4 6546.5 9423.0 9427.0 9850.4 10259.6 10368.5 8014.6 8281.5 8378.3 8440.9 8518.4 2556.7 2573.1 7273.9 8683.1 8910.6 8546.7 8573.7 8707.6 8778.5 8802.3 6424.5 6802.5 6850.6 6913.9 6926.1 6407.3 6570.7 6654.0 6810.6 8225.4 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#3] mootools.html Cycles:180 Average:5000.74 Median:5980.39 stddev:2621.24 (43.8%) stddev-sans-first:2614.54 03:10:15 INFO - PROCESS | 31622 | Values: 1389.4 1402.4 1544.8 1738.5 1765.1 6197.3 6302.7 7138.5 7367.1 7370.6 6804.5 6831.4 6946.6 6948.0 6958.4 2169.4 2195.3 2202.0 2202.2 2210.0 2118.5 2124.1 2127.7 2140.8 2148.3 2094.3 2113.5 2119.6 2122.0 2150.3 2157.0 2159.4 2167.2 2170.2 2170.5 2084.4 2125.8 2127.1 2132.2 2132.7 7229.1 7241.8 7267.6 7270.9 7280.1 4215.6 4322.2 4341.2 4350.0 4358.1 2760.3 2782.0 2886.0 2907.9 2918.7 835.2 855.4 869.0 886.3 896.3 9704.6 9737.6 9759.0 9796.4 9813.2 3979.1 4015.2 4025.4 4055.2 4073.2 8401.7 8411.6 8425.2 8425.8 8476.7 4324.4 4325.9 4332.8 4344.6 4349.4 3362.4 3402.8 3723.2 3927.4 3935.1 3333.2 3356.9 3360.6 3371.6 3386.6 1091.6 1101.1 1102.0 1108.5 1108.9 896.0 916.1 917.7 925.6 1187.8 6793.7 6848.9 6853.0 6862.6 6885.0 444.6 445.5 446.2 458.0 458.5 5153.1 5174.2 5182.6 5187.5 5225.1 8277.2 8446.9 8531.4 8610.1 8879.2 8411.5 8422.9 8439.4 8509.6 8520.0 6680.6 6785.4 6868.2 7064.6 7064.8 6933.8 7005.9 7020.5 7022.1 7026.8 7732.9 8159.4 8170.6 8239.4 8273.1 8018.5 8229.8 8322.6 8350.2 8402.6 6279.2 6295.1 6346.7 6349.1 6433.6 6566.7 6571.2 6632.9 6645.4 6673.7 6266.3 6441.9 6445.9 6533.6 6559.2 5976.1 5979.8 6030.8 6094.6 6216.3 5954.9 5958.7 5973.5 5980.9 5998.6 5926.0 5929.6 5969.7 5971.5 5972.6 5730.9 5822.8 5838.8 5844.0 5949.0 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#4] prototype.html Cycles:180 Average:4801.64 Median:5578.57 stddev:1446.94 (25.9%) stddev-sans-first:1411.28 03:10:15 INFO - PROCESS | 31622 | Values: 316.2 316.8 323.7 324.1 324.4 5518.9 5575.8 5622.8 5637.5 5708.6 5536.7 5555.6 5565.4 5581.3 5582.0 4091.5 4176.1 4186.2 4240.8 4251.7 4156.3 4159.5 4164.4 4184.0 4187.1 4132.3 4133.5 4133.7 4136.2 4136.4 4131.0 4131.9 4132.7 4147.6 4152.0 3616.1 3626.0 3627.1 3627.3 3637.1 5248.3 5287.1 5337.0 5337.4 5359.7 4772.1 4781.3 4791.0 4796.5 4804.2 5760.3 5764.7 5773.0 5775.2 5785.5 3931.3 3935.6 3941.4 3942.4 3942.5 5898.2 6104.8 6107.7 6110.0 6118.5 3988.9 3991.4 3993.1 3997.5 4005.5 4050.4 4051.5 4052.4 4054.8 4054.8 4688.2 4700.5 4709.0 4732.4 4734.5 5538.9 5742.5 5742.5 5768.9 5785.0 1442.3 1467.9 1472.5 1474.9 1475.2 967.2 978.4 981.2 996.3 996.4 5098.9 5100.1 5100.8 5105.1 5107.4 5942.6 6037.0 6155.7 6163.8 6173.8 5129.7 5144.9 5145.8 5156.2 5170.5 3241.9 3292.4 3294.9 3299.3 3308.4 5589.5 5753.0 5753.2 5754.0 5768.2 6273.5 6286.4 6292.9 6299.6 6302.4 5740.9 5743.8 5754.9 5775.4 5776.1 6014.6 6099.8 6116.9 6131.1 6137.9 5867.7 5910.4 5936.3 5936.7 5942.7 5690.3 5739.4 5749.5 5759.5 5770.9 4023.9 4028.8 4031.0 4039.7 4040.0 5962.9 6067.2 6075.0 6092.5 6100.6 5859.7 5873.6 5879.1 5880.1 5882.9 5846.6 5859.4 5861.4 5863.3 5886.6 5582.6 5710.1 5725.9 5740.9 5751.1 5888.2 5890.2 5899.1 5903.9 5929.6 5616.9 5690.8 5701.5 5703.8 5739.4 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - PROCESS | 31622 | [#5] yui.html Cycles:180 Average:11625.72 Median:42165.37 stddev:12677.85 (30.1%) stddev-sans-first:12687.34 03:10:15 INFO - PROCESS | 31622 | Values: 799.7 802.1 804.2 806.0 834.0 11044.3 11185.2 11185.2 11226.0 11235.6 10607.2 10843.7 10894.9 12741.1 13038.4 777.2 785.1 792.4 799.6 802.0 791.6 792.0 794.9 794.9 795.7 826.2 826.5 826.5 827.0 827.3 820.7 822.6 822.8 823.7 824.5 616.8 617.4 618.0 619.6 620.8 11386.5 11435.9 11457.5 11568.3 11572.2 11192.6 11482.1 11486.6 11586.8 11869.6 9184.9 9236.9 9237.2 9242.4 9269.5 3174.3 3202.2 3212.8 3249.8 3253.3 38546.6 38803.0 39419.6 39844.8 39890.0 8905.4 8987.7 9122.1 9225.8 9242.9 15083.3 15116.2 15137.9 15189.8 15226.1 5999.4 6006.9 6055.7 6060.1 6229.8 3652.0 3652.5 3676.0 3729.7 3799.9 2572.7 2640.5 2641.2 2642.2 2647.7 492.2 497.6 503.9 512.4 517.4 470.5 499.5 558.9 560.0 565.4 6754.6 6862.6 6926.4 7818.7 8185.8 460.5 593.4 606.7 615.6 630.3 3642.5 3854.6 3964.2 3989.6 4137.3 44213.6 44270.8 44351.3 44360.1 44402.0 39202.0 41389.2 42941.6 43525.0 43727.8 34409.5 34617.3 37920.0 38177.6 38202.8 7829.5 7895.6 7952.6 8029.9 8232.4 27986.3 28542.9 28608.1 28869.9 29012.3 35687.1 35729.3 35889.8 36853.0 37056.3 10274.2 10352.6 10511.5 10603.6 10616.8 10964.6 11020.7 11075.6 11076.8 11237.8 10636.5 10738.2 10782.3 10861.2 11331.5 9949.5 10122.2 10159.7 10240.2 10269.7 10370.5 10415.6 10419.5 10682.4 11041.3 8401.2 8506.7 8665.4 8787.4 8981.1 8710.2 8975.3 9012.6 9169.2 9196.5 03:10:15 INFO - PROCESS | 31622 | -------- Summary: end -------- 03:10:15 INFO - PROCESS | 31622 | 03:10:15 INFO - TEST-INFO | 31622: exit 0 03:10:15 INFO - TEST-OK | dromaeo_css | took 1114470ms 03:10:15 INFO - TEST-START | kraken 03:10:15 INFO - operating with platform_type : linux_ 03:10:15 INFO - Initialising browser for kraken test... 03:10:15 INFO - TEST-INFO | started process 31861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUVR_Rf/profile http://localhost:37710/getInfo.html) 03:10:20 INFO - PROCESS | 31861 | 03:10:20 INFO - PROCESS | 31861 | (process:31934): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:10:21 INFO - PROCESS | 31861 | __metrics Screen width/height:1600/1200 03:10:21 INFO - PROCESS | 31861 | colorDepth:24 03:10:21 INFO - PROCESS | 31861 | Browser inner width/height: 1024/697 03:10:21 INFO - PROCESS | 31861 | __metrics 03:10:21 INFO - PROCESS | 31861 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:10:22 INFO - TEST-INFO | 31861: exit 0 03:10:22 INFO - Browser initialized. 03:10:22 INFO - Running cycle 1/1 for kraken test... 03:10:22 INFO - TEST-INFO | started process 31983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUVR_Rf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:23 INFO - PROCESS | 31983 | 03:10:23 INFO - PROCESS | 31983 | (process:32043): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:10:34 INFO - PROCESS | 31983 | RSS: Main: 150282240 03:10:34 INFO - PROCESS | 31983 | 03:10:36 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37710/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:37 INFO - PROCESS | 31983 | RSS: Main: 151494656 03:10:37 INFO - PROCESS | 31983 | 03:10:40 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37710/tests/kraken/driver.html?testName=audio-dft) 03:10:40 INFO - PROCESS | 31983 | RSS: Main: 151797760 03:10:40 INFO - PROCESS | 31983 | 03:10:43 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37710/tests/kraken/driver.html?testName=audio-fft) 03:10:44 INFO - PROCESS | 31983 | RSS: Main: 147345408 03:10:44 INFO - PROCESS | 31983 | 03:10:46 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37710/tests/kraken/driver.html?testName=audio-oscillator) 03:10:46 INFO - PROCESS | 31983 | RSS: Main: 146362368 03:10:46 INFO - PROCESS | 31983 | 03:10:49 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:10:49 INFO - PROCESS | 31983 | RSS: Main: 147165184 03:10:49 INFO - PROCESS | 31983 | 03:10:52 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37710/tests/kraken/driver.html?testName=imaging-darkroom) 03:10:53 INFO - PROCESS | 31983 | RSS: Main: 148307968 03:10:53 INFO - PROCESS | 31983 | 03:10:57 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37710/tests/kraken/driver.html?testName=imaging-desaturate) 03:10:57 INFO - PROCESS | 31983 | RSS: Main: 145719296 03:10:57 INFO - PROCESS | 31983 | 03:11:00 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37710/tests/kraken/driver.html?testName=json-parse-financial) 03:11:01 INFO - PROCESS | 31983 | RSS: Main: 146288640 03:11:01 INFO - PROCESS | 31983 | 03:11:02 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:03 INFO - PROCESS | 31983 | RSS: Main: 148729856 03:11:03 INFO - PROCESS | 31983 | 03:11:05 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:05 INFO - PROCESS | 31983 | RSS: Main: 148393984 03:11:05 INFO - PROCESS | 31983 | 03:11:08 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:08 INFO - PROCESS | 31983 | RSS: Main: 149037056 03:11:08 INFO - PROCESS | 31983 | 03:11:11 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:11 INFO - PROCESS | 31983 | RSS: Main: 148615168 03:11:11 INFO - PROCESS | 31983 | 03:11:14 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:15 INFO - PROCESS | 31983 | RSS: Main: 148762624 03:11:15 INFO - PROCESS | 31983 | 03:11:16 INFO - PROCESS | 31983 | Cycle 1(1): loaded http://localhost:37710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37710/tests/kraken/driver.html?testName=ai-astar) 03:11:17 INFO - PROCESS | 31983 | RSS: Main: 148336640 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | __start_tp_report 03:11:17 INFO - PROCESS | 31983 | _x_x_mozilla_page_load 03:11:17 INFO - PROCESS | 31983 | _x_x_mozilla_page_load_details 03:11:17 INFO - PROCESS | 31983 | |i|pagename|runs| 03:11:17 INFO - PROCESS | 31983 | |0;ai-astar;115;110;117;114;115;124;113;113;114;114 03:11:17 INFO - PROCESS | 31983 | |1;audio-beat-detection;165;134;162;173;144;166;154;145;171;135 03:11:17 INFO - PROCESS | 31983 | |2;audio-dft;166;164;165;164;164;164;169;166;164;164 03:11:17 INFO - PROCESS | 31983 | |3;audio-fft;71;73;75;72;133;74;72;81;73;90 03:11:17 INFO - PROCESS | 31983 | |4;audio-oscillator;98;98;141;97;98;97;144;97;98;136 03:11:17 INFO - PROCESS | 31983 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 03:11:17 INFO - PROCESS | 31983 | |6;imaging-darkroom;147;149;147;149;147;148;149;148;152;148 03:11:17 INFO - PROCESS | 31983 | |7;imaging-desaturate;95;98;97;97;96;96;96;96;97;96 03:11:17 INFO - PROCESS | 31983 | |8;json-parse-financial;71;73;71;71;71;74;71;78;69;70 03:11:17 INFO - PROCESS | 31983 | |9;json-stringify-tinderbox;66;67;68;67;67;68;69;69;68;68 03:11:17 INFO - PROCESS | 31983 | |10;stanford-crypto-aes;83;82;83;83;95;93;83;83;93;92 03:11:17 INFO - PROCESS | 31983 | |11;stanford-crypto-ccm;120;119;126;123;125;122;128;119;135;133 03:11:17 INFO - PROCESS | 31983 | |12;stanford-crypto-pbkdf2;134;146;136;147;149;147;152;149;146;143 03:11:17 INFO - PROCESS | 31983 | |13;stanford-crypto-sha256-iterative;72;71;72;73;72;72;70;72;69;72 03:11:17 INFO - PROCESS | 31983 | __end_tp_report 03:11:17 INFO - PROCESS | 31983 | __start_cc_report 03:11:17 INFO - PROCESS | 31983 | _x_x_mozilla_cycle_collect,825 03:11:17 INFO - PROCESS | 31983 | __end_cc_report 03:11:17 INFO - PROCESS | 31983 | __startTimestamp1452683477187__endTimestamp 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | ------- Summary: start ------- 03:11:17 INFO - PROCESS | 31983 | Number of tests: 14 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:3.67 (3.2%) stddev-sans-first:3.89 03:11:17 INFO - PROCESS | 31983 | Values: 115.0 110.0 117.0 114.0 115.0 124.0 113.0 113.0 114.0 114.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:163.50 stddev:14.58 (8.9%) stddev-sans-first:15.00 03:11:17 INFO - PROCESS | 31983 | Values: 165.0 134.0 162.0 173.0 144.0 166.0 154.0 145.0 171.0 135.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 03:11:17 INFO - PROCESS | 31983 | Values: 166.0 164.0 165.0 164.0 164.0 164.0 169.0 166.0 164.0 164.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:19.03 (25.9%) stddev-sans-first:19.81 03:11:17 INFO - PROCESS | 31983 | Values: 71.0 73.0 75.0 72.0 133.0 74.0 72.0 81.0 73.0 90.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:97.50 stddev:20.75 (21.3%) stddev-sans-first:21.52 03:11:17 INFO - PROCESS | 31983 | Values: 98.0 98.0 141.0 97.0 98.0 97.0 144.0 97.0 98.0 136.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:11:17 INFO - PROCESS | 31983 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.51 (1.0%) stddev-sans-first:1.51 03:11:17 INFO - PROCESS | 31983 | Values: 147.0 149.0 147.0 149.0 147.0 148.0 149.0 148.0 152.0 148.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 03:11:17 INFO - PROCESS | 31983 | Values: 95.0 98.0 97.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.00 stddev:2.56 (3.6%) stddev-sans-first:2.69 03:11:17 INFO - PROCESS | 31983 | Values: 71.0 73.0 71.0 71.0 71.0 74.0 71.0 78.0 69.0 70.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 03:11:17 INFO - PROCESS | 31983 | Values: 66.0 67.0 68.0 67.0 67.0 68.0 69.0 69.0 68.0 68.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.50 stddev:5.44 (6.2%) stddev-sans-first:5.57 03:11:17 INFO - PROCESS | 31983 | Values: 83.0 82.0 83.0 83.0 95.0 93.0 83.0 83.0 93.0 92.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:125.50 stddev:5.62 (4.5%) stddev-sans-first:5.66 03:11:17 INFO - PROCESS | 31983 | Values: 120.0 119.0 126.0 123.0 125.0 122.0 128.0 119.0 135.0 133.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.00 stddev:5.74 (3.9%) stddev-sans-first:4.54 03:11:17 INFO - PROCESS | 31983 | Values: 134.0 146.0 136.0 147.0 149.0 147.0 152.0 149.0 146.0 143.0 03:11:17 INFO - PROCESS | 31983 | 03:11:17 INFO - PROCESS | 31983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.18 (1.6%) stddev-sans-first:1.24 03:11:17 INFO - PROCESS | 31983 | Values: 72.0 71.0 72.0 73.0 72.0 72.0 70.0 72.0 69.0 72.0 03:11:17 INFO - PROCESS | 31983 | -------- Summary: end -------- 03:11:17 INFO - PROCESS | 31983 | 03:11:18 INFO - TEST-INFO | 31983: exit 0 03:11:18 INFO - TEST-OK | kraken | took 62290ms 03:11:18 INFO - TEST-START | v8_7 03:11:18 INFO - operating with platform_type : linux_ 03:11:18 INFO - Initialising browser for v8_7 test... 03:11:18 INFO - TEST-INFO | started process 32271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoasi3Z/profile http://localhost:37710/getInfo.html) 03:11:22 INFO - PROCESS | 32271 | 03:11:22 INFO - PROCESS | 32271 | (process:32343): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:11:23 INFO - PROCESS | 32271 | __metrics Screen width/height:1600/1200 03:11:23 INFO - PROCESS | 32271 | colorDepth:24 03:11:23 INFO - PROCESS | 32271 | Browser inner width/height: 1024/697 03:11:23 INFO - PROCESS | 32271 | __metrics 03:11:23 INFO - PROCESS | 32271 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:11:24 INFO - TEST-INFO | 32271: exit 0 03:11:24 INFO - Browser initialized. 03:11:24 INFO - Running cycle 1/1 for v8_7 test... 03:11:24 INFO - TEST-INFO | started process 32392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoasi3Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:25 INFO - PROCESS | 32392 | 03:11:25 INFO - PROCESS | 32392 | (process:32450): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:11:36 INFO - PROCESS | 32392 | RSS: Main: 150200320 03:11:36 INFO - PROCESS | 32392 | 03:11:58 INFO - PROCESS | 32392 | Cycle 1(1): loaded http://localhost:37710/tests/v8_7/run.html (next: http://localhost:37710/tests/v8_7/run.html) 03:11:59 INFO - PROCESS | 32392 | RSS: Main: 145772544 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | __start_tp_report 03:11:59 INFO - PROCESS | 32392 | _x_x_mozilla_page_load 03:11:59 INFO - PROCESS | 32392 | _x_x_mozilla_page_load_details 03:11:59 INFO - PROCESS | 32392 | |i|pagename|runs| 03:11:59 INFO - PROCESS | 32392 | |0;Richards;166.80567139282735 03:11:59 INFO - PROCESS | 32392 | |1;DeltaBlue;187.05574261129817 03:11:59 INFO - PROCESS | 32392 | |2;Encrypt;277.0850651149903 03:11:59 INFO - PROCESS | 32392 | |3;Decrypt;5196.891191709845 03:11:59 INFO - PROCESS | 32392 | |4;RayTrace;1057.0221752903908 03:11:59 INFO - PROCESS | 32392 | |5;Earley;710.2272727272727 03:11:59 INFO - PROCESS | 32392 | |6;Boyer;12345.67901234568 03:11:59 INFO - PROCESS | 32392 | |7;RegExp;43687.5 03:11:59 INFO - PROCESS | 32392 | |8;Splay;591.7159763313609 03:11:59 INFO - PROCESS | 32392 | |9;NavierStokes;4845.410628019324 03:11:59 INFO - PROCESS | 32392 | __end_tp_report 03:11:59 INFO - PROCESS | 32392 | __startTimestamp1452683519044__endTimestamp 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | ------- Summary: start ------- 03:11:59 INFO - PROCESS | 32392 | Number of tests: 10 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 166.8 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#1] DeltaBlue Cycles:1 Average:187.06 Median:187.06 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 187.1 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#2] Encrypt Cycles:1 Average:277.09 Median:277.09 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 277.1 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 5196.9 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#4] RayTrace Cycles:1 Average:1057.02 Median:1057.02 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 1057.0 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#5] Earley Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 710.2 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 12345.7 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#7] RegExp Cycles:1 Average:43687.50 Median:43687.50 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 43687.5 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#8] Splay Cycles:1 Average:591.72 Median:591.72 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 591.7 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - PROCESS | 32392 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 03:11:59 INFO - PROCESS | 32392 | Values: 4845.4 03:11:59 INFO - PROCESS | 32392 | -------- Summary: end -------- 03:11:59 INFO - PROCESS | 32392 | 03:11:59 INFO - TEST-INFO | 32392: exit 0 03:11:59 INFO - TEST-OK | v8_7 | took 41784ms 03:11:59 INFO - SUITE-END | took 1218s 03:12:00 INFO - Completed test suite (00:20:18) 03:12:00 INFO - Working with test: dromaeo_css 03:12:00 INFO - Generating results file: dromaeo_css 03:12:00 INFO - Working with test: kraken 03:12:00 INFO - Generating results file: kraken 03:12:00 INFO - javascript benchmark 03:12:00 INFO - Working with test: v8_7 03:12:00 INFO - Generating results file: v8_7 03:12:00 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:12:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:12:00 INFO - process_Request line: dromaeo_css 6143.96 graph.html#tests=[[72,132,43]] 03:12:00 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:12:00 INFO - process_Request line: kraken 1549.50 graph.html#tests=[[232,132,43]] 03:12:00 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:12:00 INFO - process_Request line: v8_7 20345.83 graph.html#tests=[[230,132,43]] 03:12:00 INFO - RETURN: dromaeo_css: 6143.96 03:12:00 INFO - RETURN: kraken: 1549.50 03:12:00 INFO - RETURN: v8_7: 20345.83 03:12:00 INFO - javascript benchmark 03:12:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.518164139634, 2642.2469596165097, 2670.279024663341, 2686.0733047098743, 2691.8923243070285, 4375.934360984587, 4523.434570678665, 4528.320751887219, 4574.405327307453, 4577.0, 4484.708493947899, 4491.6182124519455, 4557.954420455794, 4561.384213131227, 4588.357629931812, 4184.330507118869, 4220.620144187023, 4282.486101667804, 4285.678574106939, 4285.849995250167, 4154.335306350969, 4244.0, 4255.340422234559, 4263.104748002907, 4309.0, 4013.6387725104883, 4072.2669919414493, 4133.0700592366775, 4176.477940257452, 4197.328427451593, 4164.437800896871, 4170.874873753793, 4176.519700234481, 4185.393117997874, 4206.348016057516, 4141.130362623852, 4153.833846646131, 4155.002799328139, 4179.853705120307, 4188.392683060939, 4330.805113769888, 4453.064856380164, 4474.7986340614425, 4523.389342438794, 4553.704009239389, 4849.224124140121, 4859.441164266084, 4871.975640121812, 4898.044881248158, 4931.679440836334, 4753.263244197155, 4899.632527560448, 4904.852854414337, 4906.264060390934, 4954.20732682769, 4439.999999999967, 4473.060657261979, 4478.910421791546, 4486.506484286726, 4533.659975501784, 5006.4492905780335, 5009.198528235464, 5031.874203144877, 5037.319961805109, 5080.212567052113, 4731.834385796481, 4812.085703716282, 4818.277258411266, 4829.517048295143, 4874.780634871439, 4730.148573256778, 4752.334673145762, 4792.520747925249, 4809.807607695723, 4828.130936431476, 4777.211760059551, 4784.234522476387, 4785.994941062416, 4802.135615589227, 4831.73425461603, 4702.27114797207, 4762.59517940972, 4768.546988036131, 4781.043791241766, 4825.179719447702, 4053.858114965962, 4078.9184216315507, 4091.509018917749, 4111.1366613011605, 4126.814293356806, 3559.2525569630666, 3569.4824250483534, 3583.498310236569, 3617.5297211362354, 3621.9315301985976, 4152.1695660867945, 4214.220369231702, 4250.404943307939, 4273.636740876998, 4289.1850548395705, 4795.136875362468, 4837.250226214942, 4862.416510018749, 4873.147199240118, 4878.780454879539, 4184.497860256728, 4207.833319230933, 4209.326507758805, 4209.831606735757, 4265.4881414230495, 4257.3613957905945, 4265.360195970629, 4277.486701595828, 4329.437173167468, 4356.455443069616, 4602.631789456902, 4615.653825963066, 4623.907521849612, 4645.256758918556, 4694.084653492536, 4840.709557426566, 4854.126257273725, 4863.0, 4868.683535570177, 4907.043126590281, 4485.618722408632, 4528.0, 4562.452505699337, 4564.201264778584, 4577.908441831211, 4783.856484305476, 4805.687630304019, 4812.085703716422, 4827.42070951488, 4861.586765125004, 4770.236762118045, 4852.951470485391, 4877.195262781744, 4893.119238537098, 4918.532739389752, 4615.2154133798, 4651.162790697707, 4666.160091183484, 4677.555632214934, 4740.905181896412, 4676.134915040592, 4710.4347478302825, 4712.905741885074, 4717.504662010577, 4750.38245028158, 4492.2363198255725, 4561.49823519406, 4615.446146462446, 4624.260118381043, 4644.883877903079, 4766.737829419415, 4768.0, 4780.665353425227, 4793.520647935178, 4849.418069831501, 4654.976725116353, 4663.673542851968, 4668.463126740333, 4690.273007683814, 4713.57577817998], "unit": "score", "name": "dojo.html", "value": 4458.544557400539}, {"lowerIsBetter": false, "replicates": [477.2840738891662, 485.0662474736132, 531.7181893596394, 538.8868337649094, 542.1434134068172, 24722.381940451476, 32634.836825815866, 32813.17967050825, 33122.17194570137, 33203.833980830095, 35723.82138089306, 36062.459063114075, 36382.81808590953, 36450.63549364506, 36526.452103218406, 7706.075270967492, 7836.608169591526, 7867.488613240121, 7869.134395216522, 7873.763787086396, 7702.845943081135, 7823.256790604912, 7861.4103942204565, 7865.449418540705, 7880.4089693272945, 7841.411894107936, 7930.881036784453, 7936.801579960518, 7942.6425810838655, 7955.960220198891, 7794.610269486531, 7797.532148071134, 7886.329661978739, 8060.710286354155, 8063.677452901877, 7692.153863075057, 7857.0, 7874.842503149962, 7881.96059019707, 7889.408294377945, 36809.631903681155, 37208.813955930316, 37273.81363093167, 37331.44002839959, 37491.06272343186, 2787.3449739311245, 2807.284142543638, 2849.2307077089276, 3335.397725865201, 3535.7171426285836, 27993.30016749577, 28236.717632823613, 28307.433851322858, 28927.276818079506, 29279.414411711645, 3378.3918894598964, 3441.6730410610953, 3454.9481757773656, 3488.5988111367265, 3613.223157021253, 171226.0, 171649.0, 172569.0, 173995.13002435034, 174161.0, 38485.615143848765, 39026.41460378097, 39032.414513782314, 49972.0, 50541.49458505442, 36409.0, 36790.26419471649, 36845.26309473849, 36892.262154756754, 36921.26157476835, 12210.206336588093, 12419.254844709347, 12419.31693756834, 12474.0, 12512.562060327844, 9356.906430935604, 9358.672446464478, 9420.34057615974, 9440.480773557383, 9489.572969216402, 13260.602181934557, 13303.0, 13399.799003014963, 13480.0, 13489.730205395837, 5382.811601593926, 5408.242846001563, 5433.0763770159165, 5438.45615438453, 5478.233047373371, 738.4166508458366, 785.7367781793049, 838.5094719588986, 859.879616853641, 921.9539023048955, 25411.11061112889, 29889.402211956072, 30762.692373076432, 30822.229444264074, 30852.53721194184, 930.776613612728, 937.105064663245, 976.5751897924425, 977.3695966101825, 1004.372267332917, 13220.810127088609, 13291.20252784836, 13399.53101641438, 13560.254186019863, 13667.316634168252, 321323.0, 324546.0, 324720.0, 325644.0, 325648.0, 47124.5287547127, 47405.288920666215, 47747.28379074317, 47776.7611161942, 47785.5221447788, 1185.3065956415421, 1202.8436303280519, 1210.564196889119, 1210.8365370675021, 1218.3238302741886, 25483.36291592725, 25514.872425637754, 25980.8700956494, 26032.219033429028, 26059.73940260649, 40262.39606405965, 40839.1832163361, 41000.58999410087, 41118.38322425106, 41197.79401102975, 249973.0, 251718.0, 252624.0, 252781.0, 252896.0, 29099.272518187216, 29501.409971800014, 29511.0, 29588.0, 29679.406411872074, 38860.0, 38867.80566097151, 39243.41134882922, 39394.0, 39447.408288876264, 32662.0, 32753.672463275063, 32797.180070497474, 32862.83568582142, 33613.83193084019, 33555.0, 33572.66427335695, 33635.831820840736, 33690.66309336973, 33827.154321141184, 32587.511187331736, 33477.832610837766, 33986.15034624154, 34102.82948585241, 34228.31543369069, 28175.57736633993, 30308.24229394283, 30425.695743042284, 30544.236394090327, 30578.318192499628, 23561.175358862358, 23752.80630997548, 23850.64224036606, 24003.759962400152, 24023.75976240215], "unit": "score", "name": "ext.html", "value": 16007.35122262791}, {"lowerIsBetter": false, "replicates": [340.5572755417956, 343.6031383751767, 345.9809710465925, 348.11404974340303, 348.372928728289, 15019.924900375483, 15372.92313538432, 15472.226388680563, 15673.608159795982, 16315.592110197236, 9933.503324833766, 10208.132308753746, 12255.325957072357, 14781.704365912676, 14801.777973330409, 4472.463304403476, 4655.790489427984, 4670.369500117475, 5103.540681338679, 5324.600654950894, 5259.447757985414, 5278.340207474066, 5283.8150664726745, 5307.973460132694, 5308.150695888658, 5194.480551944813, 5977.31260904995, 6286.654234017127, 6506.739730410778, 6549.410553050225, 6409.134766806468, 6545.410913017828, 6555.6066636002, 6587.209534855824, 6749.088873002131, 6409.4231519163495, 6458.2895881453005, 6460.547761656686, 6464.095026696266, 6474.611523308569, 18936.5265868353, 19110.23559057636, 19533.9023304884, 19625.9018704907, 19926.90036549808, 1824.1335365701318, 1927.1231589626686, 1931.3916116423422, 1951.5706544560173, 2050.641137800879, 12538.498460061586, 12584.244945303311, 12679.619611411672, 12855.22868627876, 12898.161619494704, 1786.6158775863253, 1812.047424211459, 1828.8719789614731, 1862.2364830419463, 1908.6182763447366, 52843.0, 53796.0, 55529.167062494096, 56320.0, 57034.14448783272, 14446.0, 14546.0, 14549.78175327371, 14598.63503412402, 14646.853531464549, 22086.447838803837, 22089.005994729956, 22109.66835497469, 22193.667094993587, 22235.77764222337, 8126.593670316461, 8148.918510814816, 8156.1028286888395, 8217.219364160395, 8232.259096681328, 6790.7623233186605, 6848.7260509580055, 6855.177378714586, 6858.485613578901, 6869.622170780655, 7152.606606636581, 7245.094363204599, 7255.56466612005, 7307.963460182665, 7325.4872158948365, 1705.3349193814422, 1742.8779985401154, 2898.449294634055, 2945.3520225550346, 2947.7494412974706, 375.89850740299966, 378.6043584454252, 775.856466553678, 806.899137607799, 862.6937437209825, 9374.812503749887, 9421.623135074657, 9734.902650973541, 9740.415575065519, 10008.249381296431, 375.9060234941265, 385.17572395074563, 400.77957123582496, 410.99383509247383, 437.31996745061736, 5130.7947682093045, 5342.171963345688, 8763.605637746317, 9175.22010629104, 9318.534073296443, 426150.0, 426683.0, 427334.0, 445165.0, 456495.0, 58808.41191588115, 62371.376286236555, 62863.0, 63336.68331658312, 64520.67739661365, 1052.1845569683555, 1081.216118314216, 1100.5542755184163, 1101.438266484099, 1105.690406686129, 13502.459901603826, 13617.182969021891, 13762.380692868644, 13780.931095344458, 13881.930590346983, 29224.41551168922, 29932.700672992993, 30333.393332133674, 30453.847730761205, 31016.379672406878, 39516.60483395129, 40509.0, 40560.1887962245, 40661.59338406696, 40726.18547628971, 2659.1490722968465, 5410.917816436807, 6466.482681385572, 6498.350164983463, 6546.541742078009, 9423.0, 9427.0, 9850.408975461496, 10259.58961641526, 10368.53341599645, 8014.639341229776, 8281.503109813431, 8378.287845533197, 8440.915590844013, 8518.361122915681, 2556.70597881246, 2573.125137453275, 7273.927260727325, 8683.131686831266, 8910.599023044108, 8546.700865469678, 8573.699920502753, 8707.564621769014, 8778.517181555077, 8802.33982451306, 6424.51816113784, 6802.455803535607, 6850.623215723183, 6913.930860691329, 6926.134233220848, 6407.263164736115, 6570.671466426755, 6653.9667301663185, 6810.5913645181445, 8225.42422030476], "unit": "score", "name": "jquery.html", "value": 7670.274497546777}, {"lowerIsBetter": false, "replicates": [1389.3817251323162, 1402.4320150339113, 1544.760562112872, 1738.5305967388797, 1765.0556952030665, 6197.287311959126, 6302.684865756717, 7138.535995160311, 7367.079115110611, 7370.631468426584, 6804.48966327525, 6831.419329357011, 6946.6179360135175, 6947.965260173692, 6958.443324534038, 2169.4142581502947, 2195.2755590655124, 2202.031106313225, 2202.2072054060527, 2210.027587861336, 2118.5233322502468, 2124.1184908263053, 2127.702121702963, 2140.8287337013003, 2148.291063948901, 2094.3193462124796, 2113.4610674278038, 2119.607872543577, 2121.968170477436, 2150.3226483657677, 2156.9784302157013, 2159.36298791856, 2167.2089687264192, 2170.2295685031822, 2170.522485053286, 2084.3538503064096, 2125.787421257877, 2127.117246342766, 2132.1577976699273, 2132.701421800949, 7229.132504099489, 7241.818954526127, 7267.600281984489, 7270.854582908365, 7280.053593032925, 4215.557366476506, 4322.243607368698, 4341.240282950471, 4349.978250108729, 4358.128374325116, 2760.2961244882426, 2781.986090069557, 2886.047604290579, 2907.86914588844, 2918.7373136417823, 835.1982097186708, 855.3670283989865, 868.9565521723952, 886.2909672262165, 896.2650626486284, 9704.61181552737, 9737.610495580167, 9759.0, 9796.412215267035, 9813.165880900133, 3979.1245925896255, 4015.19696060789, 4025.3961905714377, 4055.229506393776, 4073.165001174752, 8401.747947561584, 8411.621477033548, 8425.241728244488, 8425.831483370299, 8476.660933562713, 4324.416203812508, 4325.870223893288, 4332.848350307724, 4344.630706389929, 4349.434573505488, 3362.394768941614, 3402.8468718907707, 3723.1995121049104, 3927.430522574268, 3935.134270460494, 3333.1500467381147, 3356.8657253710066, 3360.5799275090612, 3371.561696979377, 3386.6274709781906, 1091.5633746501462, 1101.0695961912172, 1101.9669409917715, 1108.539955918301, 1108.894655007773, 896.0233345653269, 916.083916083916, 917.6788124156492, 925.6204955968021, 1187.7861984842812, 6793.72825086991, 6848.863022739517, 6852.972054191911, 6862.622555759481, 6884.965575172192, 444.6154076723611, 445.54554354558167, 446.2235709864812, 457.9931301030487, 458.456728776401, 5153.1497302945345, 5174.197999310113, 5182.6113041521285, 5187.533122019036, 5225.059489291964, 8277.213664701843, 8446.873296900552, 8531.360147988802, 8610.13898610134, 8879.24526415262, 8411.45325553837, 8422.915770842335, 8439.367047471464, 8509.574521274035, 8520.0, 6680.565763225375, 6785.355391237825, 6868.244493105754, 7064.646767661597, 7064.823379415556, 6933.791986240421, 7005.859882802213, 7020.508564400443, 7022.052022976833, 7026.824329391601, 7732.9226707732205, 8159.428839981144, 8170.591470426574, 8239.423240373117, 8273.089960104264, 8018.518888866687, 8229.79425514367, 8322.583870806557, 8350.248477637042, 8402.579871006548, 6279.183706118175, 6295.055741638791, 6346.682665866596, 6349.142865713255, 6433.613983160838, 6566.737330506726, 6571.211454625475, 6632.90050649231, 6645.435138013129, 6673.666316684244, 6266.279377871603, 6441.871162576628, 6445.9033114504255, 6533.640649764308, 6559.245686745894, 5976.103584462366, 5979.833932383318, 6030.849228769316, 6094.603850749687, 6216.2540495140875, 5954.910676339945, 5958.731857066356, 5973.49225315853, 5980.9401905980385, 5998.640081595118, 5926.0, 5929.6145750526075, 5969.70151492415, 5971.462568368867, 5972.64164150135, 5730.856728581652, 5822.7670893163795, 5838.766449341979, 5844.035734103995, 5949.0481522956115], "unit": "score", "name": "mootools.html", "value": 4033.4121758239708}, {"lowerIsBetter": false, "replicates": [316.1511342046604, 316.8083309597693, 323.74747696796504, 324.1361770880603, 324.3593902043464, 5518.944810551893, 5575.804846830361, 5622.803201887935, 5637.520810731087, 5708.628939118965, 5536.723163841802, 5555.611107222496, 5565.443455654433, 5581.330240371151, 5582.0, 4091.5499295077516, 4176.14389050244, 4186.204621121992, 4240.766757828318, 4251.681123915711, 4156.2726522858375, 4159.480064991876, 4164.396162556428, 4183.958160418388, 4187.120704652027, 4132.2561938850995, 4133.462649855514, 4133.7106402551835, 4136.21411931732, 4136.4415803866395, 4131.0, 4131.938020929689, 4132.73137246078, 4147.6474499667565, 4151.97924010378, 3616.1140520572367, 3626.0028492164865, 3627.05696518907, 3627.3495559520356, 3637.0543658648944, 5248.257086530519, 5287.127623942045, 5337.039332920072, 5337.359516857963, 5359.732013399314, 4772.141014617368, 4781.306710526954, 4791.0178413425165, 4796.472388037313, 4804.183288840905, 5760.308762948473, 5764.682942438164, 5773.047447171211, 5775.249217601685, 5785.479306862402, 3931.331673615464, 3935.60643935607, 3941.4481972523868, 3942.4086387041884, 3942.5071866016747, 5898.203742494794, 6104.786332478342, 6107.664078475682, 6109.969450152766, 6118.541109416856, 3988.880333589997, 3991.381335892941, 3993.0616305168264, 3997.540282867449, 4005.539362973237, 4050.359604360239, 4051.493563304587, 4052.392141178788, 4054.7972601369815, 4054.8175332110127, 4688.249880019181, 4700.529947005272, 4708.976455117771, 4732.408448943882, 4734.455537613218, 5538.861528461821, 5742.454466825645, 5742.54059675225, 5768.855778605568, 5785.0454674978155, 1442.3076923076983, 1467.8678918897351, 1472.477270568954, 1474.9336279867432, 1475.1739026145392, 967.1972263021676, 978.4129522286571, 981.1513041219437, 996.2876543271595, 996.4270544436978, 5098.872528186751, 5100.0819852426175, 5100.770465329069, 5105.132127538327, 5107.412647545506, 5942.64344139353, 6037.034074548139, 6155.692215389213, 6163.753449862045, 6173.81478555644, 5129.692218466904, 5144.890594856091, 5145.76844042019, 5156.226566015128, 5170.508801663836, 3241.9027429177163, 3292.4073666739737, 3294.901152965415, 3299.290652509722, 3308.4375656138513, 5589.524890384363, 5752.9712351437975, 5753.165790960287, 5753.971230143822, 5768.192453056576, 6273.498120150377, 6286.4342209201395, 6292.937070629327, 6299.590526615755, 6302.401271879165, 5740.942590574041, 5743.798967036218, 5754.884902302014, 5775.364709881826, 5776.133579962955, 6014.578979471395, 6099.84750381244, 6116.908246376397, 6131.110988906673, 6137.877242455036, 5867.706614669335, 5910.408959104056, 5936.28764548257, 5936.732847021981, 5942.702864856827, 5690.345610254708, 5739.426057394227, 5749.453801888814, 5759.51044161251, 5770.8845823082465, 4023.9396409054475, 4028.818703158306, 4030.979845100756, 4039.656629186552, 4040.010197501631, 5962.940370596412, 6067.150598916067, 6074.967255566476, 6092.482139018233, 6100.633961962297, 5859.677717725395, 5873.619699370559, 5879.059350503899, 5880.14737863016, 5882.911756323573, 5846.590738648254, 5859.384764599826, 5861.35525092231, 5863.2670916135485, 5886.58793884424, 5582.637128586792, 5710.114932185518, 5725.942740572541, 5740.942590574041, 5751.1085781703905, 5888.205092312483, 5890.175375447355, 5899.144624029577, 5903.91144132847, 5929.6145750526075, 5616.915746263891, 5690.77236910519, 5701.458361455655, 5703.800366987136, 5739.397363276796], "unit": "score", "name": "prototype.html", "value": 4338.4117328013135}, {"lowerIsBetter": false, "replicates": [799.6601444386134, 802.0976401548259, 804.175719887116, 805.9677612895484, 833.9999999999998, 11044.282121662096, 11185.217034807547, 11185.217034807567, 11226.04578610817, 11235.60675376361, 10607.204459665536, 10843.67468975932, 10894.891051089488, 12741.108122431433, 13038.413271402786, 777.2344240922687, 785.0892964161588, 792.3581898662102, 799.588212070784, 802.0335495727634, 791.6358475101431, 791.9643616037264, 794.8807678848161, 794.9125596184415, 795.7135431244748, 826.1531929772002, 826.5164878546058, 826.5454000299841, 827.0365024746194, 827.3339961331126, 820.7127505373131, 822.6421506644568, 822.847773161961, 823.7240524424325, 824.47233770387, 616.7717944360616, 617.3671986214166, 617.9969100154516, 619.6065498408543, 620.8106527509108, 11386.54453821846, 11435.885641143564, 11457.541698332057, 11568.305901645928, 11572.247803892804, 11192.552297908074, 11482.138839586982, 11486.597969071043, 11586.826197607043, 11869.643910682693, 9184.862227066533, 9236.937826585357, 9237.214836738885, 9242.399244049115, 9269.536523173814, 3174.3016536361965, 3202.151429871086, 3212.8232947187894, 3249.8050116993054, 3253.300540383805, 38546.61453385487, 38803.0, 39419.60580394188, 39844.80077599623, 39890.0, 8905.376623636414, 8987.730368088967, 9122.133397327243, 9225.815483690423, 9242.907570924339, 15083.321250543751, 15116.168610726296, 15137.924310378598, 15189.772153417707, 15226.086434813946, 5999.400059993965, 6006.909896351558, 6055.7274922628585, 6060.121282414026, 6229.844253893598, 3652.0, 3652.4886515887797, 3675.963240367562, 3729.701623870084, 3799.9430008549894, 2572.691277046729, 2640.524705553019, 2641.1944356970926, 2642.167717169086, 2647.695515015798, 492.1559525413932, 497.5820310938756, 503.93700787401576, 512.4004914250336, 517.350724840323, 470.49656867152504, 499.47804544251346, 558.8794467093452, 559.9664020158804, 565.3752603373296, 6754.5947243165565, 6862.588244705334, 6926.376626103574, 7818.68725250995, 8185.754427367188, 460.5486623109372, 593.3947373678824, 606.6542071019477, 615.5629503052793, 630.3224034163293, 3642.4718415829557, 3854.6338097880657, 3964.2269757397607, 3989.5611482736876, 4137.338025915839, 44213.557864421586, 44270.77864610656, 44351.33472997908, 44360.11279774387, 44402.0, 39202.0, 41389.172216555504, 42941.57058429376, 43525.0, 43727.78136109299, 34409.483857742154, 34617.30765384729, 37920.0, 38177.61822381796, 38202.808985955446, 7829.530228186327, 7895.565743884142, 7952.63272540065, 8029.919700803151, 8232.423730339058, 27986.300342491602, 28542.85728571344, 28608.14175574736, 28869.855650721613, 29012.27469313284, 35687.10782230465, 35729.28541429105, 35889.82055089708, 36853.0, 37056.25887482181, 10274.229432792421, 10352.585896564053, 10511.526981285708, 10603.628872989408, 10616.787664246518, 10964.56141754321, 11020.669379918616, 11075.612353567587, 11076.833847492133, 11237.831432528355, 10636.52135653882, 10738.175282589964, 10782.299150555189, 10861.185411094042, 11331.546738130712, 9949.502524873582, 10122.240831937781, 10159.7460063499, 10240.18078553699, 10269.691909242734, 10370.533326000499, 10415.583376665152, 10419.53112109972, 10682.359058456517, 11041.282316649393, 8401.175825818198, 8506.659733610586, 8665.43674661145, 8787.428817126865, 8981.101889810967, 8710.172533609297, 8975.28197744192, 9012.594433250388, 9169.174774270348, 9196.540172991457], "unit": "score", "name": "yui.html", "value": 5614.666897123835}], "name": "dromaeo_css", "value": 6143.966454739092}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 117.0, 114.0, 115.0, 124.0, 113.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.9}, {"lowerIsBetter": true, "replicates": [165.0, 134.0, 162.0, 173.0, 144.0, 166.0, 154.0, 145.0, 171.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 154.9}, {"lowerIsBetter": true, "replicates": [166.0, 164.0, 165.0, 164.0, 164.0, 164.0, 169.0, 166.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 75.0, 72.0, 133.0, 74.0, 72.0, 81.0, 73.0, 90.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 141.0, 97.0, 98.0, 97.0, 144.0, 97.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 147.0, 149.0, 147.0, 148.0, 149.0, 148.0, 152.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 71.0, 71.0, 74.0, 71.0, 78.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 95.0, 93.0, 83.0, 83.0, 93.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 126.0, 123.0, 125.0, 122.0, 128.0, 119.0, 135.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [134.0, 146.0, 136.0, 147.0, 149.0, 147.0, 152.0, 149.0, 146.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 73.0, 72.0, 72.0, 70.0, 72.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1549.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [187.05574261129817], "unit": "score", "name": "DeltaBlue", "value": 353.4668280000001}, {"lowerIsBetter": false, "replicates": [277.0850651149903], "unit": "score", "name": "Encrypt", "value": 960.647229}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1057.0221752903908], "unit": "score", "name": "RayTrace", "value": 700.0695134865134}, {"lowerIsBetter": false, "replicates": [710.2272727272727], "unit": "score", "name": "Earley", "value": 938.3799039999997}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [43687.5], "unit": "score", "name": "RegExp", "value": 20.852303290414874}, {"lowerIsBetter": false, "replicates": [591.7159763313609], "unit": "score", "name": "Splay", "value": 137.71979000000002}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20345.82968915914}]} 03:12:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20345.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6143.96"}}} 03:12:00 INFO - Return code: 0 03:12:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:12:00 INFO - # TBPL SUCCESS # 03:12:00 INFO - Running post-action listener: _resource_record_post_action 03:12:00 INFO - Running post-run listener: _resource_record_post_run 03:12:01 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 411541504; Read time: 0; Write time: 329608 03:12:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105594880; Read time: 0; Write time: 87592 03:12:01 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 305946624; Read time: 0; Write time: 242016 03:12:01 INFO - Running post-run listener: _upload_blobber_files 03:12:01 INFO - Blob upload gear active. 03:12:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:12:01 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12:01 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:02 INFO - (blobuploader) - INFO - Done attempting. 03:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:04 INFO - (blobuploader) - INFO - Done attempting. 03:12:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:04 INFO - Return code: 0 03:12:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23be130b67ccff2529dd30a989b7dd90bae32cfa9e1cfe8d965b6c3fd96d15fab0fc741c428f76150ae66cf4781341ce222b658cea112599fca19409f75a6a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d096a5c263657a0d6510f58b611a0d78de28f5ae824e47f23b4d106e13c689375a1548b237a98142f19ae8c02f9c00e858182a891d09a38cfcf1932b403c6d18"} 03:12:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:04 INFO - Contents: 03:12:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a23be130b67ccff2529dd30a989b7dd90bae32cfa9e1cfe8d965b6c3fd96d15fab0fc741c428f76150ae66cf4781341ce222b658cea112599fca19409f75a6a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d096a5c263657a0d6510f58b611a0d78de28f5ae824e47f23b4d106e13c689375a1548b237a98142f19ae8c02f9c00e858182a891d09a38cfcf1932b403c6d18"} 03:12:04 INFO - Copying logs to upload dir... 03:12:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1297.834390 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 03:12:03.827224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 03:12:03.832534) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 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/Fx-Team-Non-PGO/sha512/a23be130b67ccff2529dd30a989b7dd90bae32cfa9e1cfe8d965b6c3fd96d15fab0fc741c428f76150ae66cf4781341ce222b658cea112599fca19409f75a6a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d096a5c263657a0d6510f58b611a0d78de28f5ae824e47f23b4d106e13c689375a1548b237a98142f19ae8c02f9c00e858182a891d09a38cfcf1932b403c6d18"} build_url:https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/LU0F44qQTlaxAUw-wZp7Rw/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/Fx-Team-Non-PGO/sha512/a23be130b67ccff2529dd30a989b7dd90bae32cfa9e1cfe8d965b6c3fd96d15fab0fc741c428f76150ae66cf4781341ce222b658cea112599fca19409f75a6a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d096a5c263657a0d6510f58b611a0d78de28f5ae824e47f23b4d106e13c689375a1548b237a98142f19ae8c02f9c00e858182a891d09a38cfcf1932b403c6d18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 03:12:03.859912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:12:03.860278) ========= 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=eca2ab57546de7b41f256b19000001ef-1452681901.798286-555774956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 03:12:03.940815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 03:12:03.943834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 03:12:03.944140) ========= ========= Total master_lag: 0.26 =========