builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1453199955.7 results: success (0) buildid: 20160119015736 builduid: 656da356739a4588aadf1ec5939d8d37 revision: 4824324ae86931bcbaecef47f8fb039bb7a42784 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.699545) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.700095) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.700718) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.745759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.746090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.820118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.820714) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.876062) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.876395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.876834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:15.877204) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 02:39:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.4M=0s 2016-01-19 02:39:17 (78.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.000077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.000394) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.053344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.053693) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4824324ae86931bcbaecef47f8fb039bb7a42784 --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 4824324ae86931bcbaecef47f8fb039bb7a42784 --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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 02:39:17,229 truncating revision to first 12 chars 2016-01-19 02:39:17,229 Setting DEBUG logging. 2016-01-19 02:39:17,229 attempt 1/10 2016-01-19 02:39:17,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4824324ae869?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 02:39:17,490 unpacking tar archive at: fx-team-4824324ae869/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.657306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.657682) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004694 script_repo_revision: '%(revision)s' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.720917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.721220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.742095) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.742404) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 02:39:16.742858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-19 02:39:16.743158) ========= /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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:18 INFO - MultiFileLogger online at 20160119 02:39:18 in /builds/slave/test 02:39:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:39:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:18 INFO - {'append_to_log': False, 02:39:18 INFO - 'base_work_dir': '/builds/slave/test', 02:39:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:39:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:18 INFO - 'branch': 'Fx-Team-Non-PGO', 02:39:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:18 INFO - 'config_files': ('talos/linux_config.py',), 02:39:18 INFO - 'default_actions': ('clobber', 02:39:18 INFO - 'read-buildbot-config', 02:39:18 INFO - 'download-and-extract', 02:39:18 INFO - 'populate-webroot', 02:39:18 INFO - 'create-virtualenv', 02:39:18 INFO - 'install', 02:39:18 INFO - 'run-tests'), 02:39:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:18 INFO - 'download_minidump_stackwalk': True, 02:39:18 INFO - 'download_symbols': 'ondemand', 02:39:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:18 INFO - 'installer_path': 'installer.exe', 02:39:18 INFO - 'log_level': 'info', 02:39:18 INFO - 'log_name': 'talos', 02:39:18 INFO - 'log_to_console': True, 02:39:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:18 INFO - 'opt_config_files': (), 02:39:18 INFO - 'pip_index': False, 02:39:18 INFO - 'sps_profile': False, 02:39:18 INFO - 'sps_profile_interval': 0, 02:39:18 INFO - 'suite': 'dromaeojs-e10s', 02:39:18 INFO - 'system_bits': '32', 02:39:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:18 INFO - 'title': 'talos-linux64-ix-065', 02:39:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:18 INFO - 'use_talos_json': True, 02:39:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:18 INFO - 'work_dir': 'build'} 02:39:18 INFO - ##### 02:39:18 INFO - ##### Running clobber step. 02:39:18 INFO - ##### 02:39:18 INFO - Running pre-action listener: _resource_record_pre_action 02:39:18 INFO - Running main action method: clobber 02:39:18 INFO - rmtree: /builds/slave/test/build 02:39:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:18 INFO - Running post-action listener: _resource_record_post_action 02:39:18 INFO - ##### 02:39:18 INFO - ##### Running read-buildbot-config step. 02:39:18 INFO - ##### 02:39:18 INFO - Running pre-action listener: _resource_record_pre_action 02:39:18 INFO - Running main action method: read_buildbot_config 02:39:18 INFO - Using buildbot properties: 02:39:18 INFO - { 02:39:18 INFO - "project": "", 02:39:18 INFO - "product": "firefox", 02:39:18 INFO - "script_repo_revision": "production", 02:39:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:39:18 INFO - "repository": "", 02:39:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:39:18 INFO - "buildid": "20160119015736", 02:39:18 INFO - "pgo_build": "False", 02:39:18 INFO - "basedir": "/builds/slave/test", 02:39:18 INFO - "buildnumber": 663, 02:39:18 INFO - "slavename": "talos-linux64-ix-065", 02:39:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:39:18 INFO - "platform": "ubuntu64_hw", 02:39:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:39:18 INFO - "branch": "fx-team", 02:39:18 INFO - "repo_path": "integration/fx-team", 02:39:18 INFO - "revision": "4824324ae86931bcbaecef47f8fb039bb7a42784", 02:39:18 INFO - "stage_platform": "linux64", 02:39:18 INFO - "builduid": "656da356739a4588aadf1ec5939d8d37", 02:39:18 INFO - "slavebuilddir": "test" 02:39:18 INFO - } 02:39:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:39:18 INFO - Running post-action listener: _resource_record_post_action 02:39:18 INFO - ##### 02:39:18 INFO - ##### Running download-and-extract step. 02:39:18 INFO - ##### 02:39:18 INFO - Running pre-action listener: _resource_record_pre_action 02:39:18 INFO - Running main action method: download_and_extract 02:39:18 INFO - mkdir: /builds/slave/test/build/tests 02:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:18 INFO - https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:39:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/test_packages.json 02:39:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/test_packages.json 02:39:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:39:21 INFO - Downloaded 1448 bytes. 02:39:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:39:21 INFO - Using the following test package requirements: 02:39:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:39:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:39:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'jsshell-linux-x86_64.zip'], 02:39:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:39:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:39:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:39:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:39:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:39:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:39:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:39:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:21 INFO - https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:25 INFO - Downloaded 21216013 bytes. 02:39:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:39:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:39:26 INFO - Return code: 0 02:39:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:39: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')]} 02:39:26 INFO - https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:39:28 INFO - Downloaded 21216013 bytes. 02:39:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:39:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:39:29 INFO - Return code: 0 02:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:29 INFO - https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:39:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:39:30 INFO - Downloaded 11132144 bytes. 02:39:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:39:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:39:31 INFO - Return code: 0 02:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:31 INFO - https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:39:33 INFO - Downloaded 54180909 bytes. 02:39:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:33 INFO - mkdir: /builds/slave/test/properties 02:39:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:33 INFO - Contents: 02:39:33 INFO - build_url:https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:39:33 INFO - Running post-action listener: _resource_record_post_action 02:39:33 INFO - Running post-action listener: set_extra_try_arguments 02:39:33 INFO - ##### 02:39:33 INFO - ##### Running populate-webroot step. 02:39:33 INFO - ##### 02:39:33 INFO - Running pre-action listener: _resource_record_pre_action 02:39:33 INFO - Running main action method: populate_webroot 02:39:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:33 INFO - '--tppagecycles', 02:39:33 INFO - '7'], 02:39:33 INFO - 'tests': ['tsvgm']}}, 02:39:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:39:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:39:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'tests': ['damp', 'tps']}, 02:39:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['damp', 'tps']}, 02:39:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:39:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:33 INFO - 'other': {'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'other_l64': {'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'other_nol64': {'tests': ['a11yr', 02:39:33 INFO - 'ts_paint', 02:39:33 INFO - 'tpaint', 02:39:33 INFO - 'sessionrestore', 02:39:33 INFO - 'sessionrestore_no_auto_restore']}, 02:39:33 INFO - 'svgr': {'tests': ['tsvgx', 02:39:33 INFO - 'tsvgr_opacity', 02:39:33 INFO - 'tart', 02:39:33 INFO - 'tscrollx', 02:39:33 INFO - 'cart']}, 02:39:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['tsvgx', 02:39:33 INFO - 'tsvgr_opacity', 02:39:33 INFO - 'tart', 02:39:33 INFO - 'tscrollx', 02:39:33 INFO - 'cart']}, 02:39:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'tests': ['tp5o']}, 02:39:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'talos_options': ['--e10s'], 02:39:33 INFO - 'tests': ['tp5o']}, 02:39:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'talos_options': ['--xperf_path', 02:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:33 INFO - 'tests': ['tp5n']}, 02:39:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:33 INFO - 'talos_options': ['--e10s', 02:39:33 INFO - '--xperf_path', 02:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:33 INFO - 'tests': ['tp5n']}}, 02:39:33 INFO - 'talos.zip': {'path': '', 02:39:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:33 INFO - Running post-action listener: _resource_record_post_action 02:39:33 INFO - ##### 02:39:33 INFO - ##### Running create-virtualenv step. 02:39:33 INFO - ##### 02:39:33 INFO - Running pre-action listener: _resource_record_pre_action 02:39:33 INFO - Running main action method: create_virtualenv 02:39:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:33 INFO - Using real prefix '/usr' 02:39:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:36 INFO - Installing pip.................done. 02:39:36 INFO - Return code: 0 02:39:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:36 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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:39:36 INFO - Using env: {'DISPLAY': ':0', 02:39:36 INFO - 'HOME': '/home/cltbld', 02:39:36 INFO - 'LANG': 'en_US.UTF-8', 02:39:36 INFO - 'LANGUAGE': 'en_US:en', 02:39:36 INFO - 'LOGNAME': 'cltbld', 02:39:36 INFO - 'MAIL': '/var/mail/cltbld', 02:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:36 INFO - 'MOZ_NO_REMOTE': '1', 02:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:36 INFO - 'NO_EM_RESTART': '1', 02:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:36 INFO - 'PWD': '/builds/slave/test', 02:39:36 INFO - 'SHELL': '/bin/bash', 02:39:36 INFO - 'SHLVL': '1', 02:39:36 INFO - 'TERM': 'linux', 02:39:36 INFO - 'TMOUT': '86400', 02:39:36 INFO - 'USER': 'cltbld', 02:39:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:36 INFO - '_': '/tools/buildbot/bin/python'} 02:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:39:36 INFO - Cleaning up... 02:39:36 INFO - Return code: 0 02:39:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:36 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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:39:36 INFO - Using env: {'DISPLAY': ':0', 02:39:36 INFO - 'HOME': '/home/cltbld', 02:39:36 INFO - 'LANG': 'en_US.UTF-8', 02:39:36 INFO - 'LANGUAGE': 'en_US:en', 02:39:36 INFO - 'LOGNAME': 'cltbld', 02:39:36 INFO - 'MAIL': '/var/mail/cltbld', 02:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:36 INFO - 'MOZ_NO_REMOTE': '1', 02:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:36 INFO - 'NO_EM_RESTART': '1', 02:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:36 INFO - 'PWD': '/builds/slave/test', 02:39:36 INFO - 'SHELL': '/bin/bash', 02:39:36 INFO - 'SHLVL': '1', 02:39:36 INFO - 'TERM': 'linux', 02:39:36 INFO - 'TMOUT': '86400', 02:39:36 INFO - 'USER': 'cltbld', 02:39:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:36 INFO - '_': '/tools/buildbot/bin/python'} 02:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:36 INFO - Downloading/unpacking psutil>=0.7.1 02:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:38 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:39:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:38 INFO - Installing collected packages: psutil 02:39:38 INFO - Running setup.py install for psutil 02:39:38 INFO - building 'psutil._psutil_linux' extension 02:39:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:39:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:39:38 INFO - building 'psutil._psutil_posix' extension 02:39:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:39:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:39 INFO - Successfully installed psutil 02:39:39 INFO - Cleaning up... 02:39:39 INFO - Return code: 0 02:39:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:39 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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:39:39 INFO - Using env: {'DISPLAY': ':0', 02:39:39 INFO - 'HOME': '/home/cltbld', 02:39:39 INFO - 'LANG': 'en_US.UTF-8', 02:39:39 INFO - 'LANGUAGE': 'en_US:en', 02:39:39 INFO - 'LOGNAME': 'cltbld', 02:39:39 INFO - 'MAIL': '/var/mail/cltbld', 02:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:39 INFO - 'MOZ_NO_REMOTE': '1', 02:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:39 INFO - 'NO_EM_RESTART': '1', 02:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:39 INFO - 'PWD': '/builds/slave/test', 02:39:39 INFO - 'SHELL': '/bin/bash', 02:39:39 INFO - 'SHLVL': '1', 02:39:39 INFO - 'TERM': 'linux', 02:39:39 INFO - 'TMOUT': '86400', 02:39:39 INFO - 'USER': 'cltbld', 02:39:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:39 INFO - '_': '/tools/buildbot/bin/python'} 02:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:39:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:39:41 INFO - Installing collected packages: mozsystemmonitor 02:39:41 INFO - Running setup.py install for mozsystemmonitor 02:39:41 INFO - Successfully installed mozsystemmonitor 02:39:41 INFO - Cleaning up... 02:39:41 INFO - Return code: 0 02:39:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:41 INFO - Using env: {'DISPLAY': ':0', 02:39:41 INFO - 'HOME': '/home/cltbld', 02:39:41 INFO - 'LANG': 'en_US.UTF-8', 02:39:41 INFO - 'LANGUAGE': 'en_US:en', 02:39:41 INFO - 'LOGNAME': 'cltbld', 02:39:41 INFO - 'MAIL': '/var/mail/cltbld', 02:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:41 INFO - 'MOZ_NO_REMOTE': '1', 02:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:41 INFO - 'NO_EM_RESTART': '1', 02:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:41 INFO - 'PWD': '/builds/slave/test', 02:39:41 INFO - 'SHELL': '/bin/bash', 02:39:41 INFO - 'SHLVL': '1', 02:39:41 INFO - 'TERM': 'linux', 02:39:41 INFO - 'TMOUT': '86400', 02:39:41 INFO - 'USER': 'cltbld', 02:39:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:41 INFO - '_': '/tools/buildbot/bin/python'} 02:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:43 INFO - Downloading docopt-0.6.1.tar.gz 02:39:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:43 INFO - Running setup.py install for blobuploader 02:39:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:44 INFO - Running setup.py install for requests 02:39:44 INFO - Running setup.py install for docopt 02:39:44 INFO - Successfully installed blobuploader requests docopt 02:39:44 INFO - Cleaning up... 02:39:44 INFO - Return code: 0 02:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:44 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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:44 INFO - Using env: {'DISPLAY': ':0', 02:39:44 INFO - 'HOME': '/home/cltbld', 02:39:44 INFO - 'LANG': 'en_US.UTF-8', 02:39:44 INFO - 'LANGUAGE': 'en_US:en', 02:39:44 INFO - 'LOGNAME': 'cltbld', 02:39:44 INFO - 'MAIL': '/var/mail/cltbld', 02:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:44 INFO - 'MOZ_NO_REMOTE': '1', 02:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:44 INFO - 'NO_EM_RESTART': '1', 02:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:44 INFO - 'PWD': '/builds/slave/test', 02:39:44 INFO - 'SHELL': '/bin/bash', 02:39:44 INFO - 'SHLVL': '1', 02:39:44 INFO - 'TERM': 'linux', 02:39:44 INFO - 'TMOUT': '86400', 02:39:44 INFO - 'USER': 'cltbld', 02:39:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:44 INFO - '_': '/tools/buildbot/bin/python'} 02:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:44 INFO - Running setup.py (path:/tmp/pip-oagIkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:44 INFO - Running setup.py (path:/tmp/pip-0fqugD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:44 INFO - Running setup.py (path:/tmp/pip-zbZOAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:44 INFO - Running setup.py (path:/tmp/pip-e6e92B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:45 INFO - Running setup.py (path:/tmp/pip-v2nCzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:45 INFO - Running setup.py (path:/tmp/pip-tSbL7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:45 INFO - Running setup.py (path:/tmp/pip-xt40i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:45 INFO - Running setup.py (path:/tmp/pip-P0aVzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:45 INFO - Running setup.py (path:/tmp/pip-_PgRku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:45 INFO - Running setup.py (path:/tmp/pip-HcbhJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:45 INFO - Running setup.py (path:/tmp/pip-4fAjRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:45 INFO - Running setup.py (path:/tmp/pip-CDmWcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:45 INFO - Running setup.py (path:/tmp/pip-rRBmkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:45 INFO - Running setup.py (path:/tmp/pip-reBZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:45 INFO - Running setup.py (path:/tmp/pip-0aqv0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:45 INFO - Running setup.py (path:/tmp/pip-Z84Nx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:45 INFO - Running setup.py (path:/tmp/pip-22psdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:45 INFO - Running setup.py install for manifestparser 02:39:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Running setup.py install for mozcrash 02:39:46 INFO - Running setup.py install for mozdebug 02:39:46 INFO - Running setup.py install for mozdevice 02:39:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Running setup.py install for mozfile 02:39:46 INFO - Running setup.py install for mozhttpd 02:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Running setup.py install for mozinfo 02:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Running setup.py install for mozInstall 02:39:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:46 INFO - Running setup.py install for mozleak 02:39:46 INFO - Running setup.py install for mozlog 02:39:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Running setup.py install for moznetwork 02:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Running setup.py install for mozprocess 02:39:47 INFO - Running setup.py install for mozprofile 02:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Running setup.py install for mozrunner 02:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Running setup.py install for mozscreenshot 02:39:47 INFO - Running setup.py install for moztest 02:39:47 INFO - Running setup.py install for mozversion 02:39:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:47 INFO - Cleaning up... 02:39:47 INFO - Return code: 0 02:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:47 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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:47 INFO - Using env: {'DISPLAY': ':0', 02:39:47 INFO - 'HOME': '/home/cltbld', 02:39:47 INFO - 'LANG': 'en_US.UTF-8', 02:39:47 INFO - 'LANGUAGE': 'en_US:en', 02:39:47 INFO - 'LOGNAME': 'cltbld', 02:39:47 INFO - 'MAIL': '/var/mail/cltbld', 02:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:47 INFO - 'MOZ_NO_REMOTE': '1', 02:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:47 INFO - 'NO_EM_RESTART': '1', 02:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:47 INFO - 'PWD': '/builds/slave/test', 02:39:47 INFO - 'SHELL': '/bin/bash', 02:39:47 INFO - 'SHLVL': '1', 02:39:47 INFO - 'TERM': 'linux', 02:39:47 INFO - 'TMOUT': '86400', 02:39:47 INFO - 'USER': 'cltbld', 02:39:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:47 INFO - '_': '/tools/buildbot/bin/python'} 02:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:47 INFO - Running setup.py (path:/tmp/pip-CjhnmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:48 INFO - Running setup.py (path:/tmp/pip-eAHkAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:48 INFO - Running setup.py (path:/tmp/pip-oZnm23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:48 INFO - Running setup.py (path:/tmp/pip-GKU9eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:48 INFO - Running setup.py (path:/tmp/pip-wO088a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:48 INFO - Running setup.py (path:/tmp/pip-fXUfxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:48 INFO - Running setup.py (path:/tmp/pip-iqrGJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:48 INFO - Running setup.py (path:/tmp/pip-0MZuvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:48 INFO - Running setup.py (path:/tmp/pip-MNDpll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:48 INFO - Running setup.py (path:/tmp/pip-nMjWkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:48 INFO - Running setup.py (path:/tmp/pip-vYkar4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:48 INFO - Running setup.py (path:/tmp/pip-Ozh3RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:48 INFO - Running setup.py (path:/tmp/pip-YZMdaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:48 INFO - Running setup.py (path:/tmp/pip-FyGfV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:48 INFO - Running setup.py (path:/tmp/pip-_RyCi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:49 INFO - Running setup.py (path:/tmp/pip-cW7ASR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:49 INFO - Running setup.py (path:/tmp/pip-tWD0zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:39:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:50 INFO - Downloading blessings-1.5.1.tar.gz 02:39:51 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:51 INFO - Installing collected packages: blessings 02:39:51 INFO - Running setup.py install for blessings 02:39:51 INFO - Successfully installed blessings 02:39:51 INFO - Cleaning up... 02:39:51 INFO - Return code: 0 02:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:51 INFO - Reading from file tmpfile_stdout 02:39:51 INFO - Current package versions: 02:39:51 INFO - argparse == 1.2.1 02:39:51 INFO - blessings == 1.5.1 02:39:51 INFO - blobuploader == 1.2.4 02:39:51 INFO - docopt == 0.6.1 02:39:51 INFO - manifestparser == 1.1 02:39:51 INFO - mozInstall == 1.12 02:39:51 INFO - mozcrash == 0.16 02:39:51 INFO - mozdebug == 0.1 02:39:51 INFO - mozdevice == 0.48 02:39:51 INFO - mozfile == 1.2 02:39:51 INFO - mozhttpd == 0.7 02:39:51 INFO - mozinfo == 0.9 02:39:51 INFO - mozleak == 0.1 02:39:51 INFO - mozlog == 3.1 02:39:51 INFO - moznetwork == 0.27 02:39:51 INFO - mozprocess == 0.22 02:39:51 INFO - mozprofile == 0.28 02:39:51 INFO - mozrunner == 6.11 02:39:51 INFO - mozscreenshot == 0.1 02:39:51 INFO - mozsystemmonitor == 0.0 02:39:51 INFO - moztest == 0.7 02:39:51 INFO - mozversion == 1.4 02:39:51 INFO - psutil == 3.1.1 02:39:51 INFO - requests == 1.2.3 02:39:51 INFO - wsgiref == 0.1.2 02:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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', '-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 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:39:51 INFO - Using env: {'DISPLAY': ':0', 02:39:51 INFO - 'HOME': '/home/cltbld', 02:39:51 INFO - 'LANG': 'en_US.UTF-8', 02:39:51 INFO - 'LANGUAGE': 'en_US:en', 02:39:51 INFO - 'LOGNAME': 'cltbld', 02:39:51 INFO - 'MAIL': '/var/mail/cltbld', 02:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:51 INFO - 'MOZ_NO_REMOTE': '1', 02:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:51 INFO - 'NO_EM_RESTART': '1', 02:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:51 INFO - 'PWD': '/builds/slave/test', 02:39:51 INFO - 'SHELL': '/bin/bash', 02:39:51 INFO - 'SHLVL': '1', 02:39:51 INFO - 'TERM': 'linux', 02:39:51 INFO - 'TMOUT': '86400', 02:39:51 INFO - 'USER': 'cltbld', 02:39:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:51 INFO - '_': '/tools/buildbot/bin/python'} 02:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:39:51 INFO - Cleaning up... 02:39:51 INFO - Return code: 0 02:39:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39: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', 'jsonschema'] in /builds/slave/test/build 02:39: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 jsonschema 02:39:51 INFO - Using env: {'DISPLAY': ':0', 02:39:51 INFO - 'HOME': '/home/cltbld', 02:39:51 INFO - 'LANG': 'en_US.UTF-8', 02:39:51 INFO - 'LANGUAGE': 'en_US:en', 02:39:51 INFO - 'LOGNAME': 'cltbld', 02:39:51 INFO - 'MAIL': '/var/mail/cltbld', 02:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:51 INFO - 'MOZ_NO_REMOTE': '1', 02:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:51 INFO - 'NO_EM_RESTART': '1', 02:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:51 INFO - 'PWD': '/builds/slave/test', 02:39:51 INFO - 'SHELL': '/bin/bash', 02:39:51 INFO - 'SHLVL': '1', 02:39:51 INFO - 'TERM': 'linux', 02:39:51 INFO - 'TMOUT': '86400', 02:39:51 INFO - 'USER': 'cltbld', 02:39:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:51 INFO - '_': '/tools/buildbot/bin/python'} 02:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:52 INFO - Downloading/unpacking jsonschema 02:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:39:53 INFO - Downloading/unpacking functools32 (from jsonschema) 02:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:53 INFO - warning: no files found matching '*.txt' 02:39:53 INFO - no previously-included directories found matching 'build' 02:39:53 INFO - no previously-included directories found matching 'dist' 02:39:53 INFO - no previously-included directories found matching '.git*' 02:39:53 INFO - Installing collected packages: jsonschema, functools32 02:39:54 INFO - Running setup.py install for functools32 02:39:54 INFO - warning: no files found matching '*.txt' 02:39:54 INFO - no previously-included directories found matching 'build' 02:39:54 INFO - no previously-included directories found matching 'dist' 02:39:54 INFO - no previously-included directories found matching '.git*' 02:39:54 INFO - Successfully installed jsonschema functools32 02:39:54 INFO - Cleaning up... 02:39:54 INFO - Return code: 0 02:39:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe74c32ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe7fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, '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': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39: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', 'flake8'] in /builds/slave/test/build 02:39: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 flake8 02:39:54 INFO - Using env: {'DISPLAY': ':0', 02:39:54 INFO - 'HOME': '/home/cltbld', 02:39:54 INFO - 'LANG': 'en_US.UTF-8', 02:39:54 INFO - 'LANGUAGE': 'en_US:en', 02:39:54 INFO - 'LOGNAME': 'cltbld', 02:39:54 INFO - 'MAIL': '/var/mail/cltbld', 02:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:54 INFO - 'MOZ_NO_REMOTE': '1', 02:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:54 INFO - 'NO_EM_RESTART': '1', 02:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:54 INFO - 'PWD': '/builds/slave/test', 02:39:54 INFO - 'SHELL': '/bin/bash', 02:39:54 INFO - 'SHLVL': '1', 02:39:54 INFO - 'TERM': 'linux', 02:39:54 INFO - 'TMOUT': '86400', 02:39:54 INFO - 'USER': 'cltbld', 02:39:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:54 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:54 INFO - Downloading/unpacking flake8 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39: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 02:39:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:39:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:39:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:39:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:39:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:56 INFO - no previously-included directories found matching 'docs/_build' 02:39:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:39:56 INFO - Running setup.py install for pep8 02:39:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:56 INFO - no previously-included directories found matching 'docs/_build' 02:39:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:39:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:39:57 INFO - Cleaning up... 02:39:57 INFO - Return code: 0 02:39:57 INFO - Running post-action listener: _resource_record_post_action 02:39:57 INFO - Running post-action listener: _start_resource_monitoring 02:39:57 INFO - Starting resource monitoring. 02:39:57 INFO - ##### 02:39:57 INFO - ##### Running install step. 02:39:57 INFO - ##### 02:39:57 INFO - Running pre-action listener: _resource_record_pre_action 02:39:57 INFO - Running main action method: install 02:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:57 INFO - Reading from file tmpfile_stdout 02:39:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:57 INFO - Reading from file tmpfile_stdout 02:39:57 INFO - Output received: 02:39:57 INFO - Usage: mozinstall [options] installer 02:39:57 INFO - Options: 02:39:57 INFO - -h, --help show this help message and exit 02:39:57 INFO - -d DEST, --destination=DEST 02:39:57 INFO - Directory to install application into. [default: 02:39:57 INFO - "/builds/slave/test"] 02:39:57 INFO - --app=APP Application being installed. [default: firefox] 02:39:57 INFO - mkdir: /builds/slave/test/build/application 02:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Output received: 02:40:13 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:13 INFO - Running post-action listener: _resource_record_post_action 02:40:13 INFO - ##### 02:40:13 INFO - ##### Running run-tests step. 02:40:13 INFO - ##### 02:40:13 INFO - Running pre-action listener: _resource_record_pre_action 02:40:13 INFO - Running main action method: run_tests 02:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:13 INFO - Python 2.7.3 02:40:13 INFO - Return code: 0 02:40:13 INFO - grabbing minidump binary from tooltool 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:13 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 0xf123d0>, '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 0xe7ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe7e360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:40:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:40:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:13 INFO - Return code: 0 02:40:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:40:14 INFO - Return code: 0 02:40:14 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/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:40:14 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/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:40:14 INFO - Using env: {'DISPLAY': ':0', 02:40:14 INFO - 'HOME': '/home/cltbld', 02:40:14 INFO - 'LANG': 'en_US.UTF-8', 02:40:14 INFO - 'LANGUAGE': 'en_US:en', 02:40:14 INFO - 'LOGNAME': 'cltbld', 02:40:14 INFO - 'MAIL': '/var/mail/cltbld', 02:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:14 INFO - 'MOZ_NO_REMOTE': '1', 02:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:14 INFO - 'NO_EM_RESTART': '1', 02:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:14 INFO - 'PWD': '/builds/slave/test', 02:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:14 INFO - 'SHELL': '/bin/bash', 02:40:14 INFO - 'SHLVL': '1', 02:40:14 INFO - 'TERM': 'linux', 02:40:14 INFO - 'TMOUT': '86400', 02:40:14 INFO - 'USER': 'cltbld', 02:40:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750', 02:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:14 INFO - '_': '/tools/buildbot/bin/python'} 02:40:14 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/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:40:14 INFO - mozversion application_buildid: 20160119015736 02:40:14 INFO - mozversion application_changeset: 4824324ae86931bcbaecef47f8fb039bb7a42784 02:40:14 INFO - mozversion application_display_name: Nightly 02:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:14 INFO - mozversion application_name: Firefox 02:40:14 INFO - mozversion application_remotingname: firefox 02:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:40:14 INFO - mozversion application_vendor: Mozilla 02:40:14 INFO - mozversion application_version: 46.0a1 02:40:14 INFO - mozversion platform_buildid: 20160119015736 02:40:14 INFO - mozversion platform_changeset: 4824324ae86931bcbaecef47f8fb039bb7a42784 02:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:40:14 INFO - mozversion platform_version: 46.0a1 02:40:14 INFO - using testdate: 1453200014 02:40:14 INFO - actual date: 1453200014 02:40:14 INFO - starting webserver on 'localhost:45853' 02:40:14 INFO - SUITE-START | Running 3 tests 02:40:14 INFO - TEST-START | dromaeo_css 02:40:14 INFO - operating with platform_type : linux_ 02:40:14 INFO - Initialising browser for dromaeo_css test... 02:40:14 INFO - TEST-INFO | started process 20762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLi041k/profile http://localhost:45853/getInfo.html) 02:40:17 INFO - PROCESS | 20762 | -- checkerboarding starts below -- 02:40:17 INFO - PROCESS | 20762 | RENDERTRACE 0.048255 rect red 0 0 1024 768 // viewport 02:40:17 INFO - PROCESS | 20762 | RENDERTRACE 270.584 rect brown 0 0 1024 768 // page 02:40:17 INFO - PROCESS | 20762 | RENDERTRACE 270.617 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 02:40:17 INFO - PROCESS | 20762 | Checkerboarded for 1 frames (283.41 ms), 786432 peak, 14929 severity. 02:40:18 INFO - PROCESS | 20762 | 02:40:18 INFO - PROCESS | 20762 | (process:20842): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:40:18 INFO - PROCESS | 20762 | __metrics Screen width/height:1600/1200 02:40:18 INFO - PROCESS | 20762 | colorDepth:24 02:40:18 INFO - PROCESS | 20762 | Browser inner width/height: 1024/697 02:40:18 INFO - PROCESS | 20762 | __metrics 02:40:19 INFO - PROCESS | 20762 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:40:19 INFO - TEST-INFO | 20762: exit 0 02:40:19 INFO - Browser initialized. 02:40:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:19 INFO - TEST-INFO | started process 20890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLi041k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:20 INFO - PROCESS | 20890 | -- checkerboarding starts below -- 02:40:20 INFO - PROCESS | 20890 | RENDERTRACE 0.039555 rect red 0 0 10 10 // viewport 02:40:20 INFO - PROCESS | 20890 | RENDERTRACE 35.9025 rect brown 0 0 10 10 // page 02:40:20 INFO - PROCESS | 20890 | RENDERTRACE 35.9263 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:40:20 INFO - PROCESS | 20890 | Checkerboarded for 1 frames (38.0595 ms), 100 peak, 1 severity. 02:40:21 INFO - PROCESS | 20890 | 02:40:21 INFO - PROCESS | 20890 | (process:20947): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:40:31 INFO - PROCESS | 20890 | RSS: Main: 150753280 02:40:31 INFO - PROCESS | 20890 | 02:41:21 INFO - PROCESS | 20890 | 1453200081492 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:43:32 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45853/tests/dromaeo/cssquery-ext.html) 02:43:33 INFO - PROCESS | 20890 | RSS: Main: 155344896 02:43:33 INFO - PROCESS | 20890 | 02:46:35 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-ext.html (next: http://localhost:45853/tests/dromaeo/cssquery-jquery.html) 02:46:35 INFO - PROCESS | 20890 | RSS: Main: 150990848 02:46:35 INFO - PROCESS | 20890 | 02:49:37 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45853/tests/dromaeo/cssquery-mootools.html) 02:49:38 INFO - PROCESS | 20890 | RSS: Main: 151609344 02:49:38 INFO - PROCESS | 20890 | 02:52:40 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45853/tests/dromaeo/cssquery-prototype.html) 02:52:40 INFO - PROCESS | 20890 | RSS: Main: 150220800 02:52:40 INFO - PROCESS | 20890 | 02:55:43 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45853/tests/dromaeo/cssquery-yui.html) 02:55:43 INFO - PROCESS | 20890 | RSS: Main: 151310336 02:55:43 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:45853/tests/dromaeo/cssquery-yui.html (next: http://localhost:45853/tests/dromaeo/cssquery-dojo.html) 02:58:46 INFO - PROCESS | 20890 | RSS: Main: 153878528 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | __start_tp_report 02:58:46 INFO - PROCESS | 20890 | _x_x_mozilla_page_load 02:58:46 INFO - PROCESS | 20890 | _x_x_mozilla_page_load_details 02:58:46 INFO - PROCESS | 20890 | |i|pagename|runs| 02:58:46 INFO - PROCESS | 20890 | |0;dojo.html;2597.532444160051;2605.3486628342916;2638.63059171716;2641.2604470748197;2658.242400915739;4409.845655402066;4430.047539778947;4447.4218351614245;4451.198784218839;4474;4434.733915965036;4550.79521421536;4556.726596404218;4585.312203169527;4606.884827879305;26.588808313321156;4158.126793373388;4182.16356728654;4228.450301460805;4271.103068355649;3969.2656858481273;4135.214309281242;4158.085221251335;4175.144095460423;4202.264603694357;4227.239096962546;4243.533211346749;4247.320428731419;4247.978760106195;4271.31658934569;4206.053637931472;4212.347086201613;4237.533871274158;4261.403403523509;4282.314829627245;4074.775887326196;4157.293260145752;4166.166766646683;4217.388478670607;4232.746035237896;4432.490263619693;4438.4451943507065;4439.644828413751;4453.376527286183;4477.865664030084;4725.432948046257;4817.56641902227;4820.662553621248;4832.565069143759;4837.806487740486;4768.642351823592;4815.66290359675;4864.635152363587;4873.829415970459;4902.779374928136;4487.147441986045;4497.257952437811;4501.662375321864;4509.1883460977015;4522.118186953546;4780.498047704941;4809.374781278411;4908.165611845995;4909.091818013679;4954.603631709455;4719.929201061918;4743.810247590058;4762.3570817939135;4771.880702982453;4823.493533179036;4893.608511319086;4897.2654101885;4898.289747986522;4915.336429581961;4915.336429582032;4666.3700400445505;4758.690685105457;4766.785494652749;4852.805887764521;4867.440244371872;4591.678582499259;4617.2612382018715;4621.630269578425;4624.190766615829;4625.3755742974945;3974.900627484336;3987.2224916141654;4020.075382662004;4049.5747946465785;4058.289799285113;3574.785512869184;3576.964230357663;3584.5340105786604;3598.2803439312243;3616.4936908832783;4071.75569465833;4172.520160181557;4186.392973018896;4224.366345048267;4246.8725938221905;4791.065742180311;4813.4945830687975;4845.370101886802;4850.490698476679;4882.780274887638;4256.212600668886;4258.701890867672;4282.314829627245;4289.399484072233;4318.157959197926;4234.6823988201;4299.591538803808;4362.411074504965;4376.365427013129;4383.273776187357;4550.567696068868;4612.7924243409125;4651.395318608559;4651.697639653412;4699.4830568636735;4850.029994001144;4857.708537487762;4874.049560335842;4888.755562221946;4943.110240156662;4458.086092351125;4507.459104907432;4629.907401851877;4650;4687.179743544798;4754.385088201545;4755.595774359218;4776.402949631296;4787.114383839001;4812.614990800657;4827.010462855176;4829.323894654822;4839.177339852163;4847.321375007572;4873.4882837301575;4585.449746030497;4599.218132917479;4669.159551280802;4675.76621168947;4699.201135806853;4678.204705200193;4695.413073365829;4703.835365762182;4707.8823029423165;4718.834840780556;4556.088782243631;4599.379083823775;4612.86161415158;4629;4660.184467718203;4615.699979501322;4624.653151013755;4676.883077922943;4697.365855609449;4772;4611.953880461152;4631.351610774562;4635.096156249499;4642.907141857211;4669.906601868011 02:58:46 INFO - PROCESS | 20890 | |1;ext.html;474.2080725188934;498.3869840096681;508.88041310292084;510.09458211674286;512.95639870611;32531.67468325316;33020.834895825545;33146.50280245795;33224.66775332246;33321.00147982239;36324.636753632454;36903.44644830329;36915;36961.63038369615;37045.629543704556;7656.3874890008665;7840.4511684182135;7847.960760196191;7849.0581130264445;7874;7595.240475952416;7714.8457030859345;7715;7739.2260773922435;7753.147153813076;7895.723649672263;7937.761867143995;7955.920440795605;7981.640826162837;8000.559969201691;7871.134175240719;7899.684012639487;7909.683612655487;7917.9208207918045;7947.483413578099;7809.765707028798;7900.170482099355;7926.167752386032;7931.206879312081;7961.562114083723;35953.64046359529;36552.624079435016;36776.448353274725;36837.447438288444;36849.26301473982;2900.216941425824;3022.667506574275;3075.5079187330143;3233.919152021195;3241.9027429176926;27879.721202787914;28121.71878281232;28319;28495.430091398262;28717;3413.095529684611;3454.2573346730574;3471.9652803471895;3524.735644826623;3554.626764189749;156227.21886390608;156531.21734391255;156540;156632;156906.21546892307;46853;47747.04505909862;55655.443445565026;55733.99999999919;57657.13514297289;51155;51274.23088653673;51315.48684513107;51412;51451.228231576555;14589.635259118395;14647.560573182822;14767.597078277546;14783.852161478462;14795.852041479662;11067.667969960914;11279.943600281946;11301.547938082385;11317.660470185743;11443.828342574869;19230.71153932692;19475.091275462237;19603;19625.80374196268;19628.70556941647;7778.8833167502535;7781.572013539197;7918.326942209977;7939.6824127035425;7973.60131993398;846.3356265331685;876.8114855306139;889.1508609278123;918.7703074231442;1006.6527048168371;26155.476890462083;26215.606765898527;26224.73775262223;26268.8686556566;26319.34201644936;956.8373376526007;976.0191008037019;1027.3835698580792;1041.8749750029892;1085.3759088523973;12752.936235318764;12761.361931903368;12765.808512872314;12767.042471814466;15176.468823591342;224683;226252;227159;227719;228228;43581.128377432906;43749;43946.78026609911;44069;44265.33601995972;1222.5232159457819;1231.1135982092878;1234.697499112723;1239.0335538280156;1239.9442025108892;25920.351991200372;26558.33604159834;27870.30324241829;28261.43477130487;28769.42461150807;39926;40097.39853902136;40425.39361909515;40578.18843623052;40593.39109913295;239064;241019;242175;242294;242587;29340.119796406143;39827.40258896177;40201;40336.39495407513;40678.38982415325;35478.113047174025;36688.14774448644;37277;39005.80497097496;40170.39744403778;32548.34903301968;33008.33983320368;33445.33109337751;33691.83154084214;33883.83058084694;35035.64964350324;36788.264234715694;36885.44671829978;37298.25403491969;37585.624143759305;31296.843515782275;31344.529832052995;31412.214694631904;31664.20839478939;31783.205419864687;27903.16290511288;29954.25114372158;30621.387572248877;30741.23146921345;30765.23086922845;20759.27342543064;20848.687269690665;20900.37298881036;21077.473063173544;21089 02:58:46 INFO - PROCESS | 20890 | |2;jquery.html;336.25183965676365;337.60163007650976;338.46860429126264;341.30374036964594;345.366252925881;14012.719745605094;14323.355449004794;14906.627334316647;15653.84346156538;15899.205039748023;13719.519816806414;13875;14703.19132447715;14711.705765884675;14831.480898168566;4467.843625473101;4685.461171965217;5019.723915184663;5021.949780502185;5033.6728112672745;4774.474807771142;4880.194767863316;4968.527989840959;4972.5276098770555;4973.204287314031;4935.5804756595735;4979.128652485819;5163.432022477525;5361.437049109846;5385.165299378603;5063.822766203202;5207.062728708831;5335.7332133393365;5347.572194224472;5357.839264822042;4995.050940321364;5014.949850501484;5018.347614810088;5022.221555658879;5029.597632189416;11013.118950483942;11703.473343699468;11733.4133293335;11853.051755859511;11855.703607409798;1748.7726595542624;1769.513383819447;1901.7622797150357;1908.8568357373254;2006.6588679924448;11729.765404691858;11777;11884.584039558575;12059.517619295306;12109.939450302692;1641.1794102948527;1668.2242757118;1682.7980642323;1713.3318005977678;1714.6484970581;49209.75395123037;50510.7474462629;50702.7464862677;50958.235626465634;51017.23474147854;8444.324454043663;8985.371024028385;9200.539973001323;9214.124658157465;9245.121713437213;11562.190646654823;11567.363794991188;11601.361925094201;11683.591074312528;11686.357250351311;6726.831829204309;6968.965155174192;7019.5086343956455;7051.259617740166;7082.716691332392;6841.110655614738;6911.17065952089;6962.651867406711;7070.010198572204;7134.571925684476;3974.18529201513;4054.432379466877;4062.8171732272117;4073.103917138225;4073.8574149905203;1638.6640738648548;1709.1283445442666;1737.800152982398;1801.3155001099499;1809.4662074688;380.99428508572396;824.7402068348451;836.1721895323586;854.747849384433;865;9048.276137909083;9267.953660231655;9442.763930901645;9506.382085164441;9694.951525242328;384.05905531448064;417.1282020576948;427.7006095732999;427.77755567105555;435.7472665853797;5051.646384753106;5192.870178245574;5241.161414173714;5246.947530524722;5263.499967503081;427756;438139;469956;473921;475632;65040;66051.33948660451;67198;67396.6630166846;68220.97668534877;452.3757215043219;457.9885502862388;458.6651744226733;459.44407267207055;461.1814030096605;8974.41666291689;9116.498592577473;9188.448693078437;9245.907540924505;9268.907310926805;28095.297617559725;28289.57565636476;28366.716332837233;28553.42893142167;28695.282617934718;40233.597664022986;40298.59701402948;40317.59682403138;40396.1920761589;40479.79760101181;6325.114483972339;6342.143810585697;6355;6627.801165965029;6649.800505984828;8332.791680208044;9315.594102688243;9423.19902808269;9557.378770379903;9625.807483850143;8158.959205203936;8396.664133434595;8446.535440550582;8484.448510846774;8648.654053837776;8335.541545215072;8809.42738721981;8937.865932010895;8970.506622135585;9137.08629137081;8288.295494883003;8627.611757470804;8662.523561204194;8825.205731484197;8876.644934202817;6628.5691430056895;6685.832854178684;6784.76253331131;6840.897386539305;6909.136357955255;7731.884310610254;8695.956520217358;8744.956275218838;9003.909960900308;9016.729498115066 02:58:46 INFO - PROCESS | 20890 | |3;mootools.html;1350.2371160294433;1374.9381277842497;1476.291380137534;1672.70727622666;1683.0070258547455;5848.239728835256;5992.430719081691;6687.1975362956455;6847.931520684791;6922.065521154643;6460.838479038026;6625.569337993039;6645.30224326446;6652.800415987516;6711.228208755982;2112.2501511963264;2132.744070711509;2147.3128598848375;2147.967780483294;2151.3330867431146;2064.5045189154644;2067.720857684216;2073.5023594337326;2077.439091445309;2087.144270848952;2076.3770868739393;2082.0214499185436;2082.4585607741947;2082.8437867159946;2087.352920594613;2071.5339048713995;2072.3057775645175;2073.1292857000094;2073.346895727856;2077.044559502623;2049.4876280929766;2078.9792102078936;2083.1354987680093;2098.517341011561;2099.4436474334316;6915.757948471779;6993.720251189946;7011.298870112999;7029.051078104441;7043.823904402379;3932.8820135395986;3955.980220098881;4015.13674559971;4016.3975403689387;4020.1155745736182;2655.216711070239;2676.51822671919;2687.3550347916357;2758.3379988802744;2762.129929072336;810.0239211749886;819.4509678515409;835.8495470815251;862;869.3219288954625;9348.485833279236;9350.345475816628;9379.24966002725;9420.858687119699;9436.150746432786;3728.1984373359314;3747.1194269346684;3811.561670407883;3828.1195325075387;3839.0978120141745;8068.99137607799;8079.030516338077;8094.392920530984;8102.959485202537;8104.635291411901;4142.71001029931;4165.708400412002;4185.518665353523;4191.140816132685;4207.579242075829;3251.8374081296315;3330.984049864766;3662.7802331860175;3847.03824043989;3858.2090671412293;3269.395161895057;3271.9509207361907;3299.6535363786456;3304.1574398528223;3309.569755931762;1046.6546039806844;1055.5408397347178;1059.8781140168978;1067.658349328223;1072.951717172729;1038.4288641247283;1087.9728006799894;1140.7832511822728;1175.5650409348596;1180.6458062581191;6248.094026366151;6278.183836101278;6297.653629050446;6302.936970630327;6320.399562041599;394.35522920025966;397.7156333221703;398.5735263268333;399.89402808255835;400.49737579338324;5085.466026067284;5105.668131571436;5112.156494178419;5135.435102138762;5150.201718733528;7885.48744331628;7966.322862556747;8206.056303525052;8321.625526851307;8327.084020757711;8136.430449868571;8147.633356498972;8151.592420378957;8153.306968907709;8182.4681395709085;6468.3855033771715;6554.836129096715;6566.146400967844;6578.506612004119;6633.701483433354;6168.691565421621;6208.099825525183;6217.253929528486;6231.719572619152;6253.218347706536;7236.348728614239;7386.96306518464;7480.177180510248;7539.509931854412;7548.811279718051;7352.70589176427;7454.701811927679;7542.509736867086;7622.69509219625;7638.961805190938;5292.20616907467;5460.91808622863;5876.324222714443;5917.698106416754;5961.105834124916;6057.727402266997;6167.444929956326;6184.8763024738355;6206.410391012847;6208;5836.270466191726;6022.5784195105925;6075.574709770273;6152.138700581832;6197.81406557804;6005.039193728982;6035.818925432244;6134.693265336626;6208;6253.030780229072;5994.220751302303;6232.657203853832;6236.314005459487;6240.251169859646;6242.781502647385;5654.264945557051;5663.66018038919;5664.518515926193;5667.121596152603;5673.035583950656;5569.415211402907;5661.886762264814;5665.3201615806365;5666.34836993751;5683.545316374597 02:58:46 INFO - PROCESS | 20890 | |4;prototype.html;290.7238123782407;293.24928183849346;299.8096208907344;303.40835371026503;311.61359913707;5407.972960135194;5591.608587398879;5651.095824668059;5672.631278966869;5701.116326969316;5381.919271210925;5540.944590554093;5558.610897237195;5578.63738856975;5583.413741557139;4280.0797828466875;4314.590113939171;4315.482142142947;4322.0491491871735;4322.675799315049;4236.830526778926;4298.742075475466;4322.8703138905885;4335.306350983843;4336.241157797389;4058.269511487931;4189.581041895816;4273.764942928137;4289.935650965238;4297.613214810666;4171.728837625545;4188.392683060954;4188.874333769976;4190.036291652937;4195.349720793282;3663.1208509957687;3674.4855720199193;3675.9264814703556;3676.6690997810324;3689;5396.676199428047;5429.891402171935;5431.755570999315;5434.402215756264;5440.3743569489225;4829.758512074382;4921.852344429637;4923.679960802537;4930.580900623451;4937.580305674022;5945.375735547792;5945.821625351203;5949.524038076944;5952;5980.491658209014;4005.0788318686573;4006.3389540725743;4008;4014.658754005913;4030.1738143680477;6102.328743838174;6179.134921111048;6189.752409903598;6200.503959683215;6207.906881396738;4047.1905618876344;4116.0533077392365;4125.443065186221;4125.66994640428;4139.068709540329;4185.979070104691;4186.392973018956;4187.5184353799705;4189.036521600049;4195.370694395804;4832.251001094765;4853.757312134379;4854.8786280342565;4865.343178670834;4877.341558889575;5871.677057761779;5893.027650437715;5899.646021238739;5905.4685078343155;5925.525957923356;1384.764590019699;1400.3838311143268;1470.0738534723057;1487.367868655817;1488.1220080152546;966.2704657983318;980.6763767956558;983.3165949664914;988.2439933450916;988.9901100989042;5036.773345199402;5056.873578160502;5060.468650791614;5062.974685126551;5075.8984820303385;5998.4601385875485;6058.697065146725;6069.605475644069;6083.11794789753;6097.878042439126;5121.667091639031;5122.641415100908;5131.87170320745;5143.17709166539;5145.382554093533;3229.978607784827;3253.4794432890626;3256.234784825564;3270.9345813083605;3306.8677252909615;5671.858203544862;5731.140328950691;5743.655380677173;5745.626534275259;5752.913706294409;6236.968815155986;6239.500839932794;6243.8126856194385;6244.625322480666;6253.499720022387;5638.7462564185535;5736.971315143398;5757.798477053283;5759.568032397503;5766.654000759968;6080.422359875982;6080.787172448943;6083.209182806207;6084.665343406155;6092.69536523181;5914.112883067574;5940.495057920125;5941.257342832146;5952.255968003999;5958.314793798769;5702.572307077069;5712.971435142797;5724.4561766632105;5730.71346432685;5753.482186603226;4053.4325194473386;4127.566605506378;4129.834806607702;4131.111810960658;4131.235721391552;6034.426729460694;6046.84882877914;6057.242844644419;6069.666168360783;6079.878402431838;5834.766609335579;5858.004139296245;5884.235049443545;5911.970440147772;5924.259467566554;5898.321693005188;5908.793192238251;5911.527077833849;5922.851928701817;5925.970370148121;5640.492355688008;5724.370319264961;5759.884802303846;5773.711314434346;5774.133879918046;5993.340732519507;6005.819825405245;6006.549508786771;6026.306974697791;6062.302835174011;5836;5862.062070068769;5880.441358070976;5886.175935368966;5891.204687367322 02:58:46 INFO - PROCESS | 20890 | |5;yui.html;736.3924762071292;750.5684231566848;759.2673070486983;766.6166916541729;777.6733771815835;10562.788744225121;10667.78664426711;10676;10708.357498550093;10749.462526873645;8631.395802293826;10276.551927037375;10346.741331466717;10380.688579342614;10395.896041039587;745.4967896669754;757.1935888278965;758.0221514246615;758.9013428254319;762.2644148396796;749.8725216713144;756.5233902641328;756.8448468064033;757.1444267977178;759.1118391481951;780.5901901501728;787.582581231948;791.4341246009102;792.6948124971899;796.9521828690268;771.7761849063793;776.8990031295924;779.3180966654178;784.3489903380181;784.7606480023591;583.5856541855288;585.8564651660328;586.4047991288845;588.6409290332894;590.0058401593286;9590.040995900425;9645.228381729445;9648.421094734338;9653.082957119062;9657.903420965771;9762.511874406322;10501;10529.894701052968;10550.68347949555;10601.575936962512;9150;9188.356815022951;9347.626094956262;9411.670591529264;9411.90588094124;3224.6130464344196;3264.9510257345923;3268.9346213075605;3284.458064419368;3291.6214635317006;37278.44082338767;38071.04822379463;38163.23673526542;38419.42370864439;41059.58940410588;8793.868091978626;8903.243224325875;8961.641534338683;9020.233280171258;9071;14850.108993460426;14912.62718432048;14923.701525969636;14993.625159370884;15021.624459388602;6064.636121832704;6149.13912052313;6195.535334849904;6205.937940620626;6263.404976527223;3666.9816650916573;3703.574088979748;3725;3781.149241420713;3839.155385815116;2550.6174073889065;2568.8073394495486;2580.2001379572393;2589.3008887600618;2589.8705064746687;468.65319663449486;470.6916969385058;472;474.8456751555758;481.0115213236832;430.9396684464177;435.73420213669635;477.98566043018764;540.3191978107612;572.6134858970179;7250.456215783837;7544.811379715441;7556.886646700304;7590.354819840375;7595.468317217742;526.7129414469124;550.4605486623052;559.1445089013815;560.4983539731999;565.1663795901095;3580.7672501287334;3612.8012959286966;3642.2715456908195;3689.7417180797624;3776.3957766757185;46248.537514625095;46273.76863115663;46659.76670116628;46700;46707.29939050917;42431;42454.15091698149;42826.57173428288;43283.350749738776;43329.35005974913;34559.4816077759;37326.813365933;45166.548334516236;45183.09633807371;45509.54490455119;7131.500794944304;7495.812604684927;7669.309762121213;7770.145284018867;7884.250996155356;30257.394852103276;30486;30706;30718.692813071582;30953.8452307746;34503.65496345004;34652.48021279633;36555.451668224465;38122.618773811904;38128.23743525059;9936.403815771077;9942.801143977225;10048.799024019332;10055.547500362647;10262.897371026194;10675.839862402225;10693.839592406275;10701.51843167075;10763.750696489604;10851.782964340828;9571.473568953774;9575.904240957501;9609.615615375307;9624.51877406141;9628;9828.312018158946;9843.458609776531;9891.258155638212;9991.100800927952;10039.196864250696;9374.390664606779;9663.661771838233;9703.320767546204;9762.316637835567;9896.950515247378;7598.202188770099;8191.467554608931;8237.705531201911;8243.093259741543;8343.624536895975;7890.921090789018;8080.878786818085;8217.137200593852;8223.79440513968;8248.216419440143 02:58:46 INFO - PROCESS | 20890 | __end_tp_report 02:58:46 INFO - PROCESS | 20890 | __start_cc_report 02:58:46 INFO - PROCESS | 20890 | _x_x_mozilla_cycle_collect,343 02:58:46 INFO - PROCESS | 20890 | __end_cc_report 02:58:46 INFO - PROCESS | 20890 | __startTimestamp1453201126585__endTimestamp 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | ------- Summary: start ------- 02:58:46 INFO - PROCESS | 20890 | Number of tests: 6 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#0] dojo.html Cycles:165 Average:4440.99 Median:4606.88 stddev:563.84 (12.2%) stddev-sans-first:546.71 02:58:46 INFO - PROCESS | 20890 | Values: 2597.5 2605.3 2638.6 2641.3 2658.2 4409.8 4430.0 4447.4 4451.2 4474.0 4434.7 4550.8 4556.7 4585.3 4606.9 26.6 4158.1 4182.2 4228.5 4271.1 3969.3 4135.2 4158.1 4175.1 4202.3 4227.2 4243.5 4247.3 4248.0 4271.3 4206.1 4212.3 4237.5 4261.4 4282.3 4074.8 4157.3 4166.2 4217.4 4232.7 4432.5 4438.4 4439.6 4453.4 4477.9 4725.4 4817.6 4820.7 4832.6 4837.8 4768.6 4815.7 4864.6 4873.8 4902.8 4487.1 4497.3 4501.7 4509.2 4522.1 4780.5 4809.4 4908.2 4909.1 4954.6 4719.9 4743.8 4762.4 4771.9 4823.5 4893.6 4897.3 4898.3 4915.3 4915.3 4666.4 4758.7 4766.8 4852.8 4867.4 4591.7 4617.3 4621.6 4624.2 4625.4 3974.9 3987.2 4020.1 4049.6 4058.3 3574.8 3577.0 3584.5 3598.3 3616.5 4071.8 4172.5 4186.4 4224.4 4246.9 4791.1 4813.5 4845.4 4850.5 4882.8 4256.2 4258.7 4282.3 4289.4 4318.2 4234.7 4299.6 4362.4 4376.4 4383.3 4550.6 4612.8 4651.4 4651.7 4699.5 4850.0 4857.7 4874.0 4888.8 4943.1 4458.1 4507.5 4629.9 4650.0 4687.2 4754.4 4755.6 4776.4 4787.1 4812.6 4827.0 4829.3 4839.2 4847.3 4873.5 4585.4 4599.2 4669.2 4675.8 4699.2 4678.2 4695.4 4703.8 4707.9 4718.8 4556.1 4599.4 4612.9 4629.0 4660.2 4615.7 4624.7 4676.9 4697.4 4772.0 4612.0 4631.4 4635.1 4642.9 4669.9 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#1] ext.html Cycles:180 Average:37389.41 Median:3433.68 stddev:54906.14 (1599.0%) stddev-sans-first:54990.20 02:58:46 INFO - PROCESS | 20890 | Values: 474.2 498.4 508.9 510.1 513.0 32531.7 33020.8 33146.5 33224.7 33321.0 36324.6 36903.4 36915.0 36961.6 37045.6 7656.4 7840.5 7848.0 7849.1 7874.0 7595.2 7714.8 7715.0 7739.2 7753.1 7895.7 7937.8 7955.9 7981.6 8000.6 7871.1 7899.7 7909.7 7917.9 7947.5 7809.8 7900.2 7926.2 7931.2 7961.6 35953.6 36552.6 36776.4 36837.4 36849.3 2900.2 3022.7 3075.5 3233.9 3241.9 27879.7 28121.7 28319.0 28495.4 28717.0 3413.1 3454.3 3472.0 3524.7 3554.6 156227.2 156531.2 156540.0 156632.0 156906.2 46853.0 47747.0 55655.4 55734.0 57657.1 51155.0 51274.2 51315.5 51412.0 51451.2 14589.6 14647.6 14767.6 14783.9 14795.9 11067.7 11279.9 11301.5 11317.7 11443.8 19230.7 19475.1 19603.0 19625.8 19628.7 7778.9 7781.6 7918.3 7939.7 7973.6 846.3 876.8 889.2 918.8 1006.7 26155.5 26215.6 26224.7 26268.9 26319.3 956.8 976.0 1027.4 1041.9 1085.4 12752.9 12761.4 12765.8 12767.0 15176.5 224683.0 226252.0 227159.0 227719.0 228228.0 43581.1 43749.0 43946.8 44069.0 44265.3 1222.5 1231.1 1234.7 1239.0 1239.9 25920.4 26558.3 27870.3 28261.4 28769.4 39926.0 40097.4 40425.4 40578.2 40593.4 239064.0 241019.0 242175.0 242294.0 242587.0 29340.1 39827.4 40201.0 40336.4 40678.4 35478.1 36688.1 37277.0 39005.8 40170.4 32548.3 33008.3 33445.3 33691.8 33883.8 35035.6 36788.3 36885.4 37298.3 37585.6 31296.8 31344.5 31412.2 31664.2 31783.2 27903.2 29954.3 30621.4 30741.2 30765.2 20759.3 20848.7 20900.4 21077.5 21089.0 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#2] jquery.html Cycles:180 Average:23551.40 Median:5022.09 stddev:74864.70 (1490.7%) stddev-sans-first:75054.42 02:58:46 INFO - PROCESS | 20890 | Values: 336.3 337.6 338.5 341.3 345.4 14012.7 14323.4 14906.6 15653.8 15899.2 13719.5 13875.0 14703.2 14711.7 14831.5 4467.8 4685.5 5019.7 5021.9 5033.7 4774.5 4880.2 4968.5 4972.5 4973.2 4935.6 4979.1 5163.4 5361.4 5385.2 5063.8 5207.1 5335.7 5347.6 5357.8 4995.1 5014.9 5018.3 5022.2 5029.6 11013.1 11703.5 11733.4 11853.1 11855.7 1748.8 1769.5 1901.8 1908.9 2006.7 11729.8 11777.0 11884.6 12059.5 12109.9 1641.2 1668.2 1682.8 1713.3 1714.6 49209.8 50510.7 50702.7 50958.2 51017.2 8444.3 8985.4 9200.5 9214.1 9245.1 11562.2 11567.4 11601.4 11683.6 11686.4 6726.8 6969.0 7019.5 7051.3 7082.7 6841.1 6911.2 6962.7 7070.0 7134.6 3974.2 4054.4 4062.8 4073.1 4073.9 1638.7 1709.1 1737.8 1801.3 1809.5 381.0 824.7 836.2 854.7 865.0 9048.3 9268.0 9442.8 9506.4 9695.0 384.1 417.1 427.7 427.8 435.7 5051.6 5192.9 5241.2 5246.9 5263.5 427756.0 438139.0 469956.0 473921.0 475632.0 65040.0 66051.3 67198.0 67396.7 68221.0 452.4 458.0 458.7 459.4 461.2 8974.4 9116.5 9188.4 9245.9 9268.9 28095.3 28289.6 28366.7 28553.4 28695.3 40233.6 40298.6 40317.6 40396.2 40479.8 6325.1 6342.1 6355.0 6627.8 6649.8 8332.8 9315.6 9423.2 9557.4 9625.8 8159.0 8396.7 8446.5 8484.4 8648.7 8335.5 8809.4 8937.9 8970.5 9137.1 8288.3 8627.6 8662.5 8825.2 8876.6 6628.6 6685.8 6784.8 6840.9 6909.1 7731.9 8696.0 8745.0 9003.9 9016.7 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#3] mootools.html Cycles:180 Average:4763.29 Median:5678.29 stddev:2462.56 (43.4%) stddev-sans-first:2456.11 02:58:46 INFO - PROCESS | 20890 | Values: 1350.2 1374.9 1476.3 1672.7 1683.0 5848.2 5992.4 6687.2 6847.9 6922.1 6460.8 6625.6 6645.3 6652.8 6711.2 2112.3 2132.7 2147.3 2148.0 2151.3 2064.5 2067.7 2073.5 2077.4 2087.1 2076.4 2082.0 2082.5 2082.8 2087.4 2071.5 2072.3 2073.1 2073.3 2077.0 2049.5 2079.0 2083.1 2098.5 2099.4 6915.8 6993.7 7011.3 7029.1 7043.8 3932.9 3956.0 4015.1 4016.4 4020.1 2655.2 2676.5 2687.4 2758.3 2762.1 810.0 819.5 835.8 862.0 869.3 9348.5 9350.3 9379.2 9420.9 9436.2 3728.2 3747.1 3811.6 3828.1 3839.1 8069.0 8079.0 8094.4 8103.0 8104.6 4142.7 4165.7 4185.5 4191.1 4207.6 3251.8 3331.0 3662.8 3847.0 3858.2 3269.4 3272.0 3299.7 3304.2 3309.6 1046.7 1055.5 1059.9 1067.7 1073.0 1038.4 1088.0 1140.8 1175.6 1180.6 6248.1 6278.2 6297.7 6302.9 6320.4 394.4 397.7 398.6 399.9 400.5 5085.5 5105.7 5112.2 5135.4 5150.2 7885.5 7966.3 8206.1 8321.6 8327.1 8136.4 8147.6 8151.6 8153.3 8182.5 6468.4 6554.8 6566.1 6578.5 6633.7 6168.7 6208.1 6217.3 6231.7 6253.2 7236.3 7387.0 7480.2 7539.5 7548.8 7352.7 7454.7 7542.5 7622.7 7639.0 5292.2 5460.9 5876.3 5917.7 5961.1 6057.7 6167.4 6184.9 6206.4 6208.0 5836.3 6022.6 6075.6 6152.1 6197.8 6005.0 6035.8 6134.7 6208.0 6253.0 5994.2 6232.7 6236.3 6240.3 6242.8 5654.3 5663.7 5664.5 5667.1 5673.0 5569.4 5661.9 5665.3 5666.3 5683.5 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#4] prototype.html Cycles:180 Average:4851.70 Median:5587.51 stddev:1454.14 (26.0%) stddev-sans-first:1417.35 02:58:46 INFO - PROCESS | 20890 | Values: 290.7 293.2 299.8 303.4 311.6 5408.0 5591.6 5651.1 5672.6 5701.1 5381.9 5540.9 5558.6 5578.6 5583.4 4280.1 4314.6 4315.5 4322.0 4322.7 4236.8 4298.7 4322.9 4335.3 4336.2 4058.3 4189.6 4273.8 4289.9 4297.6 4171.7 4188.4 4188.9 4190.0 4195.3 3663.1 3674.5 3675.9 3676.7 3689.0 5396.7 5429.9 5431.8 5434.4 5440.4 4829.8 4921.9 4923.7 4930.6 4937.6 5945.4 5945.8 5949.5 5952.0 5980.5 4005.1 4006.3 4008.0 4014.7 4030.2 6102.3 6179.1 6189.8 6200.5 6207.9 4047.2 4116.1 4125.4 4125.7 4139.1 4186.0 4186.4 4187.5 4189.0 4195.4 4832.3 4853.8 4854.9 4865.3 4877.3 5871.7 5893.0 5899.6 5905.5 5925.5 1384.8 1400.4 1470.1 1487.4 1488.1 966.3 980.7 983.3 988.2 989.0 5036.8 5056.9 5060.5 5063.0 5075.9 5998.5 6058.7 6069.6 6083.1 6097.9 5121.7 5122.6 5131.9 5143.2 5145.4 3230.0 3253.5 3256.2 3270.9 3306.9 5671.9 5731.1 5743.7 5745.6 5752.9 6237.0 6239.5 6243.8 6244.6 6253.5 5638.7 5737.0 5757.8 5759.6 5766.7 6080.4 6080.8 6083.2 6084.7 6092.7 5914.1 5940.5 5941.3 5952.3 5958.3 5702.6 5713.0 5724.5 5730.7 5753.5 4053.4 4127.6 4129.8 4131.1 4131.2 6034.4 6046.8 6057.2 6069.7 6079.9 5834.8 5858.0 5884.2 5912.0 5924.3 5898.3 5908.8 5911.5 5922.9 5926.0 5640.5 5724.4 5759.9 5773.7 5774.1 5993.3 6005.8 6006.5 6026.3 6062.3 5836.0 5862.1 5880.4 5886.2 5891.2 02:58:46 INFO - PROCESS | 20890 | 02:58:46 INFO - PROCESS | 20890 | [#5] yui.html Cycles:180 Average:11587.57 Median:568.89 stddev:13277.51 (2333.9%) stddev-sans-first:13289.75 02:58:46 INFO - PROCESS | 20890 | Values: 736.4 750.6 759.3 766.6 777.7 10562.8 10667.8 10676.0 10708.4 10749.5 8631.4 10276.6 10346.7 10380.7 10395.9 745.5 757.2 758.0 758.9 762.3 749.9 756.5 756.8 757.1 759.1 780.6 787.6 791.4 792.7 797.0 771.8 776.9 779.3 784.3 784.8 583.6 585.9 586.4 588.6 590.0 9590.0 9645.2 9648.4 9653.1 9657.9 9762.5 10501.0 10529.9 10550.7 10601.6 9150.0 9188.4 9347.6 9411.7 9411.9 3224.6 3265.0 3268.9 3284.5 3291.6 37278.4 38071.0 38163.2 38419.4 41059.6 8793.9 8903.2 8961.6 9020.2 9071.0 14850.1 14912.6 14923.7 14993.6 15021.6 6064.6 6149.1 6195.5 6205.9 6263.4 3667.0 3703.6 3725.0 3781.1 3839.2 2550.6 2568.8 2580.2 2589.3 2589.9 468.7 470.7 472.0 474.8 481.0 430.9 435.7 478.0 540.3 572.6 7250.5 7544.8 7556.9 7590.4 7595.5 526.7 550.5 559.1 560.5 565.2 3580.8 3612.8 3642.3 3689.7 3776.4 46248.5 46273.8 46659.8 46700.0 46707.3 42431.0 42454.2 42826.6 43283.4 43329.4 34559.5 37326.8 45166.5 45183.1 45509.5 7131.5 7495.8 7669.3 7770.1 7884.3 30257.4 30486.0 30706.0 30718.7 30953.8 34503.7 34652.5 36555.5 38122.6 38128.2 9936.4 9942.8 10048.8 10055.5 10262.9 10675.8 10693.8 10701.5 10763.8 10851.8 9571.5 9575.9 9609.6 9624.5 9628.0 9828.3 9843.5 9891.3 9991.1 10039.2 9374.4 9663.7 9703.3 9762.3 9897.0 7598.2 8191.5 8237.7 8243.1 8343.6 7890.9 8080.9 8217.1 8223.8 8248.2 02:58:46 INFO - PROCESS | 20890 | -------- Summary: end -------- 02:58:46 INFO - PROCESS | 20890 | 02:58:47 INFO - TEST-INFO | 20890: exit 0 02:58:47 INFO - TEST-OK | dromaeo_css | took 1112986ms 02:58:47 INFO - TEST-START | kraken 02:58:47 INFO - operating with platform_type : linux_ 02:58:47 INFO - Initialising browser for kraken test... 02:58:47 INFO - TEST-INFO | started process 21129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAMMTJ/profile http://localhost:45853/getInfo.html) 02:58:50 INFO - PROCESS | 21129 | 02:58:50 INFO - PROCESS | 21129 | (process:21198): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:58:51 INFO - PROCESS | 21129 | __metrics Screen width/height:1600/1200 02:58:51 INFO - PROCESS | 21129 | colorDepth:24 02:58:51 INFO - PROCESS | 21129 | Browser inner width/height: 1024/697 02:58:51 INFO - PROCESS | 21129 | __metrics 02:58:52 INFO - PROCESS | 21129 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:58:52 INFO - TEST-INFO | 21129: exit 0 02:58:52 INFO - Browser initialized. 02:58:52 INFO - Running cycle 1/1 for kraken test... 02:58:52 INFO - TEST-INFO | started process 21246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAMMTJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:53 INFO - PROCESS | 21246 | -- checkerboarding starts below -- 02:58:53 INFO - PROCESS | 21246 | RENDERTRACE 0.035419 rect red 0 0 10 10 // viewport 02:58:53 INFO - PROCESS | 21246 | RENDERTRACE 70.0374 rect brown 0 0 10 10 // page 02:58:53 INFO - PROCESS | 21246 | RENDERTRACE 70.056 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:58:53 INFO - PROCESS | 21246 | Checkerboarded for 1 frames (76.5698 ms), 100 peak, 1 severity. 02:58:54 INFO - PROCESS | 21246 | 02:58:54 INFO - PROCESS | 21246 | (process:21305): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:59:04 INFO - PROCESS | 21246 | RSS: Main: 150024192 02:59:04 INFO - PROCESS | 21246 | 02:59:07 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45853/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:08 INFO - PROCESS | 21246 | RSS: Main: 149041152 02:59:08 INFO - PROCESS | 21246 | 02:59:10 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45853/tests/kraken/driver.html?testName=audio-dft) 02:59:11 INFO - PROCESS | 21246 | RSS: Main: 153231360 02:59:11 INFO - PROCESS | 21246 | 02:59:14 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45853/tests/kraken/driver.html?testName=audio-fft) 02:59:15 INFO - PROCESS | 21246 | RSS: Main: 147218432 02:59:15 INFO - PROCESS | 21246 | 02:59:17 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45853/tests/kraken/driver.html?testName=audio-oscillator) 02:59:17 INFO - PROCESS | 21246 | RSS: Main: 148533248 02:59:17 INFO - PROCESS | 21246 | 02:59:19 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:20 INFO - PROCESS | 21246 | RSS: Main: 148271104 02:59:20 INFO - PROCESS | 21246 | 02:59:23 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45853/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:24 INFO - PROCESS | 21246 | RSS: Main: 149856256 02:59:24 INFO - PROCESS | 21246 | 02:59:27 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45853/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:28 INFO - PROCESS | 21246 | RSS: Main: 150122496 02:59:28 INFO - PROCESS | 21246 | 02:59:31 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45853/tests/kraken/driver.html?testName=json-parse-financial) 02:59:31 INFO - PROCESS | 21246 | RSS: Main: 150216704 02:59:31 INFO - PROCESS | 21246 | 02:59:33 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:34 INFO - PROCESS | 21246 | RSS: Main: 149864448 02:59:34 INFO - PROCESS | 21246 | 02:59:36 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:36 INFO - PROCESS | 21246 | RSS: Main: 149774336 02:59:36 INFO - PROCESS | 21246 | 02:59:38 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:39 INFO - PROCESS | 21246 | RSS: Main: 149295104 02:59:39 INFO - PROCESS | 21246 | 02:59:41 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:42 INFO - PROCESS | 21246 | RSS: Main: 149901312 02:59:42 INFO - PROCESS | 21246 | 02:59:45 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:45 INFO - PROCESS | 21246 | RSS: Main: 150126592 02:59:45 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | Cycle 1(1): loaded http://localhost:45853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45853/tests/kraken/driver.html?testName=ai-astar) 02:59:47 INFO - PROCESS | 21246 | RSS: Main: 149336064 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | __start_tp_report 02:59:47 INFO - PROCESS | 21246 | _x_x_mozilla_page_load 02:59:47 INFO - PROCESS | 21246 | _x_x_mozilla_page_load_details 02:59:47 INFO - PROCESS | 21246 | |i|pagename|runs| 02:59:47 INFO - PROCESS | 21246 | |0;ai-astar;117;109;115;115;115;128;114;116;115;113 02:59:47 INFO - PROCESS | 21246 | |1;audio-beat-detection;156;131;153;165;143;155;158;138;169;149 02:59:47 INFO - PROCESS | 21246 | |2;audio-dft;164;167;165;162;162;165;171;165;163;161 02:59:47 INFO - PROCESS | 21246 | |3;audio-fft;73;73;74;158;73;73;73;73;149;73 02:59:47 INFO - PROCESS | 21246 | |4;audio-oscillator;97;97;148;97;98;97;131;98;98;131 02:59:47 INFO - PROCESS | 21246 | |5;imaging-gaussian-blur;111;110;110;111;110;110;111;110;110;110 02:59:47 INFO - PROCESS | 21246 | |6;imaging-darkroom;149;147;152;149;149;148;148;149;148;148 02:59:47 INFO - PROCESS | 21246 | |7;imaging-desaturate;96;96;97;96;97;96;97;97;96;96 02:59:47 INFO - PROCESS | 21246 | |8;json-parse-financial;79;74;77;72;71;71;72;72;73;70 02:59:47 INFO - PROCESS | 21246 | |9;json-stringify-tinderbox;66;67;68;67;67;68;67;68;68;70 02:59:47 INFO - PROCESS | 21246 | |10;stanford-crypto-aes;84;82;84;88;85;84;86;84;86;83 02:59:47 INFO - PROCESS | 21246 | |11;stanford-crypto-ccm;124;120;123;118;120;123;124;119;127;131 02:59:47 INFO - PROCESS | 21246 | |12;stanford-crypto-pbkdf2;138;155;145;149;153;149;156;151;140;137 02:59:47 INFO - PROCESS | 21246 | |13;stanford-crypto-sha256-iterative;73;73;72;72;70;70;71;71;71;71 02:59:47 INFO - PROCESS | 21246 | __end_tp_report 02:59:47 INFO - PROCESS | 21246 | __start_cc_report 02:59:47 INFO - PROCESS | 21246 | _x_x_mozilla_cycle_collect,804 02:59:47 INFO - PROCESS | 21246 | __end_cc_report 02:59:47 INFO - PROCESS | 21246 | __startTimestamp1453201187771__endTimestamp 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | ------- Summary: start ------- 02:59:47 INFO - PROCESS | 21246 | Number of tests: 14 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:4.83 (4.2%) stddev-sans-first:5.10 02:59:47 INFO - PROCESS | 21246 | Values: 117.0 109.0 115.0 115.0 115.0 128.0 114.0 116.0 115.0 113.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:11.77 (7.6%) stddev-sans-first:12.38 02:59:47 INFO - PROCESS | 21246 | Values: 156.0 131.0 153.0 165.0 143.0 155.0 158.0 138.0 169.0 149.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#2] audio-dft Cycles:10 Average:164.50 Median:165.00 stddev:2.92 (1.8%) stddev-sans-first:3.09 02:59:47 INFO - PROCESS | 21246 | Values: 164.0 167.0 165.0 162.0 162.0 165.0 171.0 165.0 163.0 161.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#3] audio-fft Cycles:10 Average:89.20 Median:73.00 stddev:33.96 (46.5%) stddev-sans-first:35.51 02:59:47 INFO - PROCESS | 21246 | Values: 73.0 73.0 74.0 158.0 73.0 73.0 73.0 73.0 149.0 73.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:97.00 stddev:19.52 (20.1%) stddev-sans-first:20.19 02:59:47 INFO - PROCESS | 21246 | Values: 97.0 97.0 148.0 97.0 98.0 97.0 131.0 98.0 98.0 131.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:59:47 INFO - PROCESS | 21246 | Values: 111.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.34 (0.9%) stddev-sans-first:1.41 02:59:47 INFO - PROCESS | 21246 | Values: 149.0 147.0 152.0 149.0 149.0 148.0 148.0 149.0 148.0 148.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:59:47 INFO - PROCESS | 21246 | Values: 96.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:72.50 stddev:2.85 (3.9%) stddev-sans-first:2.07 02:59:47 INFO - PROCESS | 21246 | Values: 79.0 74.0 77.0 72.0 71.0 71.0 72.0 72.0 73.0 70.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 02:59:47 INFO - PROCESS | 21246 | Values: 66.0 67.0 68.0 67.0 67.0 68.0 67.0 68.0 68.0 70.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.71 (2.0%) stddev-sans-first:1.80 02:59:47 INFO - PROCESS | 21246 | Values: 84.0 82.0 84.0 88.0 85.0 84.0 86.0 84.0 86.0 83.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:3.96 (3.2%) stddev-sans-first:4.18 02:59:47 INFO - PROCESS | 21246 | Values: 124.0 120.0 123.0 118.0 120.0 123.0 124.0 119.0 127.0 131.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:150.00 stddev:6.98 (4.7%) stddev-sans-first:6.54 02:59:47 INFO - PROCESS | 21246 | Values: 138.0 155.0 145.0 149.0 153.0 149.0 156.0 151.0 140.0 137.0 02:59:47 INFO - PROCESS | 21246 | 02:59:47 INFO - PROCESS | 21246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.07 (1.5%) stddev-sans-first:0.97 02:59:47 INFO - PROCESS | 21246 | Values: 73.0 73.0 72.0 72.0 70.0 70.0 71.0 71.0 71.0 71.0 02:59:47 INFO - PROCESS | 21246 | -------- Summary: end -------- 02:59:47 INFO - PROCESS | 21246 | 02:59:48 INFO - TEST-INFO | 21246: exit 0 02:59:48 INFO - TEST-OK | kraken | took 61471ms 02:59:48 INFO - TEST-START | v8_7 02:59:48 INFO - operating with platform_type : linux_ 02:59:48 INFO - Initialising browser for v8_7 test... 02:59:48 INFO - TEST-INFO | started process 21532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JmG5f/profile http://localhost:45853/getInfo.html) 02:59:52 INFO - PROCESS | 21532 | 02:59:52 INFO - PROCESS | 21532 | (process:21604): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:59:53 INFO - PROCESS | 21532 | __metrics Screen width/height:1600/1200 02:59:53 INFO - PROCESS | 21532 | colorDepth:24 02:59:53 INFO - PROCESS | 21532 | Browser inner width/height: 1024/697 02:59:53 INFO - PROCESS | 21532 | __metrics 02:59:53 INFO - PROCESS | 21532 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:59:54 INFO - TEST-INFO | 21532: exit 0 02:59:54 INFO - Browser initialized. 02:59:54 INFO - Running cycle 1/1 for v8_7 test... 02:59:54 INFO - TEST-INFO | started process 21652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_JmG5f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:55 INFO - PROCESS | 21652 | -- checkerboarding starts below -- 02:59:55 INFO - PROCESS | 21652 | RENDERTRACE 0.038335 rect red 0 0 10 10 // viewport 02:59:55 INFO - PROCESS | 21652 | RENDERTRACE 23.8858 rect brown 0 0 10 10 // page 02:59:55 INFO - PROCESS | 21652 | RENDERTRACE 23.9651 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 02:59:55 INFO - PROCESS | 21652 | Checkerboarded for 1 frames (33.235 ms), 100 peak, 1 severity. 02:59:56 INFO - PROCESS | 21652 | 02:59:56 INFO - PROCESS | 21652 | (process:21710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:00:06 INFO - PROCESS | 21652 | RSS: Main: 149659648 03:00:06 INFO - PROCESS | 21652 | 03:00:28 INFO - PROCESS | 21652 | Cycle 1(1): loaded http://localhost:45853/tests/v8_7/run.html (next: http://localhost:45853/tests/v8_7/run.html) 03:00:29 INFO - PROCESS | 21652 | RSS: Main: 145448960 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | __start_tp_report 03:00:29 INFO - PROCESS | 21652 | _x_x_mozilla_page_load 03:00:29 INFO - PROCESS | 21652 | _x_x_mozilla_page_load_details 03:00:29 INFO - PROCESS | 21652 | |i|pagename|runs| 03:00:29 INFO - PROCESS | 21652 | |0;Richards;171.11567419575633 03:00:29 INFO - PROCESS | 21652 | |1;DeltaBlue;187.47656542932134 03:00:29 INFO - PROCESS | 21652 | |2;Encrypt;278.08676307007784 03:00:29 INFO - PROCESS | 21652 | |3;Decrypt;5229.166666666667 03:00:29 INFO - PROCESS | 21652 | |4;RayTrace;1076.4262648008612 03:00:29 INFO - PROCESS | 21652 | |5;Earley;706.7137809187279 03:00:29 INFO - PROCESS | 21652 | |6;Boyer;12243.90243902439 03:00:29 INFO - PROCESS | 21652 | |7;RegExp;43744.68085106383 03:00:29 INFO - PROCESS | 21652 | |8;Splay;666.6666666666666 03:00:29 INFO - PROCESS | 21652 | |9;NavierStokes;4840.579710144928 03:00:29 INFO - PROCESS | 21652 | __end_tp_report 03:00:29 INFO - PROCESS | 21652 | __startTimestamp1453201229217__endTimestamp 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | ------- Summary: start ------- 03:00:29 INFO - PROCESS | 21652 | Number of tests: 10 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#0] Richards Cycles:1 Average:171.12 Median:171.12 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 171.1 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#1] DeltaBlue Cycles:1 Average:187.48 Median:187.48 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 187.5 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 278.1 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 5229.2 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 1076.4 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#5] Earley Cycles:1 Average:706.71 Median:706.71 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 706.7 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 12243.9 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#7] RegExp Cycles:1 Average:43744.68 Median:43744.68 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 43744.7 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#8] Splay Cycles:1 Average:666.67 Median:666.67 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 666.7 03:00:29 INFO - PROCESS | 21652 | 03:00:29 INFO - PROCESS | 21652 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:00:29 INFO - PROCESS | 21652 | Values: 4840.6 03:00:29 INFO - PROCESS | 21652 | -------- Summary: end -------- 03:00:29 INFO - PROCESS | 21652 | 03:00:30 INFO - TEST-INFO | 21652: exit 0 03:00:30 INFO - TEST-OK | v8_7 | took 41482ms 03:00:30 INFO - SUITE-END | took 1215s 03:00:30 INFO - Completed test suite (00:20:16) 03:00:30 INFO - Working with test: dromaeo_css 03:00:30 INFO - Generating results file: dromaeo_css 03:00:30 INFO - Working with test: kraken 03:00:30 INFO - Generating results file: kraken 03:00:30 INFO - javascript benchmark 03:00:30 INFO - Working with test: v8_7 03:00:30 INFO - Generating results file: v8_7 03:00:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 03:00:30 INFO - process_Request line: dromaeo_css 5977.08 graph.html#tests=[[72,132,43]] 03:00:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:30 INFO - process_Request line: kraken 1552.60 graph.html#tests=[[232,132,43]] 03:00:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:00:30 INFO - process_Request line: v8_7 20019.30 graph.html#tests=[[230,132,43]] 03:00:30 INFO - RETURN: dromaeo_css: 5977.08 03:00:30 INFO - RETURN: kraken: 1552.60 03:00:30 INFO - RETURN: v8_7: 20019.30 03:00:30 INFO - javascript benchmark 03:00:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2597.532444160051, 2605.3486628342916, 2638.63059171716, 2641.2604470748197, 2658.242400915739, 4409.845655402066, 4430.047539778947, 4447.4218351614245, 4451.198784218839, 4474.0, 4434.733915965036, 4550.79521421536, 4556.726596404218, 4585.312203169527, 4606.884827879305, 26.588808313321156, 4158.126793373388, 4182.16356728654, 4228.450301460805, 4271.103068355649, 3969.2656858481273, 4135.214309281242, 4158.085221251335, 4175.144095460423, 4202.264603694357, 4227.239096962546, 4243.533211346749, 4247.320428731419, 4247.978760106195, 4271.31658934569, 4206.053637931472, 4212.347086201613, 4237.533871274158, 4261.403403523509, 4282.314829627245, 4074.775887326196, 4157.293260145752, 4166.166766646683, 4217.388478670607, 4232.746035237896, 4432.490263619693, 4438.4451943507065, 4439.644828413751, 4453.376527286183, 4477.865664030084, 4725.432948046257, 4817.56641902227, 4820.662553621248, 4832.565069143759, 4837.806487740486, 4768.642351823592, 4815.66290359675, 4864.635152363587, 4873.829415970459, 4902.779374928136, 4487.147441986045, 4497.257952437811, 4501.662375321864, 4509.1883460977015, 4522.118186953546, 4780.498047704941, 4809.374781278411, 4908.165611845995, 4909.091818013679, 4954.603631709455, 4719.929201061918, 4743.810247590058, 4762.3570817939135, 4771.880702982453, 4823.493533179036, 4893.608511319086, 4897.2654101885, 4898.289747986522, 4915.336429581961, 4915.336429582032, 4666.3700400445505, 4758.690685105457, 4766.785494652749, 4852.805887764521, 4867.440244371872, 4591.678582499259, 4617.2612382018715, 4621.630269578425, 4624.190766615829, 4625.3755742974945, 3974.900627484336, 3987.2224916141654, 4020.075382662004, 4049.5747946465785, 4058.289799285113, 3574.785512869184, 3576.964230357663, 3584.5340105786604, 3598.2803439312243, 3616.4936908832783, 4071.75569465833, 4172.520160181557, 4186.392973018896, 4224.366345048267, 4246.8725938221905, 4791.065742180311, 4813.4945830687975, 4845.370101886802, 4850.490698476679, 4882.780274887638, 4256.212600668886, 4258.701890867672, 4282.314829627245, 4289.399484072233, 4318.157959197926, 4234.6823988201, 4299.591538803808, 4362.411074504965, 4376.365427013129, 4383.273776187357, 4550.567696068868, 4612.7924243409125, 4651.395318608559, 4651.697639653412, 4699.4830568636735, 4850.029994001144, 4857.708537487762, 4874.049560335842, 4888.755562221946, 4943.110240156662, 4458.086092351125, 4507.459104907432, 4629.907401851877, 4650.0, 4687.179743544798, 4754.385088201545, 4755.595774359218, 4776.402949631296, 4787.114383839001, 4812.614990800657, 4827.010462855176, 4829.323894654822, 4839.177339852163, 4847.321375007572, 4873.4882837301575, 4585.449746030497, 4599.218132917479, 4669.159551280802, 4675.76621168947, 4699.201135806853, 4678.204705200193, 4695.413073365829, 4703.835365762182, 4707.8823029423165, 4718.834840780556, 4556.088782243631, 4599.379083823775, 4612.86161415158, 4629.0, 4660.184467718203, 4615.699979501322, 4624.653151013755, 4676.883077922943, 4697.365855609449, 4772.0, 4611.953880461152, 4631.351610774562, 4635.096156249499, 4642.907141857211, 4669.906601868011], "unit": "score", "name": "dojo.html", "value": 4409.957030816668}, {"lowerIsBetter": false, "replicates": [474.2080725188934, 498.3869840096681, 508.88041310292084, 510.09458211674286, 512.95639870611, 32531.67468325316, 33020.834895825545, 33146.50280245795, 33224.66775332246, 33321.00147982239, 36324.636753632454, 36903.44644830329, 36915.0, 36961.63038369615, 37045.629543704556, 7656.3874890008665, 7840.4511684182135, 7847.960760196191, 7849.0581130264445, 7874.0, 7595.240475952416, 7714.8457030859345, 7715.0, 7739.2260773922435, 7753.147153813076, 7895.723649672263, 7937.761867143995, 7955.920440795605, 7981.640826162837, 8000.559969201691, 7871.134175240719, 7899.684012639487, 7909.683612655487, 7917.9208207918045, 7947.483413578099, 7809.765707028798, 7900.170482099355, 7926.167752386032, 7931.206879312081, 7961.562114083723, 35953.64046359529, 36552.624079435016, 36776.448353274725, 36837.447438288444, 36849.26301473982, 2900.216941425824, 3022.667506574275, 3075.5079187330143, 3233.919152021195, 3241.9027429176926, 27879.721202787914, 28121.71878281232, 28319.0, 28495.430091398262, 28717.0, 3413.095529684611, 3454.2573346730574, 3471.9652803471895, 3524.735644826623, 3554.626764189749, 156227.21886390608, 156531.21734391255, 156540.0, 156632.0, 156906.21546892307, 46853.0, 47747.04505909862, 55655.443445565026, 55733.99999999919, 57657.13514297289, 51155.0, 51274.23088653673, 51315.48684513107, 51412.0, 51451.228231576555, 14589.635259118395, 14647.560573182822, 14767.597078277546, 14783.852161478462, 14795.852041479662, 11067.667969960914, 11279.943600281946, 11301.547938082385, 11317.660470185743, 11443.828342574869, 19230.71153932692, 19475.091275462237, 19603.0, 19625.80374196268, 19628.70556941647, 7778.8833167502535, 7781.572013539197, 7918.326942209977, 7939.6824127035425, 7973.60131993398, 846.3356265331685, 876.8114855306139, 889.1508609278123, 918.7703074231442, 1006.6527048168371, 26155.476890462083, 26215.606765898527, 26224.73775262223, 26268.8686556566, 26319.34201644936, 956.8373376526007, 976.0191008037019, 1027.3835698580792, 1041.8749750029892, 1085.3759088523973, 12752.936235318764, 12761.361931903368, 12765.808512872314, 12767.042471814466, 15176.468823591342, 224683.0, 226252.0, 227159.0, 227719.0, 228228.0, 43581.128377432906, 43749.0, 43946.78026609911, 44069.0, 44265.33601995972, 1222.5232159457819, 1231.1135982092878, 1234.697499112723, 1239.0335538280156, 1239.9442025108892, 25920.351991200372, 26558.33604159834, 27870.30324241829, 28261.43477130487, 28769.42461150807, 39926.0, 40097.39853902136, 40425.39361909515, 40578.18843623052, 40593.39109913295, 239064.0, 241019.0, 242175.0, 242294.0, 242587.0, 29340.119796406143, 39827.40258896177, 40201.0, 40336.39495407513, 40678.38982415325, 35478.113047174025, 36688.14774448644, 37277.0, 39005.80497097496, 40170.39744403778, 32548.34903301968, 33008.33983320368, 33445.33109337751, 33691.83154084214, 33883.83058084694, 35035.64964350324, 36788.264234715694, 36885.44671829978, 37298.25403491969, 37585.624143759305, 31296.843515782275, 31344.529832052995, 31412.214694631904, 31664.20839478939, 31783.205419864687, 27903.16290511288, 29954.25114372158, 30621.387572248877, 30741.23146921345, 30765.23086922845, 20759.27342543064, 20848.687269690665, 20900.37298881036, 21077.473063173544, 21089.0], "unit": "score", "name": "ext.html", "value": 16584.891550792385}, {"lowerIsBetter": false, "replicates": [336.25183965676365, 337.60163007650976, 338.46860429126264, 341.30374036964594, 345.366252925881, 14012.719745605094, 14323.355449004794, 14906.627334316647, 15653.84346156538, 15899.205039748023, 13719.519816806414, 13875.0, 14703.19132447715, 14711.705765884675, 14831.480898168566, 4467.843625473101, 4685.461171965217, 5019.723915184663, 5021.949780502185, 5033.6728112672745, 4774.474807771142, 4880.194767863316, 4968.527989840959, 4972.5276098770555, 4973.204287314031, 4935.5804756595735, 4979.128652485819, 5163.432022477525, 5361.437049109846, 5385.165299378603, 5063.822766203202, 5207.062728708831, 5335.7332133393365, 5347.572194224472, 5357.839264822042, 4995.050940321364, 5014.949850501484, 5018.347614810088, 5022.221555658879, 5029.597632189416, 11013.118950483942, 11703.473343699468, 11733.4133293335, 11853.051755859511, 11855.703607409798, 1748.7726595542624, 1769.513383819447, 1901.7622797150357, 1908.8568357373254, 2006.6588679924448, 11729.765404691858, 11777.0, 11884.584039558575, 12059.517619295306, 12109.939450302692, 1641.1794102948527, 1668.2242757118, 1682.7980642323, 1713.3318005977678, 1714.6484970581, 49209.75395123037, 50510.7474462629, 50702.7464862677, 50958.235626465634, 51017.23474147854, 8444.324454043663, 8985.371024028385, 9200.539973001323, 9214.124658157465, 9245.121713437213, 11562.190646654823, 11567.363794991188, 11601.361925094201, 11683.591074312528, 11686.357250351311, 6726.831829204309, 6968.965155174192, 7019.5086343956455, 7051.259617740166, 7082.716691332392, 6841.110655614738, 6911.17065952089, 6962.651867406711, 7070.010198572204, 7134.571925684476, 3974.18529201513, 4054.432379466877, 4062.8171732272117, 4073.103917138225, 4073.8574149905203, 1638.6640738648548, 1709.1283445442666, 1737.800152982398, 1801.3155001099499, 1809.4662074688, 380.99428508572396, 824.7402068348451, 836.1721895323586, 854.747849384433, 865.0, 9048.276137909083, 9267.953660231655, 9442.763930901645, 9506.382085164441, 9694.951525242328, 384.05905531448064, 417.1282020576948, 427.7006095732999, 427.77755567105555, 435.7472665853797, 5051.646384753106, 5192.870178245574, 5241.161414173714, 5246.947530524722, 5263.499967503081, 427756.0, 438139.0, 469956.0, 473921.0, 475632.0, 65040.0, 66051.33948660451, 67198.0, 67396.6630166846, 68220.97668534877, 452.3757215043219, 457.9885502862388, 458.6651744226733, 459.44407267207055, 461.1814030096605, 8974.41666291689, 9116.498592577473, 9188.448693078437, 9245.907540924505, 9268.907310926805, 28095.297617559725, 28289.57565636476, 28366.716332837233, 28553.42893142167, 28695.282617934718, 40233.597664022986, 40298.59701402948, 40317.59682403138, 40396.1920761589, 40479.79760101181, 6325.114483972339, 6342.143810585697, 6355.0, 6627.801165965029, 6649.800505984828, 8332.791680208044, 9315.594102688243, 9423.19902808269, 9557.378770379903, 9625.807483850143, 8158.959205203936, 8396.664133434595, 8446.535440550582, 8484.448510846774, 8648.654053837776, 8335.541545215072, 8809.42738721981, 8937.865932010895, 8970.506622135585, 9137.08629137081, 8288.295494883003, 8627.611757470804, 8662.523561204194, 8825.205731484197, 8876.644934202817, 6628.5691430056895, 6685.832854178684, 6784.76253331131, 6840.897386539305, 6909.136357955255, 7731.884310610254, 8695.956520217358, 8744.956275218838, 9003.909960900308, 9016.729498115066], "unit": "score", "name": "jquery.html", "value": 6805.145912178885}, {"lowerIsBetter": false, "replicates": [1350.2371160294433, 1374.9381277842497, 1476.291380137534, 1672.70727622666, 1683.0070258547455, 5848.239728835256, 5992.430719081691, 6687.1975362956455, 6847.931520684791, 6922.065521154643, 6460.838479038026, 6625.569337993039, 6645.30224326446, 6652.800415987516, 6711.228208755982, 2112.2501511963264, 2132.744070711509, 2147.3128598848375, 2147.967780483294, 2151.3330867431146, 2064.5045189154644, 2067.720857684216, 2073.5023594337326, 2077.439091445309, 2087.144270848952, 2076.3770868739393, 2082.0214499185436, 2082.4585607741947, 2082.8437867159946, 2087.352920594613, 2071.5339048713995, 2072.3057775645175, 2073.1292857000094, 2073.346895727856, 2077.044559502623, 2049.4876280929766, 2078.9792102078936, 2083.1354987680093, 2098.517341011561, 2099.4436474334316, 6915.757948471779, 6993.720251189946, 7011.298870112999, 7029.051078104441, 7043.823904402379, 3932.8820135395986, 3955.980220098881, 4015.13674559971, 4016.3975403689387, 4020.1155745736182, 2655.216711070239, 2676.51822671919, 2687.3550347916357, 2758.3379988802744, 2762.129929072336, 810.0239211749886, 819.4509678515409, 835.8495470815251, 862.0, 869.3219288954625, 9348.485833279236, 9350.345475816628, 9379.24966002725, 9420.858687119699, 9436.150746432786, 3728.1984373359314, 3747.1194269346684, 3811.561670407883, 3828.1195325075387, 3839.0978120141745, 8068.99137607799, 8079.030516338077, 8094.392920530984, 8102.959485202537, 8104.635291411901, 4142.71001029931, 4165.708400412002, 4185.518665353523, 4191.140816132685, 4207.579242075829, 3251.8374081296315, 3330.984049864766, 3662.7802331860175, 3847.03824043989, 3858.2090671412293, 3269.395161895057, 3271.9509207361907, 3299.6535363786456, 3304.1574398528223, 3309.569755931762, 1046.6546039806844, 1055.5408397347178, 1059.8781140168978, 1067.658349328223, 1072.951717172729, 1038.4288641247283, 1087.9728006799894, 1140.7832511822728, 1175.5650409348596, 1180.6458062581191, 6248.094026366151, 6278.183836101278, 6297.653629050446, 6302.936970630327, 6320.399562041599, 394.35522920025966, 397.7156333221703, 398.5735263268333, 399.89402808255835, 400.49737579338324, 5085.466026067284, 5105.668131571436, 5112.156494178419, 5135.435102138762, 5150.201718733528, 7885.48744331628, 7966.322862556747, 8206.056303525052, 8321.625526851307, 8327.084020757711, 8136.430449868571, 8147.633356498972, 8151.592420378957, 8153.306968907709, 8182.4681395709085, 6468.3855033771715, 6554.836129096715, 6566.146400967844, 6578.506612004119, 6633.701483433354, 6168.691565421621, 6208.099825525183, 6217.253929528486, 6231.719572619152, 6253.218347706536, 7236.348728614239, 7386.96306518464, 7480.177180510248, 7539.509931854412, 7548.811279718051, 7352.70589176427, 7454.701811927679, 7542.509736867086, 7622.69509219625, 7638.961805190938, 5292.20616907467, 5460.91808622863, 5876.324222714443, 5917.698106416754, 5961.105834124916, 6057.727402266997, 6167.444929956326, 6184.8763024738355, 6206.410391012847, 6208.0, 5836.270466191726, 6022.5784195105925, 6075.574709770273, 6152.138700581832, 6197.81406557804, 6005.039193728982, 6035.818925432244, 6134.693265336626, 6208.0, 6253.030780229072, 5994.220751302303, 6232.657203853832, 6236.314005459487, 6240.251169859646, 6242.781502647385, 5654.264945557051, 5663.66018038919, 5664.518515926193, 5667.121596152603, 5673.035583950656, 5569.415211402907, 5661.886762264814, 5665.3201615806365, 5666.34836993751, 5683.545316374597], "unit": "score", "name": "mootools.html", "value": 3866.802813551935}, {"lowerIsBetter": false, "replicates": [290.7238123782407, 293.24928183849346, 299.8096208907344, 303.40835371026503, 311.61359913707, 5407.972960135194, 5591.608587398879, 5651.095824668059, 5672.631278966869, 5701.116326969316, 5381.919271210925, 5540.944590554093, 5558.610897237195, 5578.63738856975, 5583.413741557139, 4280.0797828466875, 4314.590113939171, 4315.482142142947, 4322.0491491871735, 4322.675799315049, 4236.830526778926, 4298.742075475466, 4322.8703138905885, 4335.306350983843, 4336.241157797389, 4058.269511487931, 4189.581041895816, 4273.764942928137, 4289.935650965238, 4297.613214810666, 4171.728837625545, 4188.392683060954, 4188.874333769976, 4190.036291652937, 4195.349720793282, 3663.1208509957687, 3674.4855720199193, 3675.9264814703556, 3676.6690997810324, 3689.0, 5396.676199428047, 5429.891402171935, 5431.755570999315, 5434.402215756264, 5440.3743569489225, 4829.758512074382, 4921.852344429637, 4923.679960802537, 4930.580900623451, 4937.580305674022, 5945.375735547792, 5945.821625351203, 5949.524038076944, 5952.0, 5980.491658209014, 4005.0788318686573, 4006.3389540725743, 4008.0, 4014.658754005913, 4030.1738143680477, 6102.328743838174, 6179.134921111048, 6189.752409903598, 6200.503959683215, 6207.906881396738, 4047.1905618876344, 4116.0533077392365, 4125.443065186221, 4125.66994640428, 4139.068709540329, 4185.979070104691, 4186.392973018956, 4187.5184353799705, 4189.036521600049, 4195.370694395804, 4832.251001094765, 4853.757312134379, 4854.8786280342565, 4865.343178670834, 4877.341558889575, 5871.677057761779, 5893.027650437715, 5899.646021238739, 5905.4685078343155, 5925.525957923356, 1384.764590019699, 1400.3838311143268, 1470.0738534723057, 1487.367868655817, 1488.1220080152546, 966.2704657983318, 980.6763767956558, 983.3165949664914, 988.2439933450916, 988.9901100989042, 5036.773345199402, 5056.873578160502, 5060.468650791614, 5062.974685126551, 5075.8984820303385, 5998.4601385875485, 6058.697065146725, 6069.605475644069, 6083.11794789753, 6097.878042439126, 5121.667091639031, 5122.641415100908, 5131.87170320745, 5143.17709166539, 5145.382554093533, 3229.978607784827, 3253.4794432890626, 3256.234784825564, 3270.9345813083605, 3306.8677252909615, 5671.858203544862, 5731.140328950691, 5743.655380677173, 5745.626534275259, 5752.913706294409, 6236.968815155986, 6239.500839932794, 6243.8126856194385, 6244.625322480666, 6253.499720022387, 5638.7462564185535, 5736.971315143398, 5757.798477053283, 5759.568032397503, 5766.654000759968, 6080.422359875982, 6080.787172448943, 6083.209182806207, 6084.665343406155, 6092.69536523181, 5914.112883067574, 5940.495057920125, 5941.257342832146, 5952.255968003999, 5958.314793798769, 5702.572307077069, 5712.971435142797, 5724.4561766632105, 5730.71346432685, 5753.482186603226, 4053.4325194473386, 4127.566605506378, 4129.834806607702, 4131.111810960658, 4131.235721391552, 6034.426729460694, 6046.84882877914, 6057.242844644419, 6069.666168360783, 6079.878402431838, 5834.766609335579, 5858.004139296245, 5884.235049443545, 5911.970440147772, 5924.259467566554, 5898.321693005188, 5908.793192238251, 5911.527077833849, 5922.851928701817, 5925.970370148121, 5640.492355688008, 5724.370319264961, 5759.884802303846, 5773.711314434346, 5774.133879918046, 5993.340732519507, 6005.819825405245, 6006.549508786771, 6026.306974697791, 6062.302835174011, 5836.0, 5862.062070068769, 5880.441358070976, 5886.175935368966, 5891.204687367322], "unit": "score", "name": "prototype.html", "value": 4374.575224274051}, {"lowerIsBetter": false, "replicates": [736.3924762071292, 750.5684231566848, 759.2673070486983, 766.6166916541729, 777.6733771815835, 10562.788744225121, 10667.78664426711, 10676.0, 10708.357498550093, 10749.462526873645, 8631.395802293826, 10276.551927037375, 10346.741331466717, 10380.688579342614, 10395.896041039587, 745.4967896669754, 757.1935888278965, 758.0221514246615, 758.9013428254319, 762.2644148396796, 749.8725216713144, 756.5233902641328, 756.8448468064033, 757.1444267977178, 759.1118391481951, 780.5901901501728, 787.582581231948, 791.4341246009102, 792.6948124971899, 796.9521828690268, 771.7761849063793, 776.8990031295924, 779.3180966654178, 784.3489903380181, 784.7606480023591, 583.5856541855288, 585.8564651660328, 586.4047991288845, 588.6409290332894, 590.0058401593286, 9590.040995900425, 9645.228381729445, 9648.421094734338, 9653.082957119062, 9657.903420965771, 9762.511874406322, 10501.0, 10529.894701052968, 10550.68347949555, 10601.575936962512, 9150.0, 9188.356815022951, 9347.626094956262, 9411.670591529264, 9411.90588094124, 3224.6130464344196, 3264.9510257345923, 3268.9346213075605, 3284.458064419368, 3291.6214635317006, 37278.44082338767, 38071.04822379463, 38163.23673526542, 38419.42370864439, 41059.58940410588, 8793.868091978626, 8903.243224325875, 8961.641534338683, 9020.233280171258, 9071.0, 14850.108993460426, 14912.62718432048, 14923.701525969636, 14993.625159370884, 15021.624459388602, 6064.636121832704, 6149.13912052313, 6195.535334849904, 6205.937940620626, 6263.404976527223, 3666.9816650916573, 3703.574088979748, 3725.0, 3781.149241420713, 3839.155385815116, 2550.6174073889065, 2568.8073394495486, 2580.2001379572393, 2589.3008887600618, 2589.8705064746687, 468.65319663449486, 470.6916969385058, 472.0, 474.8456751555758, 481.0115213236832, 430.9396684464177, 435.73420213669635, 477.98566043018764, 540.3191978107612, 572.6134858970179, 7250.456215783837, 7544.811379715441, 7556.886646700304, 7590.354819840375, 7595.468317217742, 526.7129414469124, 550.4605486623052, 559.1445089013815, 560.4983539731999, 565.1663795901095, 3580.7672501287334, 3612.8012959286966, 3642.2715456908195, 3689.7417180797624, 3776.3957766757185, 46248.537514625095, 46273.76863115663, 46659.76670116628, 46700.0, 46707.29939050917, 42431.0, 42454.15091698149, 42826.57173428288, 43283.350749738776, 43329.35005974913, 34559.4816077759, 37326.813365933, 45166.548334516236, 45183.09633807371, 45509.54490455119, 7131.500794944304, 7495.812604684927, 7669.309762121213, 7770.145284018867, 7884.250996155356, 30257.394852103276, 30486.0, 30706.0, 30718.692813071582, 30953.8452307746, 34503.65496345004, 34652.48021279633, 36555.451668224465, 38122.618773811904, 38128.23743525059, 9936.403815771077, 9942.801143977225, 10048.799024019332, 10055.547500362647, 10262.897371026194, 10675.839862402225, 10693.839592406275, 10701.51843167075, 10763.750696489604, 10851.782964340828, 9571.473568953774, 9575.904240957501, 9609.615615375307, 9624.51877406141, 9628.0, 9828.312018158946, 9843.458609776531, 9891.258155638212, 9991.100800927952, 10039.196864250696, 9374.390664606779, 9663.661771838233, 9703.320767546204, 9762.316637835567, 9896.950515247378, 7598.202188770099, 8191.467554608931, 8237.705531201911, 8243.093259741543, 8343.624536895975, 7890.921090789018, 8080.878786818085, 8217.137200593852, 8223.79440513968, 8248.216419440143], "unit": "score", "name": "yui.html", "value": 5415.2541671955705}], "name": "dromaeo_css", "value": 5977.082487388786}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 109.0, 115.0, 115.0, 115.0, 128.0, 114.0, 116.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 153.0, 165.0, 143.0, 155.0, 158.0, 138.0, 169.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [164.0, 167.0, 165.0, 162.0, 162.0, 165.0, 171.0, 165.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 158.0, 73.0, 73.0, 73.0, 73.0, 149.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 148.0, 97.0, 98.0, 97.0, 131.0, 98.0, 98.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 152.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [79.0, 74.0, 77.0, 72.0, 71.0, 71.0, 72.0, 72.0, 73.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 88.0, 85.0, 84.0, 86.0, 84.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 123.0, 118.0, 120.0, 123.0, 124.0, 119.0, 127.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [138.0, 155.0, 145.0, 149.0, 153.0, 149.0, 156.0, 151.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 72.0, 70.0, 70.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1552.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.11567419575633], "unit": "score", "name": "Richards", "value": 206.30488799999998}, {"lowerIsBetter": false, "replicates": [187.47656542932134], "unit": "score", "name": "DeltaBlue", "value": 352.6734119999998}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [706.7137809187279], "unit": "score", "name": "Earley", "value": 943.0451449999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [43744.68085106383], "unit": "score", "name": "RegExp", "value": 20.825046206225675}, {"lowerIsBetter": false, "replicates": [666.6666666666666], "unit": "score", "name": "Splay", "value": 122.23650000000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20019.299625277752}]} 03:00:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20019.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1552.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5977.08"}}} 03:00:30 INFO - Return code: 0 03:00:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:00:30 INFO - # TBPL SUCCESS # 03:00:30 INFO - Running post-action listener: _resource_record_post_action 03:00:30 INFO - Running post-run listener: _resource_record_post_run 03:00:32 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539475968; Read time: 40; Write time: 411412 03:00:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 229498880; Read time: 0; Write time: 243196 03:00:32 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309977088; Read time: 40; Write time: 168216 03:00:32 INFO - Running post-run listener: _upload_blobber_files 03:00:32 INFO - Blob upload gear active. 03:00:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:00:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:00:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:33 INFO - (blobuploader) - INFO - Done attempting. 03:00:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:00:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:00:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:34 INFO - (blobuploader) - INFO - Done attempting. 03:00:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:00:34 INFO - Return code: 0 03:00:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:00:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:00:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/079fbe6ffbce39e4cc3cd7c854ea5092a8f4d1a10f1159f09c46a43c05d8b4ba1ef9b5d1a6ea6c7d20d3785f42f92204463d54868c6bafa8b2ddf005ad771e3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a934d61f560ff291dc090b5fb156dc46b50cebc0bb223d4a35c02a6eacdfb280f22cdc3d01aa805a19e6d841045ec7d6acf96fdea7fdf309e5dcb35354b1cb9b"} 03:00:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:00:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:00:34 INFO - Contents: 03:00:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/079fbe6ffbce39e4cc3cd7c854ea5092a8f4d1a10f1159f09c46a43c05d8b4ba1ef9b5d1a6ea6c7d20d3785f42f92204463d54868c6bafa8b2ddf005ad771e3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a934d61f560ff291dc090b5fb156dc46b50cebc0bb223d4a35c02a6eacdfb280f22cdc3d01aa805a19e6d841045ec7d6acf96fdea7fdf309e5dcb35354b1cb9b"} 03:00:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:00:34 INFO - Copying logs to upload dir... 03:00:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:00:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.422303 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-19 03:00:33.192884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 03:00:33.196373) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 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/079fbe6ffbce39e4cc3cd7c854ea5092a8f4d1a10f1159f09c46a43c05d8b4ba1ef9b5d1a6ea6c7d20d3785f42f92204463d54868c6bafa8b2ddf005ad771e3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a934d61f560ff291dc090b5fb156dc46b50cebc0bb223d4a35c02a6eacdfb280f22cdc3d01aa805a19e6d841045ec7d6acf96fdea7fdf309e5dcb35354b1cb9b"} build_url:https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/e7GxPcgpS0-Q-neaWNXqew/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/079fbe6ffbce39e4cc3cd7c854ea5092a8f4d1a10f1159f09c46a43c05d8b4ba1ef9b5d1a6ea6c7d20d3785f42f92204463d54868c6bafa8b2ddf005ad771e3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a934d61f560ff291dc090b5fb156dc46b50cebc0bb223d4a35c02a6eacdfb280f22cdc3d01aa805a19e6d841045ec7d6acf96fdea7fdf309e5dcb35354b1cb9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 03:00:33.228748) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 03:00:33.229242) ========= 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=523ca41ca1e0623de333ad52000001bf-1453198498.177229-58325750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 03:00:33.312036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 03:00:33.312453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 03:00:33.312822) ========= ========= Total master_lag: 0.35 =========