builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1452550465.06 results: success (0) buildid: 20160111133628 builduid: e79091da622b47e7bb1c8624e0f07124 revision: 08d1d3f7266007e2492a77d579ae3f3008c51dfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.058218) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.058861) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.059166) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.088468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.088759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.105029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.105295) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004743 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.163205) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.163472) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.163869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.164163) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 14:14: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% 84.6M=0s 2016-01-11 14:14:25 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.281991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.282301) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018427 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.331997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.332440) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 08d1d3f7266007e2492a77d579ae3f3008c51dfc --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 08d1d3f7266007e2492a77d579ae3f3008c51dfc --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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 14:14:25,367 truncating revision to first 12 chars 2016-01-11 14:14:25,367 Setting DEBUG logging. 2016-01-11 14:14:25,367 attempt 1/10 2016-01-11 14:14:25,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/08d1d3f72660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 14:14:25,633 unpacking tar archive at: fx-team-08d1d3f72660/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.935390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.935691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.945724) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.946140) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 14:14:25.946661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-11 14:14:25.946957) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:14:26 INFO - MultiFileLogger online at 20160111 14:14:26 in /builds/slave/test 14:14: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 14:14:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:14:26 INFO - {'append_to_log': False, 14:14:26 INFO - 'base_work_dir': '/builds/slave/test', 14:14:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:14:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:14:26 INFO - 'branch': 'Fx-Team-Non-PGO', 14:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:14:26 INFO - 'config_files': ('talos/linux_config.py',), 14:14:26 INFO - 'default_actions': ('clobber', 14:14:26 INFO - 'read-buildbot-config', 14:14:26 INFO - 'download-and-extract', 14:14:26 INFO - 'populate-webroot', 14:14:26 INFO - 'create-virtualenv', 14:14:26 INFO - 'install', 14:14:26 INFO - 'run-tests'), 14:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:14:26 INFO - 'download_minidump_stackwalk': True, 14:14:26 INFO - 'download_symbols': 'ondemand', 14:14:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:14:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:14:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:14:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:14:26 INFO - 'installer_path': 'installer.exe', 14:14:26 INFO - 'log_level': 'info', 14:14:26 INFO - 'log_name': 'talos', 14:14:26 INFO - 'log_to_console': True, 14:14:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:14:26 INFO - 'opt_config_files': (), 14:14:26 INFO - 'pip_index': False, 14:14:26 INFO - 'sps_profile': False, 14:14:26 INFO - 'sps_profile_interval': 0, 14:14:26 INFO - 'suite': 'dromaeojs-e10s', 14:14:26 INFO - 'system_bits': '32', 14:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:14:26 INFO - 'title': 'talos-linux64-ix-041', 14:14:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:14:26 INFO - 'use_talos_json': True, 14:14:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:14:26 INFO - 'work_dir': 'build'} 14:14:26 INFO - ##### 14:14:26 INFO - ##### Running clobber step. 14:14:26 INFO - ##### 14:14:26 INFO - Running pre-action listener: _resource_record_pre_action 14:14:26 INFO - Running main action method: clobber 14:14:26 INFO - rmtree: /builds/slave/test/build 14:14:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:14:26 INFO - Running post-action listener: _resource_record_post_action 14:14:26 INFO - ##### 14:14:26 INFO - ##### Running read-buildbot-config step. 14:14:26 INFO - ##### 14:14:26 INFO - Running pre-action listener: _resource_record_pre_action 14:14:26 INFO - Running main action method: read_buildbot_config 14:14:26 INFO - Using buildbot properties: 14:14:26 INFO - { 14:14:26 INFO - "project": "", 14:14:26 INFO - "product": "firefox", 14:14:26 INFO - "script_repo_revision": "production", 14:14:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:14:26 INFO - "repository": "", 14:14:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:14:26 INFO - "buildid": "20160111133628", 14:14:26 INFO - "pgo_build": "False", 14:14:26 INFO - "basedir": "/builds/slave/test", 14:14:26 INFO - "buildnumber": 944, 14:14:26 INFO - "slavename": "talos-linux64-ix-041", 14:14:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:14:26 INFO - "platform": "ubuntu64_hw", 14:14:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:14:26 INFO - "branch": "fx-team", 14:14:26 INFO - "repo_path": "integration/fx-team", 14:14:26 INFO - "revision": "08d1d3f7266007e2492a77d579ae3f3008c51dfc", 14:14:26 INFO - "stage_platform": "linux64", 14:14:26 INFO - "builduid": "e79091da622b47e7bb1c8624e0f07124", 14:14:26 INFO - "slavebuilddir": "test" 14:14:26 INFO - } 14:14:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:14:26 INFO - Running post-action listener: _resource_record_post_action 14:14:26 INFO - ##### 14:14:26 INFO - ##### Running download-and-extract step. 14:14:26 INFO - ##### 14:14:26 INFO - Running pre-action listener: _resource_record_pre_action 14:14:26 INFO - Running main action method: download_and_extract 14:14:26 INFO - mkdir: /builds/slave/test/build/tests 14:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:26 INFO - https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/test_packages.json 14:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/test_packages.json 14:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:14:32 INFO - Downloaded 1302 bytes. 14:14:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:14:32 INFO - Using the following test package requirements: 14:14:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:14:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'jsshell-linux-x86_64.zip'], 14:14:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:14:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:14:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:14:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:14:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:14:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:14:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:14:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:32 INFO - https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:35 INFO - Downloaded 22756958 bytes. 14:14:35 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 14:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:35 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 14:14:36 INFO - Return code: 0 14:14:36 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 14:14: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')]} 14:14:36 INFO - https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:42 INFO - Downloaded 22756958 bytes. 14:14:42 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 14:14:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:14:42 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 14:14:43 INFO - Return code: 0 14:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:43 INFO - https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:45 INFO - Downloaded 11132285 bytes. 14:14:45 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 14:14:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:45 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 14:14:45 INFO - Return code: 0 14:14: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')]} 14:14:45 INFO - https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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 14:14:48 INFO - Downloaded 53749736 bytes. 14:14:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:14:48 INFO - mkdir: /builds/slave/test/properties 14:14:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:48 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:48 INFO - Contents: 14:14:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - Running post-action listener: set_extra_try_arguments 14:14:48 INFO - ##### 14:14:48 INFO - ##### Running populate-webroot step. 14:14:48 INFO - ##### 14:14:48 INFO - Running pre-action listener: _resource_record_pre_action 14:14:48 INFO - Running main action method: populate_webroot 14:14:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:48 INFO - '--tppagecycles', 14:14:48 INFO - '7'], 14:14:48 INFO - 'tests': ['tsvgm']}}, 14:14:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:14:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:14:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:14:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['damp', 'tps']}, 14:14:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['damp', 'tps']}, 14:14:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:14:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:48 INFO - 'other': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'other_l64': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'other_nol64': {'tests': ['a11yr', 14:14:48 INFO - 'ts_paint', 14:14:48 INFO - 'tpaint', 14:14:48 INFO - 'sessionrestore', 14:14:48 INFO - 'sessionrestore_no_auto_restore']}, 14:14:48 INFO - 'svgr': {'tests': ['tsvgx', 14:14:48 INFO - 'tsvgr_opacity', 14:14:48 INFO - 'tart', 14:14:48 INFO - 'tscrollx', 14:14:48 INFO - 'cart']}, 14:14:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['tsvgx', 14:14:48 INFO - 'tsvgr_opacity', 14:14:48 INFO - 'tart', 14:14:48 INFO - 'tscrollx', 14:14:48 INFO - 'cart']}, 14:14:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'tests': ['tp5o']}, 14:14:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--e10s'], 14:14:48 INFO - 'tests': ['tp5o']}, 14:14:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--xperf_path', 14:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:48 INFO - 'tests': ['tp5n']}, 14:14:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:14:48 INFO - 'talos_options': ['--e10s', 14:14:48 INFO - '--xperf_path', 14:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:48 INFO - 'tests': ['tp5n']}}, 14:14:48 INFO - 'talos.zip': {'path': '', 14:14:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - ##### 14:14:48 INFO - ##### Running create-virtualenv step. 14:14:48 INFO - ##### 14:14:48 INFO - Running pre-action listener: _resource_record_pre_action 14:14:48 INFO - Running main action method: create_virtualenv 14:14:48 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:48 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 14:14:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:48 INFO - Using real prefix '/usr' 14:14:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:51 INFO - Installing pip.................done. 14:14:51 INFO - Return code: 0 14:14:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:14:51 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 14:14:51 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 14:14:51 INFO - Using env: {'DISPLAY': ':0', 14:14:51 INFO - 'HOME': '/home/cltbld', 14:14:51 INFO - 'LANG': 'en_US.UTF-8', 14:14:51 INFO - 'LANGUAGE': 'en_US:en', 14:14:51 INFO - 'LOGNAME': 'cltbld', 14:14:51 INFO - 'MAIL': '/var/mail/cltbld', 14:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:51 INFO - 'MOZ_NO_REMOTE': '1', 14:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:51 INFO - 'NO_EM_RESTART': '1', 14:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:51 INFO - 'PWD': '/builds/slave/test', 14:14:51 INFO - 'SHELL': '/bin/bash', 14:14:51 INFO - 'SHLVL': '1', 14:14:51 INFO - 'TERM': 'linux', 14:14:51 INFO - 'TMOUT': '86400', 14:14:51 INFO - 'USER': 'cltbld', 14:14:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:51 INFO - '_': '/tools/buildbot/bin/python'} 14:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:51 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 14:14:51 INFO - Cleaning up... 14:14:51 INFO - Return code: 0 14:14:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:51 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:14:51 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 14:14:51 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 14:14:51 INFO - Using env: {'DISPLAY': ':0', 14:14:51 INFO - 'HOME': '/home/cltbld', 14:14:51 INFO - 'LANG': 'en_US.UTF-8', 14:14:51 INFO - 'LANGUAGE': 'en_US:en', 14:14:51 INFO - 'LOGNAME': 'cltbld', 14:14:51 INFO - 'MAIL': '/var/mail/cltbld', 14:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:51 INFO - 'MOZ_NO_REMOTE': '1', 14:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:51 INFO - 'NO_EM_RESTART': '1', 14:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:51 INFO - 'PWD': '/builds/slave/test', 14:14:51 INFO - 'SHELL': '/bin/bash', 14:14:51 INFO - 'SHLVL': '1', 14:14:51 INFO - 'TERM': 'linux', 14:14:51 INFO - 'TMOUT': '86400', 14:14:51 INFO - 'USER': 'cltbld', 14:14:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:51 INFO - '_': '/tools/buildbot/bin/python'} 14:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:51 INFO - Downloading/unpacking psutil>=0.7.1 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:51 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 14:14:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:14:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:53 INFO - Installing collected packages: psutil 14:14:53 INFO - Running setup.py install for psutil 14:14:53 INFO - building 'psutil._psutil_linux' extension 14:14:53 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 14:14:53 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 14:14:53 INFO - building 'psutil._psutil_posix' extension 14:14:53 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 14:14:54 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 14:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:54 INFO - Successfully installed psutil 14:14:54 INFO - Cleaning up... 14:14:54 INFO - Return code: 0 14:14:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:14: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')]} 14:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14: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')]} 14:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:54 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:14:54 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 14:14:54 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 14:14:54 INFO - Using env: {'DISPLAY': ':0', 14:14:54 INFO - 'HOME': '/home/cltbld', 14:14:54 INFO - 'LANG': 'en_US.UTF-8', 14:14:54 INFO - 'LANGUAGE': 'en_US:en', 14:14:54 INFO - 'LOGNAME': 'cltbld', 14:14:54 INFO - 'MAIL': '/var/mail/cltbld', 14:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:54 INFO - 'MOZ_NO_REMOTE': '1', 14:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:54 INFO - 'NO_EM_RESTART': '1', 14:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:54 INFO - 'PWD': '/builds/slave/test', 14:14:54 INFO - 'SHELL': '/bin/bash', 14:14:54 INFO - 'SHLVL': '1', 14:14:54 INFO - 'TERM': 'linux', 14:14:54 INFO - 'TMOUT': '86400', 14:14:54 INFO - 'USER': 'cltbld', 14:14:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:54 INFO - '_': '/tools/buildbot/bin/python'} 14:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:14:54 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 14:14:54 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 14:14:54 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 14:14:54 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 14:14:54 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 14:14:54 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 14:14:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:14:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:14:56 INFO - Installing collected packages: mozsystemmonitor 14:14:56 INFO - Running setup.py install for mozsystemmonitor 14:14:56 INFO - Successfully installed mozsystemmonitor 14:14:56 INFO - Cleaning up... 14:14:57 INFO - Return code: 0 14:14:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14:57 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')]} 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:57 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')]} 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:57 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:14:57 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 14:14:57 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 14:14:57 INFO - Using env: {'DISPLAY': ':0', 14:14:57 INFO - 'HOME': '/home/cltbld', 14:14:57 INFO - 'LANG': 'en_US.UTF-8', 14:14:57 INFO - 'LANGUAGE': 'en_US:en', 14:14:57 INFO - 'LOGNAME': 'cltbld', 14:14:57 INFO - 'MAIL': '/var/mail/cltbld', 14:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:57 INFO - 'MOZ_NO_REMOTE': '1', 14:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:57 INFO - 'NO_EM_RESTART': '1', 14:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:57 INFO - 'PWD': '/builds/slave/test', 14:14:57 INFO - 'SHELL': '/bin/bash', 14:14:57 INFO - 'SHLVL': '1', 14:14:57 INFO - 'TERM': 'linux', 14:14:57 INFO - 'TMOUT': '86400', 14:14:57 INFO - 'USER': 'cltbld', 14:14:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:57 INFO - '_': '/tools/buildbot/bin/python'} 14:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 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 14:14:59 INFO - Downloading docopt-0.6.1.tar.gz 14:14:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:59 INFO - Running setup.py install for blobuploader 14:14:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:59 INFO - Running setup.py install for requests 14:15:00 INFO - Running setup.py install for docopt 14:15:00 INFO - Successfully installed blobuploader requests docopt 14:15:00 INFO - Cleaning up... 14:15:00 INFO - Return code: 0 14:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:00 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')]} 14:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:00 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')]} 14:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:00 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:15:00 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 14:15:00 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 14:15:00 INFO - Using env: {'DISPLAY': ':0', 14:15:00 INFO - 'HOME': '/home/cltbld', 14:15:00 INFO - 'LANG': 'en_US.UTF-8', 14:15:00 INFO - 'LANGUAGE': 'en_US:en', 14:15:00 INFO - 'LOGNAME': 'cltbld', 14:15:00 INFO - 'MAIL': '/var/mail/cltbld', 14:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:00 INFO - 'MOZ_NO_REMOTE': '1', 14:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:00 INFO - 'NO_EM_RESTART': '1', 14:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:00 INFO - 'PWD': '/builds/slave/test', 14:15:00 INFO - 'SHELL': '/bin/bash', 14:15:00 INFO - 'SHLVL': '1', 14:15:00 INFO - 'TERM': 'linux', 14:15:00 INFO - 'TMOUT': '86400', 14:15:00 INFO - 'USER': 'cltbld', 14:15:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:00 INFO - '_': '/tools/buildbot/bin/python'} 14:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:00 INFO - Running setup.py (path:/tmp/pip-F2Kj3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:00 INFO - Running setup.py (path:/tmp/pip-keq3KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:00 INFO - Running setup.py (path:/tmp/pip-4IudxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:00 INFO - Running setup.py (path:/tmp/pip-9wyJz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:00 INFO - Running setup.py (path:/tmp/pip-R7bMRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:00 INFO - Running setup.py (path:/tmp/pip-BdjiMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:00 INFO - Running setup.py (path:/tmp/pip-wLGriI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:01 INFO - Running setup.py (path:/tmp/pip-7mALEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:01 INFO - Running setup.py (path:/tmp/pip-6kbBxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:01 INFO - Running setup.py (path:/tmp/pip-k9H2Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:01 INFO - Running setup.py (path:/tmp/pip-USEA_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:01 INFO - Running setup.py (path:/tmp/pip-hvJSQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:01 INFO - Running setup.py (path:/tmp/pip-vJTsFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:01 INFO - Running setup.py (path:/tmp/pip-ARROkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:01 INFO - Running setup.py (path:/tmp/pip-f8R6qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:01 INFO - Running setup.py (path:/tmp/pip-fqAi3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:01 INFO - Running setup.py (path:/tmp/pip-tjRqSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:01 INFO - Running setup.py install for manifestparser 14:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:01 INFO - Running setup.py install for mozcrash 14:15:01 INFO - Running setup.py install for mozdebug 14:15:02 INFO - Running setup.py install for mozdevice 14:15:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozfile 14:15:02 INFO - Running setup.py install for mozhttpd 14:15:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozinfo 14:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozInstall 14:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozleak 14:15:02 INFO - Running setup.py install for mozlog 14:15:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for moznetwork 14:15:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:02 INFO - Running setup.py install for mozprocess 14:15:02 INFO - Running setup.py install for mozprofile 14:15:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Running setup.py install for mozrunner 14:15:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Running setup.py install for mozscreenshot 14:15:03 INFO - Running setup.py install for moztest 14:15:03 INFO - Running setup.py install for mozversion 14:15:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:03 INFO - Cleaning up... 14:15:03 INFO - Return code: 0 14:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', '-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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:15:03 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 14:15:03 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 14:15:03 INFO - Using env: {'DISPLAY': ':0', 14:15:03 INFO - 'HOME': '/home/cltbld', 14:15:03 INFO - 'LANG': 'en_US.UTF-8', 14:15:03 INFO - 'LANGUAGE': 'en_US:en', 14:15:03 INFO - 'LOGNAME': 'cltbld', 14:15:03 INFO - 'MAIL': '/var/mail/cltbld', 14:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:03 INFO - 'MOZ_NO_REMOTE': '1', 14:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:03 INFO - 'NO_EM_RESTART': '1', 14:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:03 INFO - 'PWD': '/builds/slave/test', 14:15:03 INFO - 'SHELL': '/bin/bash', 14:15:03 INFO - 'SHLVL': '1', 14:15:03 INFO - 'TERM': 'linux', 14:15:03 INFO - 'TMOUT': '86400', 14:15:03 INFO - 'USER': 'cltbld', 14:15:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:03 INFO - '_': '/tools/buildbot/bin/python'} 14:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:03 INFO - Running setup.py (path:/tmp/pip-ckhklB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:03 INFO - Running setup.py (path:/tmp/pip-wSju86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:03 INFO - Running setup.py (path:/tmp/pip-1Uilkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:03 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)) 14:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:03 INFO - Running setup.py (path:/tmp/pip-rk3cBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:04 INFO - Running setup.py (path:/tmp/pip-mqhTNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:04 INFO - Running setup.py (path:/tmp/pip-MuKzNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:04 INFO - Running setup.py (path:/tmp/pip-Fx1vZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:04 INFO - Running setup.py (path:/tmp/pip-XZXpcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:04 INFO - Running setup.py (path:/tmp/pip-SQ8tFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:04 INFO - Running setup.py (path:/tmp/pip-fGH3Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:04 INFO - Running setup.py (path:/tmp/pip-N_PIq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:04 INFO - Running setup.py (path:/tmp/pip-EwEueA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:04 INFO - Running setup.py (path:/tmp/pip-lsNxbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:04 INFO - Running setup.py (path:/tmp/pip-9cF4ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:04 INFO - Running setup.py (path:/tmp/pip-ZwvMDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:04 INFO - Running setup.py (path:/tmp/pip-SVpm1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:04 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)) 14:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:04 INFO - Running setup.py (path:/tmp/pip-_UA7yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 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)) 14:15:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:06 INFO - Downloading blessings-1.5.1.tar.gz 14:15:06 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 14:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:06 INFO - Installing collected packages: blessings 14:15:06 INFO - Running setup.py install for blessings 14:15:06 INFO - Successfully installed blessings 14:15:06 INFO - Cleaning up... 14:15:06 INFO - Return code: 0 14:15:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:07 INFO - Reading from file tmpfile_stdout 14:15:07 INFO - Current package versions: 14:15:07 INFO - argparse == 1.2.1 14:15:07 INFO - blessings == 1.5.1 14:15:07 INFO - blobuploader == 1.2.4 14:15:07 INFO - docopt == 0.6.1 14:15:07 INFO - manifestparser == 1.1 14:15:07 INFO - mozInstall == 1.12 14:15:07 INFO - mozcrash == 0.16 14:15:07 INFO - mozdebug == 0.1 14:15:07 INFO - mozdevice == 0.47 14:15:07 INFO - mozfile == 1.2 14:15:07 INFO - mozhttpd == 0.7 14:15:07 INFO - mozinfo == 0.9 14:15:07 INFO - mozleak == 0.1 14:15:07 INFO - mozlog == 3.1 14:15:07 INFO - moznetwork == 0.27 14:15:07 INFO - mozprocess == 0.22 14:15:07 INFO - mozprofile == 0.28 14:15:07 INFO - mozrunner == 6.11 14:15:07 INFO - mozscreenshot == 0.1 14:15:07 INFO - mozsystemmonitor == 0.0 14:15:07 INFO - moztest == 0.7 14:15:07 INFO - mozversion == 1.4 14:15:07 INFO - psutil == 3.1.1 14:15:07 INFO - requests == 1.2.3 14:15:07 INFO - wsgiref == 0.1.2 14:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:15:07 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 14:15:07 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 14:15:07 INFO - Using env: {'DISPLAY': ':0', 14:15:07 INFO - 'HOME': '/home/cltbld', 14:15:07 INFO - 'LANG': 'en_US.UTF-8', 14:15:07 INFO - 'LANGUAGE': 'en_US:en', 14:15:07 INFO - 'LOGNAME': 'cltbld', 14:15:07 INFO - 'MAIL': '/var/mail/cltbld', 14:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:07 INFO - 'MOZ_NO_REMOTE': '1', 14:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:07 INFO - 'NO_EM_RESTART': '1', 14:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:07 INFO - 'PWD': '/builds/slave/test', 14:15:07 INFO - 'SHELL': '/bin/bash', 14:15:07 INFO - 'SHLVL': '1', 14:15:07 INFO - 'TERM': 'linux', 14:15:07 INFO - 'TMOUT': '86400', 14:15:07 INFO - 'USER': 'cltbld', 14:15:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:07 INFO - '_': '/tools/buildbot/bin/python'} 14:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 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)) 14:15:07 INFO - Cleaning up... 14:15:07 INFO - Return code: 0 14:15:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:07 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:15:07 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 14:15:07 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 14:15:07 INFO - Using env: {'DISPLAY': ':0', 14:15:07 INFO - 'HOME': '/home/cltbld', 14:15:07 INFO - 'LANG': 'en_US.UTF-8', 14:15:07 INFO - 'LANGUAGE': 'en_US:en', 14:15:07 INFO - 'LOGNAME': 'cltbld', 14:15:07 INFO - 'MAIL': '/var/mail/cltbld', 14:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:07 INFO - 'MOZ_NO_REMOTE': '1', 14:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:07 INFO - 'NO_EM_RESTART': '1', 14:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:07 INFO - 'PWD': '/builds/slave/test', 14:15:07 INFO - 'SHELL': '/bin/bash', 14:15:07 INFO - 'SHLVL': '1', 14:15:07 INFO - 'TERM': 'linux', 14:15:07 INFO - 'TMOUT': '86400', 14:15:07 INFO - 'USER': 'cltbld', 14:15:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:07 INFO - '_': '/tools/buildbot/bin/python'} 14:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:07 INFO - Downloading/unpacking jsonschema 14:15:07 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 14:15:07 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 14:15:07 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 14:15:07 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 14:15:07 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 14:15:07 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 14:15:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:09 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 14:15:09 INFO - Downloading/unpacking functools32 (from jsonschema) 14:15:09 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 14:15:09 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 14:15:09 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 14:15:09 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 14:15:09 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 14:15:09 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 14:15:09 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:09 INFO - warning: no files found matching '*.txt' 14:15:09 INFO - no previously-included directories found matching 'build' 14:15:09 INFO - no previously-included directories found matching 'dist' 14:15:09 INFO - no previously-included directories found matching '.git*' 14:15:09 INFO - Installing collected packages: jsonschema, functools32 14:15:09 INFO - Running setup.py install for functools32 14:15:09 INFO - warning: no files found matching '*.txt' 14:15:09 INFO - no previously-included directories found matching 'build' 14:15:09 INFO - no previously-included directories found matching 'dist' 14:15:09 INFO - no previously-included directories found matching '.git*' 14:15:09 INFO - Successfully installed jsonschema functools32 14:15:09 INFO - Cleaning up... 14:15:09 INFO - Return code: 0 14:15:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:09 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 0x7fa82eff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1309dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', '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 14:15:09 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 14:15:09 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 14:15:09 INFO - Using env: {'DISPLAY': ':0', 14:15:09 INFO - 'HOME': '/home/cltbld', 14:15:09 INFO - 'LANG': 'en_US.UTF-8', 14:15:09 INFO - 'LANGUAGE': 'en_US:en', 14:15:09 INFO - 'LOGNAME': 'cltbld', 14:15:09 INFO - 'MAIL': '/var/mail/cltbld', 14:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:09 INFO - 'MOZ_NO_REMOTE': '1', 14:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:09 INFO - 'NO_EM_RESTART': '1', 14:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:09 INFO - 'PWD': '/builds/slave/test', 14:15:09 INFO - 'SHELL': '/bin/bash', 14:15:09 INFO - 'SHLVL': '1', 14:15:09 INFO - 'TERM': 'linux', 14:15:09 INFO - 'TMOUT': '86400', 14:15:09 INFO - 'USER': 'cltbld', 14:15:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:09 INFO - '_': '/tools/buildbot/bin/python'} 14:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:10 INFO - Downloading/unpacking flake8 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:11 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 14:15:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:11 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 14:15:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:11 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 14:15:12 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 14:15:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:12 INFO - no previously-included directories found matching 'docs/_build' 14:15:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:12 INFO - Running setup.py install for pep8 14:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:12 INFO - no previously-included directories found matching 'docs/_build' 14:15:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:15:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:15:12 INFO - Cleaning up... 14:15:12 INFO - Return code: 0 14:15:12 INFO - Running post-action listener: _resource_record_post_action 14:15:12 INFO - Running post-action listener: _start_resource_monitoring 14:15:12 INFO - Starting resource monitoring. 14:15:12 INFO - ##### 14:15:12 INFO - ##### Running install step. 14:15:12 INFO - ##### 14:15:12 INFO - Running pre-action listener: _resource_record_pre_action 14:15:12 INFO - Running main action method: install 14:15:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:12 INFO - Reading from file tmpfile_stdout 14:15:12 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:13 INFO - Reading from file tmpfile_stdout 14:15:13 INFO - Output received: 14:15:13 INFO - Usage: mozinstall [options] installer 14:15:13 INFO - Options: 14:15:13 INFO - -h, --help show this help message and exit 14:15:13 INFO - -d DEST, --destination=DEST 14:15:13 INFO - Directory to install application into. [default: 14:15:13 INFO - "/builds/slave/test"] 14:15:13 INFO - --app=APP Application being installed. [default: firefox] 14:15:13 INFO - mkdir: /builds/slave/test/build/application 14:15:13 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'] 14:15:13 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 14:15:28 INFO - Reading from file tmpfile_stdout 14:15:28 INFO - Output received: 14:15:28 INFO - /builds/slave/test/build/application/firefox/firefox 14:15:28 INFO - Running post-action listener: _resource_record_post_action 14:15:28 INFO - ##### 14:15:28 INFO - ##### Running run-tests step. 14:15:28 INFO - ##### 14:15:28 INFO - Running pre-action listener: _resource_record_pre_action 14:15:28 INFO - Running main action method: run_tests 14:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:28 INFO - Python 2.7.3 14:15:28 INFO - Return code: 0 14:15:28 INFO - grabbing minidump binary from tooltool 14:15:28 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')]} 14:15:28 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 0x139c3d0>, '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 0x1307ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1308360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:28 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 14:15:28 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 14:15:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:28 INFO - Return code: 0 14:15:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:15:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:15:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:15:29 INFO - Return code: 0 14:15:29 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/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 14:15:29 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/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 14:15:29 INFO - Using env: {'DISPLAY': ':0', 14:15:29 INFO - 'HOME': '/home/cltbld', 14:15:29 INFO - 'LANG': 'en_US.UTF-8', 14:15:29 INFO - 'LANGUAGE': 'en_US:en', 14:15:29 INFO - 'LOGNAME': 'cltbld', 14:15:29 INFO - 'MAIL': '/var/mail/cltbld', 14:15:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:29 INFO - 'MOZ_NO_REMOTE': '1', 14:15:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:29 INFO - 'NO_EM_RESTART': '1', 14:15:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:29 INFO - 'PWD': '/builds/slave/test', 14:15:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:29 INFO - 'SHELL': '/bin/bash', 14:15:29 INFO - 'SHLVL': '1', 14:15:29 INFO - 'TERM': 'linux', 14:15:29 INFO - 'TMOUT': '86400', 14:15:29 INFO - 'USER': 'cltbld', 14:15:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856', 14:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:29 INFO - '_': '/tools/buildbot/bin/python'} 14:15:29 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/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 14:15:29 INFO - mozversion application_buildid: 20160111133628 14:15:29 INFO - mozversion application_changeset: 08d1d3f7266007e2492a77d579ae3f3008c51dfc 14:15:29 INFO - mozversion application_display_name: Nightly 14:15:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:29 INFO - mozversion application_name: Firefox 14:15:29 INFO - mozversion application_remotingname: firefox 14:15:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:15:29 INFO - mozversion application_vendor: Mozilla 14:15:29 INFO - mozversion application_version: 46.0a1 14:15:29 INFO - mozversion platform_buildid: 20160111133628 14:15:29 INFO - mozversion platform_changeset: 08d1d3f7266007e2492a77d579ae3f3008c51dfc 14:15:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:15:29 INFO - mozversion platform_version: 46.0a1 14:15:29 INFO - using testdate: 1452550529 14:15:29 INFO - actual date: 1452550529 14:15:29 INFO - starting webserver on 'localhost:38370' 14:15:29 INFO - SUITE-START | Running 3 tests 14:15:29 INFO - TEST-START | dromaeo_css 14:15:29 INFO - operating with platform_type : linux_ 14:15:29 INFO - Initialising browser for dromaeo_css test... 14:15:29 INFO - TEST-INFO | started process 5114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBEcLV/profile http://localhost:38370/getInfo.html) 14:15:34 INFO - PROCESS | 5114 | 14:15:34 INFO - PROCESS | 5114 | (process:5196): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:15:35 INFO - PROCESS | 5114 | __metrics Screen width/height:1600/1200 14:15:35 INFO - PROCESS | 5114 | colorDepth:24 14:15:35 INFO - PROCESS | 5114 | Browser inner width/height: 1024/697 14:15:35 INFO - PROCESS | 5114 | __metrics 14:15:35 INFO - PROCESS | 5114 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:15:36 INFO - TEST-INFO | 5114: exit 0 14:15:36 INFO - Browser initialized. 14:15:36 INFO - Running cycle 1/1 for dromaeo_css test... 14:15:36 INFO - TEST-INFO | started process 5245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBEcLV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:37 INFO - PROCESS | 5245 | 14:15:37 INFO - PROCESS | 5245 | (process:5301): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:15:48 INFO - PROCESS | 5245 | RSS: Main: 150097920 14:15:48 INFO - PROCESS | 5245 | 14:16:37 INFO - PROCESS | 5245 | 1452550597770 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] 14:18:49 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38370/tests/dromaeo/cssquery-ext.html) 14:18:50 INFO - PROCESS | 5245 | RSS: Main: 153427968 14:18:50 INFO - PROCESS | 5245 | 14:21:52 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-ext.html (next: http://localhost:38370/tests/dromaeo/cssquery-jquery.html) 14:21:53 INFO - PROCESS | 5245 | RSS: Main: 151883776 14:21:53 INFO - PROCESS | 5245 | 14:24:55 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38370/tests/dromaeo/cssquery-mootools.html) 14:24:55 INFO - PROCESS | 5245 | RSS: Main: 151007232 14:24:55 INFO - PROCESS | 5245 | 14:27:57 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38370/tests/dromaeo/cssquery-prototype.html) 14:27:58 INFO - PROCESS | 5245 | RSS: Main: 150585344 14:27:58 INFO - PROCESS | 5245 | 14:31:00 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38370/tests/dromaeo/cssquery-yui.html) 14:31:01 INFO - PROCESS | 5245 | RSS: Main: 151404544 14:31:01 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | Cycle 1(1): loaded http://localhost:38370/tests/dromaeo/cssquery-yui.html (next: http://localhost:38370/tests/dromaeo/cssquery-dojo.html) 14:34:04 INFO - PROCESS | 5245 | RSS: Main: 153300992 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | __start_tp_report 14:34:04 INFO - PROCESS | 5245 | _x_x_mozilla_page_load 14:34:04 INFO - PROCESS | 5245 | _x_x_mozilla_page_load_details 14:34:04 INFO - PROCESS | 5245 | |i|pagename|runs| 14:34:04 INFO - PROCESS | 5245 | |0;dojo.html;2617.489589530042;2676.1168814291286;2708.851013194275;2717.932051698706;2734.3437574982;4524.298733696282;4604.148232576971;4624.306354046895;4643.512431194727;4649.976750116249;4553.22595158823;4569.268916973277;4602;4632.675712700112;4646.395968524095;4308.526062133163;4344.63070638996;4398.340248962665;4400.185965596359;4436.401085853417;4311.5472875348105;4338.501072376685;4373.497047839492;4433.600975912167;4447.977760111195;4181.477315335583;4211.073563815956;4312.913741725148;4360.716553424049;4392.704152275087;4330.913381732347;4348.173846969065;4350.042990542107;4351.782410879475;4398.868033958986;4305.397244385788;4323.935140972888;4326.329418940069;4334;4355.912881742379;4409.559044095597;4513.390692256537;4523.2988886722615;4531.478879928784;4611.446626404853;4962.87592810179;4993.251012348177;5009.924851127236;5010.949890501085;5030.496950304977;5016.849494515171;5021.824236151717;5022.146235140035;5026.220935754964;5053.065182941167;4482.462104547442;4585.335126406719;4591.265397536378;4680.204365257914;4700.976495117571;5068.923966140511;5070.264811602297;5085.821996230115;5089.262057001714;5135.024345374367;4874.95125048745;4876.341693871282;4877.146499362598;4886.3403440535785;4938.950610493921;4838.080764654705;4919.2129259318335;4962.801487940442;4969.155243608595;4996.150654388763;4937.1113199624415;4943.728094954812;4947.480514545993;4949.802007919643;4987;4705.4588722296685;4874.2201247800185;4917.877053073702;4923.77842997066;4926.975365123151;4161.04296011919;4185.686073544496;4212.831486740557;4242.278812601865;4281.871543853689;3690.446433035066;3691.169486865434;3712.795796231233;3714.4799728038097;3750.0437388465766;4175.436316097349;4293.549177336397;4340.804663790137;4365.301551751704;4392.05570802279;4938.950610493921;4958.305837182797;5013.498650134958;5090.821821236313;5138.948610513847;4308.418363520885;4312.827486900552;4331.415258940003;4344.782760861945;4367.6287515561535;4312.417823593774;4477.888052798706;4478.910421791546;4487.192305384997;4510.548945105529;4719.5752382285755;4727.999999999931;4786.425628924551;4811.302361157683;4840.2255639097575;4958.6281028923695;4990.925136123034;4992.675476094042;5000.324956130876;5032;4591.403117594691;4689;4753.429588449409;4758.381410416624;4808.3989501312335;4870.269459581091;4914.483979182278;4950;4950.975245123751;5003.54968052877;4954.628402869727;4960.677555958851;4999.10016197088;5016.698998059982;5038.445770965118;4667.32323813052;4703.788329525111;4799.088173247072;4840.322354870392;4885.364902562644;4856.611471082234;4863.927041094457;4864.343313652753;4873.731944743073;4907.9263811043575;4667.719936803803;4742.2175341069715;4761.214399624023;4768.451628062817;4815.036992601564;4743.075100355398;4818.759062046814;4875.585575226146;4892.461829198856;4949.826756063664;4786.760661966958;4794.808207671654;4821.5178482151505;4828.082664293773;4856.73287969151 14:34:04 INFO - PROCESS | 5245 | |1;ext.html;495.65056635072256;498.85782551972693;521.9425863155054;538.504575790273;539.360857384;31824.20439489014;32733;32745.836270818614;32861.342773144526;32873.17817054572;35939.28121437576;36213;36234.8188259059;36237.275254494896;36350.8182459088;7737.22627737226;7852.05775306964;7908.446408751361;7909.644066017043;7919.287264146225;7638.618069096551;7721.691132354699;7785.260400261966;7960.681572737083;7973.521588704667;7932.325752311061;7961.164077771838;7961.60191990401;8011.67953281868;8052.758417247463;7923.524588524678;7968.521888686697;8010.439269251126;8011.959940200261;8024.598770061532;7809.258120478602;7888.211178882066;7925.405594580429;7930.1276859545405;7958.283754462126;36676.26647467062;36851.262974740355;37067.81466092679;37092.629073709184;37128.44307335392;2975.7619390448713;3086.722195002438;3096.3033317503605;3331.738246201693;3443.8450269737923;28035.29911752202;28125;28137;28527.144185674464;28794.280142996384;3407.4548072308557;3413.6004238262194;3488.180277634754;3498.510208570802;3521.4013617685055;169991.150044249;171384;171627;172139.13930430394;172198;48193;49612.25581616279;52347;52524.474755252726;56653.43346566564;50830.237546436096;51027.74486127545;51233.48766512287;51271;51398.486015140115;13690.863091369158;13807.240601767;13839.930800345934;13867.791983120262;13888.513902013583;10031.147352474976;10041.19670426364;10043.447610381352;10052.849207261897;10053.246006549392;18991.43025709231;19061.42815715503;19583.314583989493;19850.404487865388;19952.900235498728;7785.403992181702;7900.170482099412;7991.600419978978;8101.392395570356;8139.186081391814;830.4477522447626;856.7215654912054;864.1833467373272;871.2855458524076;1002.979940401188;23196.65205021926;23483.647745283834;23894.64158037631;24418.511629767305;24641.383965401008;761.2463660975704;924.9306302027375;940.3840484482674;1004.4475538453821;1129.4973736687095;12294.20087694297;12492.81260781089;12601.432935517923;12604.621861344174;12706.428210730539;369749;370692;374073;375397;375656;43635.127297454506;44691.77654111774;44694.10611787746;44696.3295550567;44815.77592112084;1224.4245204753752;1228.6498347970785;1239.6714870559308;1268.4545645372577;1271.9872801272054;24871.50256994886;25666.871665641553;25860.741392585835;27886.636280583887;28033.29916752016;40555.79722101371;40926.795366022976;40996.385054224804;41030.1793964125;41318;235837;238472;238497;239498;240094;29539.55690664685;42079;42554.78722606491;42564;43293.783531083405;40556;41600.37599435951;41601.37597936094;42243.57756422397;42426;29451;30300.24249393783;30439.71702122394;30528.694713052584;30677.693223067483;30942.381152376376;30955.845220773754;31005.844970775;31333.216669583442;33849.15377115493;30350.696493034786;30851.69148308578;30995.380092397576;31174;31313;26193.73806261913;27324.590131147652;28927.276818079717;28942.506466399216;31569.52645710362;21658.783412166307;22071.448213794785;22309.553808924054;22594.322170334915;23411.180608678613 14:34:04 INFO - PROCESS | 5245 | |2;jquery.html;335.7951649493808;338.9762716609837;343.1575482191219;344.7552237911083;345.2043040790976;14302.427902883885;14439.917006224536;15050.698986020274;15472;15684.058956462606;10307;10394;10410.11514021309;13248.867511324885;14696.853031469682;4477.238869392203;4529.365888775574;4702.553257440538;4709.246520556711;5002.0246052019875;4895.6083513318845;4904.0437114762635;4960.181570040939;4964.975175124119;4968.70187788732;3446.8104254266004;3596.2627661329498;4917.065757506062;4942.332785074005;5110.540051395374;5233.476652334774;5237.319148510707;5250.212468129773;5270.051390749663;5311.203319502067;4903.950960490385;5075.720835354054;5085.059264036128;5092.388913330387;5112;11086.944565277203;11282.492287847066;14122.364493597814;17918;17985.370512032147;1751.8773685841995;1835.9265629374809;1871.4759867237196;1901.9239230430767;1959.941631518978;8899.644014239422;8943.373963822534;9034.051424600453;9047.230985366252;11651.184417090806;1718.4415065103892;1730.6971280025946;1733.298014304209;1743.4420985284714;1796.3084212578121;30954.38091238185;32379.352412951845;32569.185770355693;46522.76738616285;49864;9376.203022743142;9773.849753054317;9779.902200978042;9785.902140978642;9870.161036311994;12322.568710095104;12362.44369003397;12393.566225182076;12401;12479.438425270884;6891.173059232924;6977.581345119309;6982;6985.511014229057;7044.084269044992;6602.801915942433;6622.2715501294815;6628.8674226515195;6640.501962352843;6674.399304062657;3880.0881792778673;3993.780342081155;4105.548389677133;4174;4253.1706317267835;1724.1982478147722;1764.5765016395972;1774.9201285942163;1784.6252287019872;1807.5752198233404;383.8886722850342;392.13142888501534;398.2870661515912;434.11440661051734;810.2828996338283;9261.861072083924;9391.060893910555;9486.430814151174;9645.180159686364;9669.806603867883;399.9760014399145;403.929312370334;406.6929468251451;416.78535554189614;422.8815931539174;5198.870028249248;5305.8938821223355;5414.106672399089;5433.266509021231;5447.809326673548;412376;414801;415932;420019;437243;59794;60285;60871.69564152151;60945.39054609397;61089.694551526954;448.2872233149308;459.6552585560829;459.81377542095504;461.057138152479;461.9053094115698;9077.09229077087;9104.90895091067;9134;9232.538373081185;9306.06939306064;26414.339641509116;26704.332391690365;26895.327616809736;30152.24619384533;31503.36993260168;34950.475742864386;35196;35220.47169292411;36125.458118127724;36515.26969460649;2527.699455939025;4779.115863565252;5954;6232.127502149793;6353;7063.611501367474;8191.508509489449;9365.344425890122;9446.433214006907;9484.193843523377;5983.252093488314;6035.728392222272;6081.300650425258;6122.785702500391;6420.711068001858;5981.581289309706;6002.879942401215;6256.186695729526;6439.484841212786;6469.967650161907;6197.597156184834;6292.874142517033;6354.618722876642;6414.903776443264;6471.935280647133;8655.30757539408;8868.581027035902;8879.955600221958;9021.548922553977;9043.095690430904;6162.537809664203;8229.25936665703;8304.169583041648;8419;8564.74305770828 14:34:04 INFO - PROCESS | 5245 | |3;mootools.html;1375.7248550289942;1385.826771653543;1520.97718534222;1731.1776905969673;1749.6325771587965;6222.657753823538;6330.96834515828;7085.964570177149;7213.134423869136;7258.310460506256;6879.4840386971055;7005.684744186511;7077.433805295564;7112.431005519559;7115.18175409828;2066.173530587762;2086.040421406155;2090.090810497431;2092.7174831397797;2095.21429463951;2100.905459254337;2117.1319758898853;2120.7561130469962;2194.034624765098;2201.273579718689;2102.358780571925;2114.302280247515;2124.150339864051;2128.159377046066;2132.605467988427;2106.6313395155785;2121.8832964186963;2122.564874200785;2122.8195603373733;2125.7767934366825;2096.727425434699;2139.8609090409072;2143.057054895841;2148.656215005607;2149.8602590831547;7290.942813292043;7316.707331706725;7351.595662238575;7356.117265928123;7368.815779605499;4329.653627709776;4455.309427038814;4455.398521199629;4460.977695111536;4461.04087621163;2771.6003418273845;2774.4589804988036;2849.088291746642;2852.786041046909;2857.957130643042;850.7958090058403;871.895372555291;882.1266945723752;910.0671811393308;910.8952470465915;10007.64973225941;10011.048950349705;10011.849822252672;10069.244806639457;10083.44541050242;4035.53591337;4036.8183431745642;4057.594240575919;4090.3455447128317;4166.500019997619;8637.956810215908;8642.178992995656;8664.003639581402;8667.306615470747;8701.521416322163;4434.623057040123;4468.262736648481;4472.284434490531;4480.865574032784;4488.349189367524;3403.3873902697255;3499.3001399720156;3888.8055597220027;4010.318245898146;4015.7590544566833;3506.474028895635;3515;3556.928861422809;3585.3367127081574;3593.6765691087926;1144.6108323170163;1148.7645032768262;1150.2350936627217;1150.2983180260035;1150.5627861412609;898.4743924804063;953.5565961827645;1165.4289398194824;1175.7648470305974;1200.7298357869408;6793.762218322335;6798.354156355138;6816.897746533806;6835.350641689031;6839.692213850389;1049.6536143072767;1062.2882668612049;1062.373199812099;1063.723431907694;1081.9621313254;5404.648697834628;5421.810236641699;5443.265159203457;5449.918251226235;5462.644928079662;8224.794380140425;8669.739907802776;8839.955800220958;8859.601317940707;8900.465972041698;8700.434471759316;8723.171298726611;8728.996165441056;8743.213110820057;8805.075467075992;6545.410913017851;6623.768168114093;6669.599824010575;6705.798826035227;6740.258571557125;6417;6424.51816113784;6427.357264273535;6473.741050358121;6499.415052645285;7367.373773229336;7399.704011839466;7515.210902855121;7618.504797188165;7669.233076692286;7587.962060189664;7674.194209608134;7699.076110866732;7788.922110779046;7836.412269079728;5368.248445217595;5471.480209380103;5746.2529871116485;5995.700214989146;6114.816555503342;6490.513211509061;6527.836804079936;6538.542302038812;6542.051402546699;6546.672666366758;6098.542609304409;6137.631742095488;6172.105044768573;6196.938030619816;6284.528660350584;6079.331273559993;6119.571629985859;6124.418180272867;6192.473639740492;6215.192025036717;6205.348438413902;6377.394147555975;6399.104125422352;6407;6410.038494225903;6033.064874944391;6057.545684073624;6067.757289708539;6068.332483426908;6069.787557435468;5879.2944846616965;5932.110183472513;6009.429104235091;6045.667488288186;6050.7277172526465 14:34:04 INFO - PROCESS | 5245 | |4;prototype.html;305.6866711620589;313.81955375659004;323.787918913112;330.27998962262257;333.66800033966206;5518.420565840589;5597.552195824334;5634.3802181759975;5720.8283751487415;5753.338366087901;5593.105103183481;5617.4382561743805;5657.010023245936;5657.23627310314;5658.207850900877;4187;4308.763018034007;4325.091730736549;4363.149185908741;4372;4313.978430107845;4317.676174286926;4323.848665296715;4325.98339390243;4328.870133895988;4270.017895883949;4272.46594175728;4279.48646162461;4280.978595107035;4281.785910704468;4250.06498570314;4276.850310239158;4277.016286254147;4286.207051695446;4289.292266775994;3677.3380791457525;3729.81350932455;3732.4883422214048;3739.551253849528;3775.6413140751583;5269.473052694738;5380.085385484438;5418.566514678816;5437.918431223535;5438.510534051954;4973.7513124344;4980.402351717781;4981.277714731344;4981.850544483671;4991.525805048551;5928.64428134309;5951.49412299955;5958.880822383571;5964.761409543613;5964.940350596482;3914.6476817086314;4061.431399604058;4066.755994640331;4072.7352722073265;4080.795960202008;6101.206843110412;6135.601185922901;6150.8769824603705;6180.042093475518;6184.783532576384;4147.958520414818;4152.169566086734;4163.3130533462245;4164.6251837334785;4167.374893765959;4206.537280899099;4233.322668373045;4240.618344349024;4241.045764702917;4245.577731459995;4662.347271382009;4784.330193772875;4889.046635906036;4901.362822833009;4918.729469879119;5860.677662728505;5921.970390148108;5925.05199168131;5926.1999630049395;5928.881422371528;1497.2438918346384;1518.5216656753307;1523.1850959736487;1528.1289664890905;1532.2415404374683;976.72651657536;1015.4973288222377;1015.720676813882;1017.5370206555999;1021.1932573267185;5182.792688292501;5183.974080129575;5189.221616757516;5202.063628546898;5203.60972927032;6158.661273629904;6192.442680158807;6203.751849925952;6222.066689996536;6227.470664993526;5169.689818610896;5173.042987047333;5185.274061631375;5213.739313034409;5228.006678731029;3268.836558172082;3320.335932813447;3358.9160270992934;3376.2234686022352;3397.5583174187195;5837.708114594253;5897.115432685132;5900.76396944126;5901.3508514063415;5911.142884281755;6340.461060809883;6376.362363763679;6417.133686952295;6438.7102580384;6451.322611125858;5746.856328591903;5883.588148829541;5895.351511333835;5899.7050147492455;5912.142739302777;6218.720157593009;6252.1559589456665;6262.718177681924;6264.248290205204;6270.717817698123;6073.089036644538;6081.027035674271;6084.11780291864;6091.573589848846;6092.147099405998;5776.942230577641;5867;5875.6474611523445;5891.705414729161;5906.468417842415;4197.97901010493;4239.279322515118;4240.703150779415;4242.703010789215;4247.915041699087;5933.762649493972;6049.3950604939155;6249.375062493714;6272.96496078142;6274.435300822948;5868.823935281948;5960.344362120077;5987.461128498456;5992.67040312787;5995.940040599538;5878.970605146947;5987.5808693391045;5988.191594134911;5994.520438364833;5996.4902983245165;5718.370979192368;5845.444682755132;5858.8242352729485;5860.648361098348;5871.6770577618645;5997.940020599913;6030.246219222598;6039.849003774941;6041.18444010053;6048.6975651218145;5787.971060144672;5873.3832947539895;5882.735276912464;5885.264341957255;5886.440788125121 14:34:04 INFO - PROCESS | 5245 | |5;yui.html;748.8165399477127;783.7335305995961;796.3231253434582;803.1326167738843;806.5402720449342;10298.33060851045;10455.529501172447;10484.423356715377;10486.947565262173;10513.579456821728;10679;10730.624428145016;10745.247832651718;11449.713757156054;11459.770804583903;782.0810547606568;789.8380831929469;795.4034474144391;795.932345750612;806.6813608624619;800.0479429478902;803.8593246181924;806.3025482957258;807.5840941914919;809;832.6253186066264;842.4524059361434;844.5650489997656;844.6536919862857;845.7843249971279;824.6701319472229;828.2462958707578;831.9126491718373;832.3133414932644;834.1116710703143;622.2564035977009;623.7006237006217;624.1511544299749;627.9843003924892;628.9654069026202;11250;11313.377764222965;11316.547338106466;11331.716707082389;11340.03609693177;11236.494357753922;11310.434478276053;11444.084473242121;11640.534378624845;11887.643370698894;8744.882069957082;8852.291816654651;8884.73345799627;8894.332925030649;8931.419457735226;3192.409404260196;3230.370077834823;3231.3214225012775;3236.6116066072223;3240.2547414094656;37652.43521347182;38120.80939595312;38249.61750382516;38426.807865960494;38478.038049049;9102.887997226017;9127.77180570491;9191.724248272563;9348.065193480597;9462.52687365629;15873.285702143432;15938.362465501483;15942.840571594368;15947.521574352788;15955.680886382439;6072.240969878765;6308.716107775161;6311.368863113652;6400.807975760735;6460.644664543495;3575.80333081683;3606.3688854450365;3607.6572725591027;3613.6928361089604;3615.692666123409;2636.9979407824903;2689.6906855711845;2700.932476688059;2706.864656767154;2709.403931135147;475.56248251608605;479.5707841481854;487.16208122030054;489.3687143584807;489.3760455419298;463.768115942029;535.568867062011;550.2818821437982;585.344414256036;608.4402349838159;6718.49611279156;6978.0230767692565;7021.929780702128;7039.54242974205;7079.115110611174;492.72161228905554;494.19372194628687;524.9396319423239;568.3151802078486;605.1799811255773;3031.8938837140595;3121.734652554558;3122.172624254574;3164.5411415344647;3199.82400967949;43811.780941095094;43921.560784392386;44264.3360349595;44358.33462498065;44630.55369446329;39732.60267397289;39742.40386394206;39814.2037159261;39895.80052099779;40710.185796283906;36127.63872361295;36718.449223261676;36721.63278367236;37225.44161837575;37532.24935501275;7425.628718564159;7532.924670753222;7591.4685971981435;7640.503367281109;7682.692692292246;27870.44259114847;28082;28127;28950.855245723636;29292.414151717272;34044.829775851955;34665.133371665914;35079.82460087683;35088.298234034664;35653.64346356503;9425.57584908667;9634.036596340591;9819.116279534876;9960.103590676585;10346.793064138825;10693;10768.246222764332;10797.460126993461;10958.945205274242;11470.713232169262;9143.13140251675;9475.810483790423;9521.143097121292;9525.14273715369;9548.331616786758;9967.750806229902;9992.350497217658;10349.74125646865;10543.94728026355;10904.291221070922;9188.49463279526;10192.082712555906;10464.267501275142;10466.581336746445;10498.212634052325;8292.17078292166;8733.908261467317;8887.555622218992;8929;9122.589483473126;7700.691972321044;7880.133185349721;7889.802754931173;7990.800229994296;8660.307175425825 14:34:04 INFO - PROCESS | 5245 | __end_tp_report 14:34:04 INFO - PROCESS | 5245 | __start_cc_report 14:34:04 INFO - PROCESS | 5245 | _x_x_mozilla_cycle_collect,313 14:34:04 INFO - PROCESS | 5245 | __end_cc_report 14:34:04 INFO - PROCESS | 5245 | __startTimestamp1452551644338__endTimestamp 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | ------- Summary: start ------- 14:34:04 INFO - PROCESS | 5245 | Number of tests: 6 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#0] dojo.html Cycles:165 Average:4608.77 Median:4728.00 stddev:463.53 (9.8%) stddev-sans-first:437.83 14:34:04 INFO - PROCESS | 5245 | Values: 2617.5 2676.1 2708.9 2717.9 2734.3 4524.3 4604.1 4624.3 4643.5 4650.0 4553.2 4569.3 4602.0 4632.7 4646.4 4308.5 4344.6 4398.3 4400.2 4436.4 4311.5 4338.5 4373.5 4433.6 4448.0 4181.5 4211.1 4312.9 4360.7 4392.7 4330.9 4348.2 4350.0 4351.8 4398.9 4305.4 4323.9 4326.3 4334.0 4355.9 4409.6 4513.4 4523.3 4531.5 4611.4 4962.9 4993.3 5009.9 5010.9 5030.5 5016.8 5021.8 5022.1 5026.2 5053.1 4482.5 4585.3 4591.3 4680.2 4701.0 5068.9 5070.3 5085.8 5089.3 5135.0 4875.0 4876.3 4877.1 4886.3 4939.0 4838.1 4919.2 4962.8 4969.2 4996.2 4937.1 4943.7 4947.5 4949.8 4987.0 4705.5 4874.2 4917.9 4923.8 4927.0 4161.0 4185.7 4212.8 4242.3 4281.9 3690.4 3691.2 3712.8 3714.5 3750.0 4175.4 4293.5 4340.8 4365.3 4392.1 4939.0 4958.3 5013.5 5090.8 5138.9 4308.4 4312.8 4331.4 4344.8 4367.6 4312.4 4477.9 4478.9 4487.2 4510.5 4719.6 4728.0 4786.4 4811.3 4840.2 4958.6 4990.9 4992.7 5000.3 5032.0 4591.4 4689.0 4753.4 4758.4 4808.4 4870.3 4914.5 4950.0 4951.0 5003.5 4954.6 4960.7 4999.1 5016.7 5038.4 4667.3 4703.8 4799.1 4840.3 4885.4 4856.6 4863.9 4864.3 4873.7 4907.9 4667.7 4742.2 4761.2 4768.5 4815.0 4743.1 4818.8 4875.6 4892.5 4949.8 4786.8 4794.8 4821.5 4828.1 4856.7 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#1] ext.html Cycles:180 Average:41534.52 Median:3466.01 stddev:72269.52 (2085.1%) stddev-sans-first:72406.56 14:34:04 INFO - PROCESS | 5245 | Values: 495.7 498.9 521.9 538.5 539.4 31824.2 32733.0 32745.8 32861.3 32873.2 35939.3 36213.0 36234.8 36237.3 36350.8 7737.2 7852.1 7908.4 7909.6 7919.3 7638.6 7721.7 7785.3 7960.7 7973.5 7932.3 7961.2 7961.6 8011.7 8052.8 7923.5 7968.5 8010.4 8012.0 8024.6 7809.3 7888.2 7925.4 7930.1 7958.3 36676.3 36851.3 37067.8 37092.6 37128.4 2975.8 3086.7 3096.3 3331.7 3443.8 28035.3 28125.0 28137.0 28527.1 28794.3 3407.5 3413.6 3488.2 3498.5 3521.4 169991.2 171384.0 171627.0 172139.1 172198.0 48193.0 49612.3 52347.0 52524.5 56653.4 50830.2 51027.7 51233.5 51271.0 51398.5 13690.9 13807.2 13839.9 13867.8 13888.5 10031.1 10041.2 10043.4 10052.8 10053.2 18991.4 19061.4 19583.3 19850.4 19952.9 7785.4 7900.2 7991.6 8101.4 8139.2 830.4 856.7 864.2 871.3 1003.0 23196.7 23483.6 23894.6 24418.5 24641.4 761.2 924.9 940.4 1004.4 1129.5 12294.2 12492.8 12601.4 12604.6 12706.4 369749.0 370692.0 374073.0 375397.0 375656.0 43635.1 44691.8 44694.1 44696.3 44815.8 1224.4 1228.6 1239.7 1268.5 1272.0 24871.5 25666.9 25860.7 27886.6 28033.3 40555.8 40926.8 40996.4 41030.2 41318.0 235837.0 238472.0 238497.0 239498.0 240094.0 29539.6 42079.0 42554.8 42564.0 43293.8 40556.0 41600.4 41601.4 42243.6 42426.0 29451.0 30300.2 30439.7 30528.7 30677.7 30942.4 30955.8 31005.8 31333.2 33849.2 30350.7 30851.7 30995.4 31174.0 31313.0 26193.7 27324.6 28927.3 28942.5 31569.5 21658.8 22071.4 22309.6 22594.3 23411.2 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#2] jquery.html Cycles:180 Average:21625.26 Median:4929.70 stddev:68652.49 (1392.6%) stddev-sans-first:68826.47 14:34:04 INFO - PROCESS | 5245 | Values: 335.8 339.0 343.2 344.8 345.2 14302.4 14439.9 15050.7 15472.0 15684.1 10307.0 10394.0 10410.1 13248.9 14696.9 4477.2 4529.4 4702.6 4709.2 5002.0 4895.6 4904.0 4960.2 4965.0 4968.7 3446.8 3596.3 4917.1 4942.3 5110.5 5233.5 5237.3 5250.2 5270.1 5311.2 4904.0 5075.7 5085.1 5092.4 5112.0 11086.9 11282.5 14122.4 17918.0 17985.4 1751.9 1835.9 1871.5 1901.9 1959.9 8899.6 8943.4 9034.1 9047.2 11651.2 1718.4 1730.7 1733.3 1743.4 1796.3 30954.4 32379.4 32569.2 46522.8 49864.0 9376.2 9773.8 9779.9 9785.9 9870.2 12322.6 12362.4 12393.6 12401.0 12479.4 6891.2 6977.6 6982.0 6985.5 7044.1 6602.8 6622.3 6628.9 6640.5 6674.4 3880.1 3993.8 4105.5 4174.0 4253.2 1724.2 1764.6 1774.9 1784.6 1807.6 383.9 392.1 398.3 434.1 810.3 9261.9 9391.1 9486.4 9645.2 9669.8 400.0 403.9 406.7 416.8 422.9 5198.9 5305.9 5414.1 5433.3 5447.8 412376.0 414801.0 415932.0 420019.0 437243.0 59794.0 60285.0 60871.7 60945.4 61089.7 448.3 459.7 459.8 461.1 461.9 9077.1 9104.9 9134.0 9232.5 9306.1 26414.3 26704.3 26895.3 30152.2 31503.4 34950.5 35196.0 35220.5 36125.5 36515.3 2527.7 4779.1 5954.0 6232.1 6353.0 7063.6 8191.5 9365.3 9446.4 9484.2 5983.3 6035.7 6081.3 6122.8 6420.7 5981.6 6002.9 6256.2 6439.5 6470.0 6197.6 6292.9 6354.6 6414.9 6471.9 8655.3 8868.6 8880.0 9021.5 9043.1 6162.5 8229.3 8304.2 8419.0 8564.7 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#3] mootools.html Cycles:180 Average:5010.38 Median:6039.37 stddev:2574.28 (42.6%) stddev-sans-first:2567.00 14:34:04 INFO - PROCESS | 5245 | Values: 1375.7 1385.8 1521.0 1731.2 1749.6 6222.7 6331.0 7086.0 7213.1 7258.3 6879.5 7005.7 7077.4 7112.4 7115.2 2066.2 2086.0 2090.1 2092.7 2095.2 2100.9 2117.1 2120.8 2194.0 2201.3 2102.4 2114.3 2124.2 2128.2 2132.6 2106.6 2121.9 2122.6 2122.8 2125.8 2096.7 2139.9 2143.1 2148.7 2149.9 7290.9 7316.7 7351.6 7356.1 7368.8 4329.7 4455.3 4455.4 4461.0 4461.0 2771.6 2774.5 2849.1 2852.8 2858.0 850.8 871.9 882.1 910.1 910.9 10007.6 10011.0 10011.8 10069.2 10083.4 4035.5 4036.8 4057.6 4090.3 4166.5 8638.0 8642.2 8664.0 8667.3 8701.5 4434.6 4468.3 4472.3 4480.9 4488.3 3403.4 3499.3 3888.8 4010.3 4015.8 3506.5 3515.0 3556.9 3585.3 3593.7 1144.6 1148.8 1150.2 1150.3 1150.6 898.5 953.6 1165.4 1175.8 1200.7 6793.8 6798.4 6816.9 6835.4 6839.7 1049.7 1062.3 1062.4 1063.7 1082.0 5404.6 5421.8 5443.3 5449.9 5462.6 8224.8 8669.7 8840.0 8859.6 8900.5 8700.4 8723.2 8729.0 8743.2 8805.1 6545.4 6623.8 6669.6 6705.8 6740.3 6417.0 6424.5 6427.4 6473.7 6499.4 7367.4 7399.7 7515.2 7618.5 7669.2 7588.0 7674.2 7699.1 7788.9 7836.4 5368.2 5471.5 5746.3 5995.7 6114.8 6490.5 6527.8 6538.5 6542.1 6546.7 6098.5 6137.6 6172.1 6196.9 6284.5 6079.3 6119.6 6124.4 6192.5 6215.2 6205.3 6377.4 6399.1 6407.0 6410.0 6033.1 6057.5 6067.8 6068.3 6069.8 5879.3 5932.1 6009.4 6045.7 6050.7 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#4] prototype.html Cycles:180 Average:4917.79 Median:5595.33 stddev:1468.36 (26.2%) stddev-sans-first:1431.10 14:34:04 INFO - PROCESS | 5245 | Values: 305.7 313.8 323.8 330.3 333.7 5518.4 5597.6 5634.4 5720.8 5753.3 5593.1 5617.4 5657.0 5657.2 5658.2 4187.0 4308.8 4325.1 4363.1 4372.0 4314.0 4317.7 4323.8 4326.0 4328.9 4270.0 4272.5 4279.5 4281.0 4281.8 4250.1 4276.9 4277.0 4286.2 4289.3 3677.3 3729.8 3732.5 3739.6 3775.6 5269.5 5380.1 5418.6 5437.9 5438.5 4973.8 4980.4 4981.3 4981.9 4991.5 5928.6 5951.5 5958.9 5964.8 5964.9 3914.6 4061.4 4066.8 4072.7 4080.8 6101.2 6135.6 6150.9 6180.0 6184.8 4148.0 4152.2 4163.3 4164.6 4167.4 4206.5 4233.3 4240.6 4241.0 4245.6 4662.3 4784.3 4889.0 4901.4 4918.7 5860.7 5922.0 5925.1 5926.2 5928.9 1497.2 1518.5 1523.2 1528.1 1532.2 976.7 1015.5 1015.7 1017.5 1021.2 5182.8 5184.0 5189.2 5202.1 5203.6 6158.7 6192.4 6203.8 6222.1 6227.5 5169.7 5173.0 5185.3 5213.7 5228.0 3268.8 3320.3 3358.9 3376.2 3397.6 5837.7 5897.1 5900.8 5901.4 5911.1 6340.5 6376.4 6417.1 6438.7 6451.3 5746.9 5883.6 5895.4 5899.7 5912.1 6218.7 6252.2 6262.7 6264.2 6270.7 6073.1 6081.0 6084.1 6091.6 6092.1 5776.9 5867.0 5875.6 5891.7 5906.5 4198.0 4239.3 4240.7 4242.7 4247.9 5933.8 6049.4 6249.4 6273.0 6274.4 5868.8 5960.3 5987.5 5992.7 5995.9 5879.0 5987.6 5988.2 5994.5 5996.5 5718.4 5845.4 5858.8 5860.6 5871.7 5997.9 6030.2 6039.8 6041.2 6048.7 5788.0 5873.4 5882.7 5885.3 5886.4 14:34:04 INFO - PROCESS | 5245 | 14:34:04 INFO - PROCESS | 5245 | [#5] yui.html Cycles:180 Average:11339.31 Median:483.37 stddev:12426.06 (2570.7%) stddev-sans-first:12435.47 14:34:04 INFO - PROCESS | 5245 | Values: 748.8 783.7 796.3 803.1 806.5 10298.3 10455.5 10484.4 10486.9 10513.6 10679.0 10730.6 10745.2 11449.7 11459.8 782.1 789.8 795.4 795.9 806.7 800.0 803.9 806.3 807.6 809.0 832.6 842.5 844.6 844.7 845.8 824.7 828.2 831.9 832.3 834.1 622.3 623.7 624.2 628.0 629.0 11250.0 11313.4 11316.5 11331.7 11340.0 11236.5 11310.4 11444.1 11640.5 11887.6 8744.9 8852.3 8884.7 8894.3 8931.4 3192.4 3230.4 3231.3 3236.6 3240.3 37652.4 38120.8 38249.6 38426.8 38478.0 9102.9 9127.8 9191.7 9348.1 9462.5 15873.3 15938.4 15942.8 15947.5 15955.7 6072.2 6308.7 6311.4 6400.8 6460.6 3575.8 3606.4 3607.7 3613.7 3615.7 2637.0 2689.7 2700.9 2706.9 2709.4 475.6 479.6 487.2 489.4 489.4 463.8 535.6 550.3 585.3 608.4 6718.5 6978.0 7021.9 7039.5 7079.1 492.7 494.2 524.9 568.3 605.2 3031.9 3121.7 3122.2 3164.5 3199.8 43811.8 43921.6 44264.3 44358.3 44630.6 39732.6 39742.4 39814.2 39895.8 40710.2 36127.6 36718.4 36721.6 37225.4 37532.2 7425.6 7532.9 7591.5 7640.5 7682.7 27870.4 28082.0 28127.0 28950.9 29292.4 34044.8 34665.1 35079.8 35088.3 35653.6 9425.6 9634.0 9819.1 9960.1 10346.8 10693.0 10768.2 10797.5 10958.9 11470.7 9143.1 9475.8 9521.1 9525.1 9548.3 9967.8 9992.4 10349.7 10543.9 10904.3 9188.5 10192.1 10464.3 10466.6 10498.2 8292.2 8733.9 8887.6 8929.0 9122.6 7700.7 7880.1 7889.8 7990.8 8660.3 14:34:04 INFO - PROCESS | 5245 | -------- Summary: end -------- 14:34:04 INFO - PROCESS | 5245 | 14:34:05 INFO - TEST-INFO | 5245: exit 0 14:34:05 INFO - TEST-OK | dromaeo_css | took 1115121ms 14:34:05 INFO - TEST-START | kraken 14:34:05 INFO - operating with platform_type : linux_ 14:34:05 INFO - Initialising browser for kraken test... 14:34:05 INFO - TEST-INFO | started process 5481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MeKfC/profile http://localhost:38370/getInfo.html) 14:34:08 INFO - PROCESS | 5481 | 14:34:08 INFO - PROCESS | 5481 | (process:5551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:34:09 INFO - PROCESS | 5481 | __metrics Screen width/height:1600/1200 14:34:09 INFO - PROCESS | 5481 | colorDepth:24 14:34:09 INFO - PROCESS | 5481 | Browser inner width/height: 1024/697 14:34:09 INFO - PROCESS | 5481 | __metrics 14:34:09 INFO - PROCESS | 5481 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:34:10 INFO - TEST-INFO | 5481: exit 0 14:34:10 INFO - Browser initialized. 14:34:10 INFO - Running cycle 1/1 for kraken test... 14:34:10 INFO - TEST-INFO | started process 5600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MeKfC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:12 INFO - PROCESS | 5600 | 14:34:12 INFO - PROCESS | 5600 | (process:5661): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:34:22 INFO - PROCESS | 5600 | RSS: Main: 150585344 14:34:22 INFO - PROCESS | 5600 | 14:34:25 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38370/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:26 INFO - PROCESS | 5600 | RSS: Main: 150212608 14:34:26 INFO - PROCESS | 5600 | 14:34:28 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38370/tests/kraken/driver.html?testName=audio-dft) 14:34:29 INFO - PROCESS | 5600 | RSS: Main: 150577152 14:34:29 INFO - PROCESS | 5600 | 14:34:32 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38370/tests/kraken/driver.html?testName=audio-fft) 14:34:32 INFO - PROCESS | 5600 | RSS: Main: 146714624 14:34:32 INFO - PROCESS | 5600 | 14:34:35 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38370/tests/kraken/driver.html?testName=audio-oscillator) 14:34:35 INFO - PROCESS | 5600 | RSS: Main: 146001920 14:34:35 INFO - PROCESS | 5600 | 14:34:37 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:38 INFO - PROCESS | 5600 | RSS: Main: 146907136 14:34:38 INFO - PROCESS | 5600 | 14:34:41 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38370/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:42 INFO - PROCESS | 5600 | RSS: Main: 148320256 14:34:42 INFO - PROCESS | 5600 | 14:34:45 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38370/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:46 INFO - PROCESS | 5600 | RSS: Main: 145809408 14:34:46 INFO - PROCESS | 5600 | 14:34:49 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38370/tests/kraken/driver.html?testName=json-parse-financial) 14:34:49 INFO - PROCESS | 5600 | RSS: Main: 146321408 14:34:49 INFO - PROCESS | 5600 | 14:34:51 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:34:52 INFO - PROCESS | 5600 | RSS: Main: 147775488 14:34:52 INFO - PROCESS | 5600 | 14:34:54 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:34:54 INFO - PROCESS | 5600 | RSS: Main: 148451328 14:34:54 INFO - PROCESS | 5600 | 14:34:56 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:34:57 INFO - PROCESS | 5600 | RSS: Main: 148180992 14:34:57 INFO - PROCESS | 5600 | 14:35:00 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:00 INFO - PROCESS | 5600 | RSS: Main: 147718144 14:35:00 INFO - PROCESS | 5600 | 14:35:03 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:03 INFO - PROCESS | 5600 | RSS: Main: 147898368 14:35:03 INFO - PROCESS | 5600 | 14:35:05 INFO - PROCESS | 5600 | Cycle 1(1): loaded http://localhost:38370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38370/tests/kraken/driver.html?testName=ai-astar) 14:35:05 INFO - PROCESS | 5600 | RSS: Main: 149450752 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | __start_tp_report 14:35:06 INFO - PROCESS | 5600 | _x_x_mozilla_page_load 14:35:06 INFO - PROCESS | 5600 | _x_x_mozilla_page_load_details 14:35:06 INFO - PROCESS | 5600 | |i|pagename|runs| 14:35:06 INFO - PROCESS | 5600 | |0;ai-astar;112;108;115;115;115;125;113;113;113;112 14:35:06 INFO - PROCESS | 5600 | |1;audio-beat-detection;160;134;162;164;138;156;161;134;172;135 14:35:06 INFO - PROCESS | 5600 | |2;audio-dft;162;163;164;162;163;165;170;164;165;162 14:35:06 INFO - PROCESS | 5600 | |3;audio-fft;80;74;73;73;143;73;74;72;75;99 14:35:06 INFO - PROCESS | 5600 | |4;audio-oscillator;98;97;131;96;99;97;143;98;99;150 14:35:06 INFO - PROCESS | 5600 | |5;imaging-gaussian-blur;109;109;109;110;110;110;111;110;123;110 14:35:06 INFO - PROCESS | 5600 | |6;imaging-darkroom;149;148;148;149;148;148;147;150;147;148 14:35:06 INFO - PROCESS | 5600 | |7;imaging-desaturate;96;98;97;96;96;96;96;101;96;96 14:35:06 INFO - PROCESS | 5600 | |8;json-parse-financial;71;71;72;71;70;73;70;70;73;69 14:35:06 INFO - PROCESS | 5600 | |9;json-stringify-tinderbox;67;67;67;67;67;68;66;69;68;68 14:35:06 INFO - PROCESS | 5600 | |10;stanford-crypto-aes;83;84;87;86;85;84;87;86;85;86 14:35:06 INFO - PROCESS | 5600 | |11;stanford-crypto-ccm;126;128;133;130;124;126;136;135;135;140 14:35:06 INFO - PROCESS | 5600 | |12;stanford-crypto-pbkdf2;139;142;160;150;150;153;150;150;151;137 14:35:06 INFO - PROCESS | 5600 | |13;stanford-crypto-sha256-iterative;76;71;74;75;75;74;71;71;70;73 14:35:06 INFO - PROCESS | 5600 | __end_tp_report 14:35:06 INFO - PROCESS | 5600 | __start_cc_report 14:35:06 INFO - PROCESS | 5600 | _x_x_mozilla_cycle_collect,823 14:35:06 INFO - PROCESS | 5600 | __end_cc_report 14:35:06 INFO - PROCESS | 5600 | __startTimestamp1452551706000__endTimestamp 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | ------- Summary: start ------- 14:35:06 INFO - PROCESS | 5600 | Number of tests: 14 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.36 (3.8%) stddev-sans-first:4.56 14:35:06 INFO - PROCESS | 5600 | Values: 112.0 108.0 115.0 115.0 115.0 125.0 113.0 113.0 113.0 112.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:160.50 stddev:14.67 (9.1%) stddev-sans-first:15.24 14:35:06 INFO - PROCESS | 5600 | Values: 160.0 134.0 162.0 164.0 138.0 156.0 161.0 134.0 172.0 135.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.40 (1.5%) stddev-sans-first:2.44 14:35:06 INFO - PROCESS | 5600 | Values: 162.0 163.0 164.0 162.0 163.0 165.0 170.0 164.0 165.0 162.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:22.38 (30.2%) stddev-sans-first:23.70 14:35:06 INFO - PROCESS | 5600 | Values: 80.0 74.0 73.0 73.0 143.0 73.0 74.0 72.0 75.0 99.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:97.50 stddev:21.57 (22.1%) stddev-sans-first:22.38 14:35:06 INFO - PROCESS | 5600 | Values: 98.0 97.0 131.0 96.0 99.0 97.0 143.0 98.0 99.0 150.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:110.00 stddev:4.23 (3.8%) stddev-sans-first:4.42 14:35:06 INFO - PROCESS | 5600 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 111.0 110.0 123.0 110.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 14:35:06 INFO - PROCESS | 5600 | Values: 149.0 148.0 148.0 149.0 148.0 148.0 147.0 150.0 147.0 148.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 14:35:06 INFO - PROCESS | 5600 | Values: 96.0 98.0 97.0 96.0 96.0 96.0 96.0 101.0 96.0 96.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:1.33 (1.9%) stddev-sans-first:1.41 14:35:06 INFO - PROCESS | 5600 | Values: 71.0 71.0 72.0 71.0 70.0 73.0 70.0 70.0 73.0 69.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 14:35:06 INFO - PROCESS | 5600 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 66.0 69.0 68.0 68.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:1.34 (1.6%) stddev-sans-first:1.13 14:35:06 INFO - PROCESS | 5600 | Values: 83.0 84.0 87.0 86.0 85.0 84.0 87.0 86.0 85.0 86.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:134.00 stddev:5.27 (3.9%) stddev-sans-first:5.23 14:35:06 INFO - PROCESS | 5600 | Values: 126.0 128.0 133.0 130.0 124.0 126.0 136.0 135.0 135.0 140.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:150.00 stddev:6.92 (4.6%) stddev-sans-first:6.50 14:35:06 INFO - PROCESS | 5600 | Values: 139.0 142.0 160.0 150.0 150.0 153.0 150.0 150.0 151.0 137.0 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - PROCESS | 5600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:74.00 stddev:2.11 (2.8%) stddev-sans-first:1.94 14:35:06 INFO - PROCESS | 5600 | Values: 76.0 71.0 74.0 75.0 75.0 74.0 71.0 71.0 70.0 73.0 14:35:06 INFO - PROCESS | 5600 | -------- Summary: end -------- 14:35:06 INFO - PROCESS | 5600 | 14:35:06 INFO - TEST-INFO | 5600: exit 0 14:35:06 INFO - TEST-OK | kraken | took 61939ms 14:35:06 INFO - TEST-START | v8_7 14:35:06 INFO - operating with platform_type : linux_ 14:35:06 INFO - Initialising browser for v8_7 test... 14:35:07 INFO - TEST-INFO | started process 5889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34oDxI/profile http://localhost:38370/getInfo.html) 14:35:10 INFO - PROCESS | 5889 | 14:35:10 INFO - PROCESS | 5889 | (process:5961): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:35:11 INFO - PROCESS | 5889 | __metrics Screen width/height:1600/1200 14:35:11 INFO - PROCESS | 5889 | colorDepth:24 14:35:11 INFO - PROCESS | 5889 | Browser inner width/height: 1024/697 14:35:11 INFO - PROCESS | 5889 | __metrics 14:35:11 INFO - PROCESS | 5889 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:35:12 INFO - TEST-INFO | 5889: exit 0 14:35:12 INFO - Browser initialized. 14:35:12 INFO - Running cycle 1/1 for v8_7 test... 14:35:12 INFO - TEST-INFO | started process 6010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34oDxI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:14 INFO - PROCESS | 6010 | 14:35:14 INFO - PROCESS | 6010 | (process:6066): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:35:24 INFO - PROCESS | 6010 | RSS: Main: 150224896 14:35:24 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | Cycle 1(1): loaded http://localhost:38370/tests/v8_7/run.html (next: http://localhost:38370/tests/v8_7/run.html) 14:35:47 INFO - PROCESS | 6010 | RSS: Main: 145829888 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | __start_tp_report 14:35:47 INFO - PROCESS | 6010 | _x_x_mozilla_page_load 14:35:47 INFO - PROCESS | 6010 | _x_x_mozilla_page_load_details 14:35:47 INFO - PROCESS | 6010 | |i|pagename|runs| 14:35:47 INFO - PROCESS | 6010 | |0;Richards;167.58840288252054 14:35:47 INFO - PROCESS | 6010 | |1;DeltaBlue;186.70649738610905 14:35:47 INFO - PROCESS | 6010 | |2;Encrypt;278.39643652561244 14:35:47 INFO - PROCESS | 6010 | |3;Decrypt;5175.257731958763 14:35:47 INFO - PROCESS | 6010 | |4;RayTrace;1079.913606911447 14:35:47 INFO - PROCESS | 6010 | |5;Earley;754.7169811320755 14:35:47 INFO - PROCESS | 6010 | |6;Boyer;12292.682926829268 14:35:47 INFO - PROCESS | 6010 | |7;RegExp;43957.44680851064 14:35:47 INFO - PROCESS | 6010 | |8;Splay;603.0120481927711 14:35:47 INFO - PROCESS | 6010 | |9;NavierStokes;4845.410628019324 14:35:47 INFO - PROCESS | 6010 | __end_tp_report 14:35:47 INFO - PROCESS | 6010 | __startTimestamp1452551747699__endTimestamp 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | ------- Summary: start ------- 14:35:47 INFO - PROCESS | 6010 | Number of tests: 10 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#0] Richards Cycles:1 Average:167.59 Median:167.59 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 167.6 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 186.7 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 278.4 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 5175.3 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 1079.9 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#5] Earley Cycles:1 Average:754.72 Median:754.72 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 754.7 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 12292.7 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#7] RegExp Cycles:1 Average:43957.45 Median:43957.45 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 43957.4 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#8] Splay Cycles:1 Average:603.01 Median:603.01 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 603.0 14:35:47 INFO - PROCESS | 6010 | 14:35:47 INFO - PROCESS | 6010 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 14:35:47 INFO - PROCESS | 6010 | Values: 4845.4 14:35:47 INFO - PROCESS | 6010 | -------- Summary: end -------- 14:35:47 INFO - PROCESS | 6010 | 14:35:48 INFO - TEST-INFO | 6010: exit 0 14:35:48 INFO - TEST-OK | v8_7 | took 41665ms 14:35:48 INFO - SUITE-END | took 1218s 14:35:49 INFO - Completed test suite (00:20:19) 14:35:49 INFO - Working with test: dromaeo_css 14:35:49 INFO - Generating results file: dromaeo_css 14:35:49 INFO - Working with test: kraken 14:35:49 INFO - Generating results file: kraken 14:35:49 INFO - javascript benchmark 14:35:49 INFO - Working with test: v8_7 14:35:49 INFO - Generating results file: v8_7 14:35:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:35:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 14:35:49 INFO - process_Request line: dromaeo_css 6050.73 graph.html#tests=[[72,132,43]] 14:35:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:35:49 INFO - process_Request line: kraken 1556.40 graph.html#tests=[[232,132,43]] 14:35:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:35:49 INFO - process_Request line: v8_7 20130.38 graph.html#tests=[[230,132,43]] 14:35:49 INFO - RETURN: dromaeo_css: 6050.73 14:35:49 INFO - RETURN: kraken: 1556.40 14:35:49 INFO - RETURN: v8_7: 20130.38 14:35:49 INFO - javascript benchmark 14:35:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2617.489589530042, 2676.1168814291286, 2708.851013194275, 2717.932051698706, 2734.3437574982, 4524.298733696282, 4604.148232576971, 4624.306354046895, 4643.512431194727, 4649.976750116249, 4553.22595158823, 4569.268916973277, 4602.0, 4632.675712700112, 4646.395968524095, 4308.526062133163, 4344.63070638996, 4398.340248962665, 4400.185965596359, 4436.401085853417, 4311.5472875348105, 4338.501072376685, 4373.497047839492, 4433.600975912167, 4447.977760111195, 4181.477315335583, 4211.073563815956, 4312.913741725148, 4360.716553424049, 4392.704152275087, 4330.913381732347, 4348.173846969065, 4350.042990542107, 4351.782410879475, 4398.868033958986, 4305.397244385788, 4323.935140972888, 4326.329418940069, 4334.0, 4355.912881742379, 4409.559044095597, 4513.390692256537, 4523.2988886722615, 4531.478879928784, 4611.446626404853, 4962.87592810179, 4993.251012348177, 5009.924851127236, 5010.949890501085, 5030.496950304977, 5016.849494515171, 5021.824236151717, 5022.146235140035, 5026.220935754964, 5053.065182941167, 4482.462104547442, 4585.335126406719, 4591.265397536378, 4680.204365257914, 4700.976495117571, 5068.923966140511, 5070.264811602297, 5085.821996230115, 5089.262057001714, 5135.024345374367, 4874.95125048745, 4876.341693871282, 4877.146499362598, 4886.3403440535785, 4938.950610493921, 4838.080764654705, 4919.2129259318335, 4962.801487940442, 4969.155243608595, 4996.150654388763, 4937.1113199624415, 4943.728094954812, 4947.480514545993, 4949.802007919643, 4987.0, 4705.4588722296685, 4874.2201247800185, 4917.877053073702, 4923.77842997066, 4926.975365123151, 4161.04296011919, 4185.686073544496, 4212.831486740557, 4242.278812601865, 4281.871543853689, 3690.446433035066, 3691.169486865434, 3712.795796231233, 3714.4799728038097, 3750.0437388465766, 4175.436316097349, 4293.549177336397, 4340.804663790137, 4365.301551751704, 4392.05570802279, 4938.950610493921, 4958.305837182797, 5013.498650134958, 5090.821821236313, 5138.948610513847, 4308.418363520885, 4312.827486900552, 4331.415258940003, 4344.782760861945, 4367.6287515561535, 4312.417823593774, 4477.888052798706, 4478.910421791546, 4487.192305384997, 4510.548945105529, 4719.5752382285755, 4727.999999999931, 4786.425628924551, 4811.302361157683, 4840.2255639097575, 4958.6281028923695, 4990.925136123034, 4992.675476094042, 5000.324956130876, 5032.0, 4591.403117594691, 4689.0, 4753.429588449409, 4758.381410416624, 4808.3989501312335, 4870.269459581091, 4914.483979182278, 4950.0, 4950.975245123751, 5003.54968052877, 4954.628402869727, 4960.677555958851, 4999.10016197088, 5016.698998059982, 5038.445770965118, 4667.32323813052, 4703.788329525111, 4799.088173247072, 4840.322354870392, 4885.364902562644, 4856.611471082234, 4863.927041094457, 4864.343313652753, 4873.731944743073, 4907.9263811043575, 4667.719936803803, 4742.2175341069715, 4761.214399624023, 4768.451628062817, 4815.036992601564, 4743.075100355398, 4818.759062046814, 4875.585575226146, 4892.461829198856, 4949.826756063664, 4786.760661966958, 4794.808207671654, 4821.5178482151505, 4828.082664293773, 4856.73287969151], "unit": "score", "name": "dojo.html", "value": 4580.822351182192}, {"lowerIsBetter": false, "replicates": [495.65056635072256, 498.85782551972693, 521.9425863155054, 538.504575790273, 539.360857384, 31824.20439489014, 32733.0, 32745.836270818614, 32861.342773144526, 32873.17817054572, 35939.28121437576, 36213.0, 36234.8188259059, 36237.275254494896, 36350.8182459088, 7737.22627737226, 7852.05775306964, 7908.446408751361, 7909.644066017043, 7919.287264146225, 7638.618069096551, 7721.691132354699, 7785.260400261966, 7960.681572737083, 7973.521588704667, 7932.325752311061, 7961.164077771838, 7961.60191990401, 8011.67953281868, 8052.758417247463, 7923.524588524678, 7968.521888686697, 8010.439269251126, 8011.959940200261, 8024.598770061532, 7809.258120478602, 7888.211178882066, 7925.405594580429, 7930.1276859545405, 7958.283754462126, 36676.26647467062, 36851.262974740355, 37067.81466092679, 37092.629073709184, 37128.44307335392, 2975.7619390448713, 3086.722195002438, 3096.3033317503605, 3331.738246201693, 3443.8450269737923, 28035.29911752202, 28125.0, 28137.0, 28527.144185674464, 28794.280142996384, 3407.4548072308557, 3413.6004238262194, 3488.180277634754, 3498.510208570802, 3521.4013617685055, 169991.150044249, 171384.0, 171627.0, 172139.13930430394, 172198.0, 48193.0, 49612.25581616279, 52347.0, 52524.474755252726, 56653.43346566564, 50830.237546436096, 51027.74486127545, 51233.48766512287, 51271.0, 51398.486015140115, 13690.863091369158, 13807.240601767, 13839.930800345934, 13867.791983120262, 13888.513902013583, 10031.147352474976, 10041.19670426364, 10043.447610381352, 10052.849207261897, 10053.246006549392, 18991.43025709231, 19061.42815715503, 19583.314583989493, 19850.404487865388, 19952.900235498728, 7785.403992181702, 7900.170482099412, 7991.600419978978, 8101.392395570356, 8139.186081391814, 830.4477522447626, 856.7215654912054, 864.1833467373272, 871.2855458524076, 1002.979940401188, 23196.65205021926, 23483.647745283834, 23894.64158037631, 24418.511629767305, 24641.383965401008, 761.2463660975704, 924.9306302027375, 940.3840484482674, 1004.4475538453821, 1129.4973736687095, 12294.20087694297, 12492.81260781089, 12601.432935517923, 12604.621861344174, 12706.428210730539, 369749.0, 370692.0, 374073.0, 375397.0, 375656.0, 43635.127297454506, 44691.77654111774, 44694.10611787746, 44696.3295550567, 44815.77592112084, 1224.4245204753752, 1228.6498347970785, 1239.6714870559308, 1268.4545645372577, 1271.9872801272054, 24871.50256994886, 25666.871665641553, 25860.741392585835, 27886.636280583887, 28033.29916752016, 40555.79722101371, 40926.795366022976, 40996.385054224804, 41030.1793964125, 41318.0, 235837.0, 238472.0, 238497.0, 239498.0, 240094.0, 29539.55690664685, 42079.0, 42554.78722606491, 42564.0, 43293.783531083405, 40556.0, 41600.37599435951, 41601.37597936094, 42243.57756422397, 42426.0, 29451.0, 30300.24249393783, 30439.71702122394, 30528.694713052584, 30677.693223067483, 30942.381152376376, 30955.845220773754, 31005.844970775, 31333.216669583442, 33849.15377115493, 30350.696493034786, 30851.69148308578, 30995.380092397576, 31174.0, 31313.0, 26193.73806261913, 27324.590131147652, 28927.276818079717, 28942.506466399216, 31569.52645710362, 21658.783412166307, 22071.448213794785, 22309.553808924054, 22594.322170334915, 23411.180608678613], "unit": "score", "name": "ext.html", "value": 16646.20992053655}, {"lowerIsBetter": false, "replicates": [335.7951649493808, 338.9762716609837, 343.1575482191219, 344.7552237911083, 345.2043040790976, 14302.427902883885, 14439.917006224536, 15050.698986020274, 15472.0, 15684.058956462606, 10307.0, 10394.0, 10410.11514021309, 13248.867511324885, 14696.853031469682, 4477.238869392203, 4529.365888775574, 4702.553257440538, 4709.246520556711, 5002.0246052019875, 4895.6083513318845, 4904.0437114762635, 4960.181570040939, 4964.975175124119, 4968.70187788732, 3446.8104254266004, 3596.2627661329498, 4917.065757506062, 4942.332785074005, 5110.540051395374, 5233.476652334774, 5237.319148510707, 5250.212468129773, 5270.051390749663, 5311.203319502067, 4903.950960490385, 5075.720835354054, 5085.059264036128, 5092.388913330387, 5112.0, 11086.944565277203, 11282.492287847066, 14122.364493597814, 17918.0, 17985.370512032147, 1751.8773685841995, 1835.9265629374809, 1871.4759867237196, 1901.9239230430767, 1959.941631518978, 8899.644014239422, 8943.373963822534, 9034.051424600453, 9047.230985366252, 11651.184417090806, 1718.4415065103892, 1730.6971280025946, 1733.298014304209, 1743.4420985284714, 1796.3084212578121, 30954.38091238185, 32379.352412951845, 32569.185770355693, 46522.76738616285, 49864.0, 9376.203022743142, 9773.849753054317, 9779.902200978042, 9785.902140978642, 9870.161036311994, 12322.568710095104, 12362.44369003397, 12393.566225182076, 12401.0, 12479.438425270884, 6891.173059232924, 6977.581345119309, 6982.0, 6985.511014229057, 7044.084269044992, 6602.801915942433, 6622.2715501294815, 6628.8674226515195, 6640.501962352843, 6674.399304062657, 3880.0881792778673, 3993.780342081155, 4105.548389677133, 4174.0, 4253.1706317267835, 1724.1982478147722, 1764.5765016395972, 1774.9201285942163, 1784.6252287019872, 1807.5752198233404, 383.8886722850342, 392.13142888501534, 398.2870661515912, 434.11440661051734, 810.2828996338283, 9261.861072083924, 9391.060893910555, 9486.430814151174, 9645.180159686364, 9669.806603867883, 399.9760014399145, 403.929312370334, 406.6929468251451, 416.78535554189614, 422.8815931539174, 5198.870028249248, 5305.8938821223355, 5414.106672399089, 5433.266509021231, 5447.809326673548, 412376.0, 414801.0, 415932.0, 420019.0, 437243.0, 59794.0, 60285.0, 60871.69564152151, 60945.39054609397, 61089.694551526954, 448.2872233149308, 459.6552585560829, 459.81377542095504, 461.057138152479, 461.9053094115698, 9077.09229077087, 9104.90895091067, 9134.0, 9232.538373081185, 9306.06939306064, 26414.339641509116, 26704.332391690365, 26895.327616809736, 30152.24619384533, 31503.36993260168, 34950.475742864386, 35196.0, 35220.47169292411, 36125.458118127724, 36515.26969460649, 2527.699455939025, 4779.115863565252, 5954.0, 6232.127502149793, 6353.0, 7063.611501367474, 8191.508509489449, 9365.344425890122, 9446.433214006907, 9484.193843523377, 5983.252093488314, 6035.728392222272, 6081.300650425258, 6122.785702500391, 6420.711068001858, 5981.581289309706, 6002.879942401215, 6256.186695729526, 6439.484841212786, 6469.967650161907, 6197.597156184834, 6292.874142517033, 6354.618722876642, 6414.903776443264, 6471.935280647133, 8655.30757539408, 8868.581027035902, 8879.955600221958, 9021.548922553977, 9043.095690430904, 6162.537809664203, 8229.25936665703, 8304.169583041648, 8419.0, 8564.74305770828], "unit": "score", "name": "jquery.html", "value": 6383.864224636975}, {"lowerIsBetter": false, "replicates": [1375.7248550289942, 1385.826771653543, 1520.97718534222, 1731.1776905969673, 1749.6325771587965, 6222.657753823538, 6330.96834515828, 7085.964570177149, 7213.134423869136, 7258.310460506256, 6879.4840386971055, 7005.684744186511, 7077.433805295564, 7112.431005519559, 7115.18175409828, 2066.173530587762, 2086.040421406155, 2090.090810497431, 2092.7174831397797, 2095.21429463951, 2100.905459254337, 2117.1319758898853, 2120.7561130469962, 2194.034624765098, 2201.273579718689, 2102.358780571925, 2114.302280247515, 2124.150339864051, 2128.159377046066, 2132.605467988427, 2106.6313395155785, 2121.8832964186963, 2122.564874200785, 2122.8195603373733, 2125.7767934366825, 2096.727425434699, 2139.8609090409072, 2143.057054895841, 2148.656215005607, 2149.8602590831547, 7290.942813292043, 7316.707331706725, 7351.595662238575, 7356.117265928123, 7368.815779605499, 4329.653627709776, 4455.309427038814, 4455.398521199629, 4460.977695111536, 4461.04087621163, 2771.6003418273845, 2774.4589804988036, 2849.088291746642, 2852.786041046909, 2857.957130643042, 850.7958090058403, 871.895372555291, 882.1266945723752, 910.0671811393308, 910.8952470465915, 10007.64973225941, 10011.048950349705, 10011.849822252672, 10069.244806639457, 10083.44541050242, 4035.53591337, 4036.8183431745642, 4057.594240575919, 4090.3455447128317, 4166.500019997619, 8637.956810215908, 8642.178992995656, 8664.003639581402, 8667.306615470747, 8701.521416322163, 4434.623057040123, 4468.262736648481, 4472.284434490531, 4480.865574032784, 4488.349189367524, 3403.3873902697255, 3499.3001399720156, 3888.8055597220027, 4010.318245898146, 4015.7590544566833, 3506.474028895635, 3515.0, 3556.928861422809, 3585.3367127081574, 3593.6765691087926, 1144.6108323170163, 1148.7645032768262, 1150.2350936627217, 1150.2983180260035, 1150.5627861412609, 898.4743924804063, 953.5565961827645, 1165.4289398194824, 1175.7648470305974, 1200.7298357869408, 6793.762218322335, 6798.354156355138, 6816.897746533806, 6835.350641689031, 6839.692213850389, 1049.6536143072767, 1062.2882668612049, 1062.373199812099, 1063.723431907694, 1081.9621313254, 5404.648697834628, 5421.810236641699, 5443.265159203457, 5449.918251226235, 5462.644928079662, 8224.794380140425, 8669.739907802776, 8839.955800220958, 8859.601317940707, 8900.465972041698, 8700.434471759316, 8723.171298726611, 8728.996165441056, 8743.213110820057, 8805.075467075992, 6545.410913017851, 6623.768168114093, 6669.599824010575, 6705.798826035227, 6740.258571557125, 6417.0, 6424.51816113784, 6427.357264273535, 6473.741050358121, 6499.415052645285, 7367.373773229336, 7399.704011839466, 7515.210902855121, 7618.504797188165, 7669.233076692286, 7587.962060189664, 7674.194209608134, 7699.076110866732, 7788.922110779046, 7836.412269079728, 5368.248445217595, 5471.480209380103, 5746.2529871116485, 5995.700214989146, 6114.816555503342, 6490.513211509061, 6527.836804079936, 6538.542302038812, 6542.051402546699, 6546.672666366758, 6098.542609304409, 6137.631742095488, 6172.105044768573, 6196.938030619816, 6284.528660350584, 6079.331273559993, 6119.571629985859, 6124.418180272867, 6192.473639740492, 6215.192025036717, 6205.348438413902, 6377.394147555975, 6399.104125422352, 6407.0, 6410.038494225903, 6033.064874944391, 6057.545684073624, 6067.757289708539, 6068.332483426908, 6069.787557435468, 5879.2944846616965, 5932.110183472513, 6009.429104235091, 6045.667488288186, 6050.7277172526465], "unit": "score", "name": "mootools.html", "value": 4143.308239319351}, {"lowerIsBetter": false, "replicates": [305.6866711620589, 313.81955375659004, 323.787918913112, 330.27998962262257, 333.66800033966206, 5518.420565840589, 5597.552195824334, 5634.3802181759975, 5720.8283751487415, 5753.338366087901, 5593.105103183481, 5617.4382561743805, 5657.010023245936, 5657.23627310314, 5658.207850900877, 4187.0, 4308.763018034007, 4325.091730736549, 4363.149185908741, 4372.0, 4313.978430107845, 4317.676174286926, 4323.848665296715, 4325.98339390243, 4328.870133895988, 4270.017895883949, 4272.46594175728, 4279.48646162461, 4280.978595107035, 4281.785910704468, 4250.06498570314, 4276.850310239158, 4277.016286254147, 4286.207051695446, 4289.292266775994, 3677.3380791457525, 3729.81350932455, 3732.4883422214048, 3739.551253849528, 3775.6413140751583, 5269.473052694738, 5380.085385484438, 5418.566514678816, 5437.918431223535, 5438.510534051954, 4973.7513124344, 4980.402351717781, 4981.277714731344, 4981.850544483671, 4991.525805048551, 5928.64428134309, 5951.49412299955, 5958.880822383571, 5964.761409543613, 5964.940350596482, 3914.6476817086314, 4061.431399604058, 4066.755994640331, 4072.7352722073265, 4080.795960202008, 6101.206843110412, 6135.601185922901, 6150.8769824603705, 6180.042093475518, 6184.783532576384, 4147.958520414818, 4152.169566086734, 4163.3130533462245, 4164.6251837334785, 4167.374893765959, 4206.537280899099, 4233.322668373045, 4240.618344349024, 4241.045764702917, 4245.577731459995, 4662.347271382009, 4784.330193772875, 4889.046635906036, 4901.362822833009, 4918.729469879119, 5860.677662728505, 5921.970390148108, 5925.05199168131, 5926.1999630049395, 5928.881422371528, 1497.2438918346384, 1518.5216656753307, 1523.1850959736487, 1528.1289664890905, 1532.2415404374683, 976.72651657536, 1015.4973288222377, 1015.720676813882, 1017.5370206555999, 1021.1932573267185, 5182.792688292501, 5183.974080129575, 5189.221616757516, 5202.063628546898, 5203.60972927032, 6158.661273629904, 6192.442680158807, 6203.751849925952, 6222.066689996536, 6227.470664993526, 5169.689818610896, 5173.042987047333, 5185.274061631375, 5213.739313034409, 5228.006678731029, 3268.836558172082, 3320.335932813447, 3358.9160270992934, 3376.2234686022352, 3397.5583174187195, 5837.708114594253, 5897.115432685132, 5900.76396944126, 5901.3508514063415, 5911.142884281755, 6340.461060809883, 6376.362363763679, 6417.133686952295, 6438.7102580384, 6451.322611125858, 5746.856328591903, 5883.588148829541, 5895.351511333835, 5899.7050147492455, 5912.142739302777, 6218.720157593009, 6252.1559589456665, 6262.718177681924, 6264.248290205204, 6270.717817698123, 6073.089036644538, 6081.027035674271, 6084.11780291864, 6091.573589848846, 6092.147099405998, 5776.942230577641, 5867.0, 5875.6474611523445, 5891.705414729161, 5906.468417842415, 4197.97901010493, 4239.279322515118, 4240.703150779415, 4242.703010789215, 4247.915041699087, 5933.762649493972, 6049.3950604939155, 6249.375062493714, 6272.96496078142, 6274.435300822948, 5868.823935281948, 5960.344362120077, 5987.461128498456, 5992.67040312787, 5995.940040599538, 5878.970605146947, 5987.5808693391045, 5988.191594134911, 5994.520438364833, 5996.4902983245165, 5718.370979192368, 5845.444682755132, 5858.8242352729485, 5860.648361098348, 5871.6770577618645, 5997.940020599913, 6030.246219222598, 6039.849003774941, 6041.18444010053, 6048.6975651218145, 5787.971060144672, 5873.3832947539895, 5882.735276912464, 5885.264341957255, 5886.440788125121], "unit": "score", "name": "prototype.html", "value": 4445.289431059351}, {"lowerIsBetter": false, "replicates": [748.8165399477127, 783.7335305995961, 796.3231253434582, 803.1326167738843, 806.5402720449342, 10298.33060851045, 10455.529501172447, 10484.423356715377, 10486.947565262173, 10513.579456821728, 10679.0, 10730.624428145016, 10745.247832651718, 11449.713757156054, 11459.770804583903, 782.0810547606568, 789.8380831929469, 795.4034474144391, 795.932345750612, 806.6813608624619, 800.0479429478902, 803.8593246181924, 806.3025482957258, 807.5840941914919, 809.0, 832.6253186066264, 842.4524059361434, 844.5650489997656, 844.6536919862857, 845.7843249971279, 824.6701319472229, 828.2462958707578, 831.9126491718373, 832.3133414932644, 834.1116710703143, 622.2564035977009, 623.7006237006217, 624.1511544299749, 627.9843003924892, 628.9654069026202, 11250.0, 11313.377764222965, 11316.547338106466, 11331.716707082389, 11340.03609693177, 11236.494357753922, 11310.434478276053, 11444.084473242121, 11640.534378624845, 11887.643370698894, 8744.882069957082, 8852.291816654651, 8884.73345799627, 8894.332925030649, 8931.419457735226, 3192.409404260196, 3230.370077834823, 3231.3214225012775, 3236.6116066072223, 3240.2547414094656, 37652.43521347182, 38120.80939595312, 38249.61750382516, 38426.807865960494, 38478.038049049, 9102.887997226017, 9127.77180570491, 9191.724248272563, 9348.065193480597, 9462.52687365629, 15873.285702143432, 15938.362465501483, 15942.840571594368, 15947.521574352788, 15955.680886382439, 6072.240969878765, 6308.716107775161, 6311.368863113652, 6400.807975760735, 6460.644664543495, 3575.80333081683, 3606.3688854450365, 3607.6572725591027, 3613.6928361089604, 3615.692666123409, 2636.9979407824903, 2689.6906855711845, 2700.932476688059, 2706.864656767154, 2709.403931135147, 475.56248251608605, 479.5707841481854, 487.16208122030054, 489.3687143584807, 489.3760455419298, 463.768115942029, 535.568867062011, 550.2818821437982, 585.344414256036, 608.4402349838159, 6718.49611279156, 6978.0230767692565, 7021.929780702128, 7039.54242974205, 7079.115110611174, 492.72161228905554, 494.19372194628687, 524.9396319423239, 568.3151802078486, 605.1799811255773, 3031.8938837140595, 3121.734652554558, 3122.172624254574, 3164.5411415344647, 3199.82400967949, 43811.780941095094, 43921.560784392386, 44264.3360349595, 44358.33462498065, 44630.55369446329, 39732.60267397289, 39742.40386394206, 39814.2037159261, 39895.80052099779, 40710.185796283906, 36127.63872361295, 36718.449223261676, 36721.63278367236, 37225.44161837575, 37532.24935501275, 7425.628718564159, 7532.924670753222, 7591.4685971981435, 7640.503367281109, 7682.692692292246, 27870.44259114847, 28082.0, 28127.0, 28950.855245723636, 29292.414151717272, 34044.829775851955, 34665.133371665914, 35079.82460087683, 35088.298234034664, 35653.64346356503, 9425.57584908667, 9634.036596340591, 9819.116279534876, 9960.103590676585, 10346.793064138825, 10693.0, 10768.246222764332, 10797.460126993461, 10958.945205274242, 11470.713232169262, 9143.13140251675, 9475.810483790423, 9521.143097121292, 9525.14273715369, 9548.331616786758, 9967.750806229902, 9992.350497217658, 10349.74125646865, 10543.94728026355, 10904.291221070922, 9188.49463279526, 10192.082712555906, 10464.267501275142, 10466.581336746445, 10498.212634052325, 8292.17078292166, 8733.908261467317, 8887.555622218992, 8929.0, 9122.589483473126, 7700.691972321044, 7880.133185349721, 7889.802754931173, 7990.800229994296, 8660.307175425825], "unit": "score", "name": "yui.html", "value": 5472.900031665527}], "name": "dromaeo_css", "value": 6050.7317371440795}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 115.0, 115.0, 115.0, 125.0, 113.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [160.0, 134.0, 162.0, 164.0, 138.0, 156.0, 161.0, 134.0, 172.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 164.0, 162.0, 163.0, 165.0, 170.0, 164.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 73.0, 73.0, 143.0, 73.0, 74.0, 72.0, 75.0, 99.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 131.0, 96.0, 99.0, 97.0, 143.0, 98.0, 99.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 123.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.1}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0, 150.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 101.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 70.0, 73.0, 70.0, 70.0, 73.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 66.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 87.0, 86.0, 85.0, 84.0, 87.0, 86.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [126.0, 128.0, 133.0, 130.0, 124.0, 126.0, 136.0, 135.0, 135.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.3}, {"lowerIsBetter": true, "replicates": [139.0, 142.0, 160.0, 150.0, 150.0, 153.0, 150.0, 150.0, 151.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 74.0, 75.0, 75.0, 74.0, 71.0, 71.0, 70.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.0}], "name": "kraken", "value": 1556.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.58840288252054], "unit": "score", "name": "Richards", "value": 210.64703400000002}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [754.7169811320755], "unit": "score", "name": "Earley", "value": 883.0634750000003}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [43957.44680851064], "unit": "score", "name": "RegExp", "value": 20.724247337850933}, {"lowerIsBetter": false, "replicates": [603.0120481927711], "unit": "score", "name": "Splay", "value": 135.13992007992007}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20130.38471497251}]} 14:35:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20130.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6050.73"}}} 14:35:49 INFO - Return code: 0 14:35:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:49 INFO - # TBPL SUCCESS # 14:35:49 INFO - Running post-action listener: _resource_record_post_action 14:35:49 INFO - Running post-run listener: _resource_record_post_run 14:35:50 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 307200; Write bytes: 312336384; Read time: 272; Write time: 163252 14:35:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5562368; Read time: 0; Write time: 380 14:35:50 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 307200; Write bytes: 306774016; Read time: 272; Write time: 162872 14:35:50 INFO - Running post-run listener: _upload_blobber_files 14:35:50 INFO - Blob upload gear active. 14:35:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:50 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 14:35:50 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'] 14:35:50 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 14:35:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:51 INFO - (blobuploader) - INFO - Done attempting. 14:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:52 INFO - (blobuploader) - INFO - Done attempting. 14:35:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:52 INFO - Return code: 0 14:35:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40c48cc8691133538dd8398b04ffb4e187583dd26e356b63b9a8478b7baf644e0cfed78658759e458bfc063e5b12cde5726b18d9fd5c7d56c2fef1e00428cbc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e7a5436bc41d02f049445cd533094f8071c7d5c66db35645b41e9e55f03b66143132db4e0bc6c5e8906fe8852f77d025ecd76c1abd88441e29a91d5f6299382"} 14:35:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:52 INFO - Contents: 14:35:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40c48cc8691133538dd8398b04ffb4e187583dd26e356b63b9a8478b7baf644e0cfed78658759e458bfc063e5b12cde5726b18d9fd5c7d56c2fef1e00428cbc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e7a5436bc41d02f049445cd533094f8071c7d5c66db35645b41e9e55f03b66143132db4e0bc6c5e8906fe8852f77d025ecd76c1abd88441e29a91d5f6299382"} 14:35:52 INFO - Copying logs to upload dir... 14:35:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.772848 ========= master_lag: 1.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-11 14:35:54.056636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 14:35:54.063822) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 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/40c48cc8691133538dd8398b04ffb4e187583dd26e356b63b9a8478b7baf644e0cfed78658759e458bfc063e5b12cde5726b18d9fd5c7d56c2fef1e00428cbc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e7a5436bc41d02f049445cd533094f8071c7d5c66db35645b41e9e55f03b66143132db4e0bc6c5e8906fe8852f77d025ecd76c1abd88441e29a91d5f6299382"} build_url:https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/Wm8_I_uMShOWN0Xr4UT5rw/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/40c48cc8691133538dd8398b04ffb4e187583dd26e356b63b9a8478b7baf644e0cfed78658759e458bfc063e5b12cde5726b18d9fd5c7d56c2fef1e00428cbc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e7a5436bc41d02f049445cd533094f8071c7d5c66db35645b41e9e55f03b66143132db4e0bc6c5e8906fe8852f77d025ecd76c1abd88441e29a91d5f6299382"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 14:35:54.094111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:35:54.094539) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452549662.230677-308885856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:35:54.360493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:35:54.360836) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:35:54.361602) ========= ========= Total master_lag: 1.75 =========