builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1467461340.63 results: success (0) buildid: 20160702023007 builduid: 401ed72a5741489e81ed84e37d93caf4 revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.632109) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.632539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.632822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.670530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.670811) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 05:09:01-- 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% 114M=0s 2016-07-02 05:09:01 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120208 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.811006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.811428) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:00.865169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 05:09:00.865533) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 05:09:01,402 truncating revision to first 12 chars 2016-07-02 05:09:01,402 Setting DEBUG logging. 2016-07-02 05:09:01,402 attempt 1/10 2016-07-02 05:09:01,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39dffbba7642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 05:09:02,343 unpacking tar archive at: fx-team-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 05:09:02.220229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:02.220691) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:02.221131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:02.221462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 05:09:02.231989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-02 05:09:02.232292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:02 INFO - MultiFileLogger online at 20160702 05:09:02 in /builds/slave/test 05:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:02 INFO - {'append_to_log': False, 05:09:02 INFO - 'base_work_dir': '/builds/slave/test', 05:09:02 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:02 INFO - 'branch': 'Fx-Team', 05:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:02 INFO - 'config_files': ('talos/linux_config.py',), 05:09:02 INFO - 'default_actions': ('clobber', 05:09:02 INFO - 'read-buildbot-config', 05:09:02 INFO - 'download-and-extract', 05:09:02 INFO - 'populate-webroot', 05:09:02 INFO - 'create-virtualenv', 05:09:02 INFO - 'install', 05:09:02 INFO - 'run-tests'), 05:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:02 INFO - 'download_minidump_stackwalk': True, 05:09:02 INFO - 'download_symbols': 'ondemand', 05:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:02 INFO - 'installer_path': 'installer.exe', 05:09:02 INFO - 'log_level': 'info', 05:09:02 INFO - 'log_name': 'talos', 05:09:02 INFO - 'log_to_console': True, 05:09:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:02 INFO - 'opt_config_files': (), 05:09:02 INFO - 'pip_index': False, 05:09:02 INFO - 'sps_profile': False, 05:09:02 INFO - 'sps_profile_interval': 0, 05:09:02 INFO - 'suite': 'dromaeojs-e10s', 05:09:02 INFO - 'system_bits': '32', 05:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:02 INFO - 'title': 'talos-linux64-ix-006', 05:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:02 INFO - 'use_talos_json': True, 05:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:02 INFO - 'work_dir': 'build'} 05:09:02 INFO - ##### 05:09:02 INFO - ##### Running clobber step. 05:09:02 INFO - ##### 05:09:02 INFO - Running pre-action listener: _resource_record_pre_action 05:09:02 INFO - Running main action method: clobber 05:09:02 INFO - rmtree: /builds/slave/test/build 05:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - ##### 05:09:03 INFO - ##### Finished clobber step (success) 05:09:03 INFO - ##### 05:09:03 INFO - ##### 05:09:03 INFO - ##### Running read-buildbot-config step. 05:09:03 INFO - ##### 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: read_buildbot_config 05:09:03 INFO - Using buildbot properties: 05:09:03 INFO - { 05:09:03 INFO - "project": "", 05:09:03 INFO - "product": "firefox", 05:09:03 INFO - "script_repo_revision": "production", 05:09:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:09:03 INFO - "repository": "", 05:09:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:09:03 INFO - "buildid": "20160702023007", 05:09:03 INFO - "pgo_build": "True", 05:09:03 INFO - "basedir": "/builds/slave/test", 05:09:03 INFO - "buildnumber": 532, 05:09:03 INFO - "slavename": "talos-linux64-ix-006", 05:09:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:09:03 INFO - "platform": "ubuntu64_hw", 05:09:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:09:03 INFO - "branch": "fx-team", 05:09:03 INFO - "repo_path": "integration/fx-team", 05:09:03 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 05:09:03 INFO - "stage_platform": "linux64-pgo", 05:09:03 INFO - "builduid": "401ed72a5741489e81ed84e37d93caf4", 05:09:03 INFO - "slavebuilddir": "test" 05:09:03 INFO - } 05:09:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - ##### 05:09:03 INFO - ##### Finished read-buildbot-config step (success) 05:09:03 INFO - ##### 05:09:03 INFO - ##### 05:09:03 INFO - ##### Running download-and-extract step. 05:09:03 INFO - ##### 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: download_and_extract 05:09:03 INFO - mkdir: /builds/slave/test/build/tests 05:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:03 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:09:11 INFO - Downloaded 1361 bytes. 05:09:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:09:11 INFO - Using the following test package requirements: 05:09:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:09:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'jsshell-linux-x86_64.zip'], 05:09:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:11 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:14 INFO - Downloaded 24272920 bytes. 05:09:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:15 INFO - Return code: 0 05:09:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:15 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:18 INFO - Downloaded 24272920 bytes. 05:09:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:19 INFO - Return code: 0 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:19 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:09:20 INFO - Downloaded 14405327 bytes. 05:09:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:09:20 INFO - Return code: 0 05:09:20 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')]} 05:09:20 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:09:24 INFO - Downloaded 60349372 bytes. 05:09:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:24 INFO - mkdir: /builds/slave/test/properties 05:09:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:24 INFO - Contents: 05:09:24 INFO - build_url:https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:09:25 INFO - Running post-action listener: _resource_record_post_action 05:09:25 INFO - Running post-action listener: set_extra_try_arguments 05:09:25 INFO - ##### 05:09:25 INFO - ##### Finished download-and-extract step (success) 05:09:25 INFO - ##### 05:09:25 INFO - ##### 05:09:25 INFO - ##### Running populate-webroot step. 05:09:25 INFO - ##### 05:09:25 INFO - Running pre-action listener: _resource_record_pre_action 05:09:25 INFO - Running main action method: populate_webroot 05:09:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:25 INFO - '--tppagecycles', 05:09:25 INFO - '7'], 05:09:25 INFO - 'tests': ['tsvgm']}}, 05:09:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['damp', 'tps']}, 05:09:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'tests': ['damp', 'tps']}, 05:09:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['dromaeo_dom']}, 05:09:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['basic_compositor_video']}, 05:09:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:09:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['a11yr', 05:09:25 INFO - 'ts_paint', 05:09:25 INFO - 'tpaint', 05:09:25 INFO - 'sessionrestore', 05:09:25 INFO - 'sessionrestore_no_auto_restore', 05:09:25 INFO - 'tabpaint']}, 05:09:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['tsvgx', 05:09:25 INFO - 'tsvgr_opacity', 05:09:25 INFO - 'tart', 05:09:25 INFO - 'tscrollx', 05:09:25 INFO - 'cart']}, 05:09:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:25 INFO - 'tsvgr_opacity', 05:09:25 INFO - 'tart', 05:09:25 INFO - 'tscrollx', 05:09:25 INFO - 'cart']}, 05:09:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'talos_options': ['--disable-e10s'], 05:09:25 INFO - 'tests': ['tp5o']}, 05:09:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'tests': ['tp5o']}, 05:09:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'talos_options': ['--disable-e10s', 05:09:25 INFO - '--xperf_path', 05:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:25 INFO - 'tests': ['tp5n']}, 05:09:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:25 INFO - 'talos_options': ['--xperf_path', 05:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:25 INFO - 'tests': ['tp5n']}}, 05:09:25 INFO - 'talos.zip': {'path': '', 05:09:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:25 INFO - Running post-action listener: _resource_record_post_action 05:09:25 INFO - ##### 05:09:25 INFO - ##### Finished populate-webroot step (success) 05:09:25 INFO - ##### 05:09:25 INFO - ##### 05:09:25 INFO - ##### Running create-virtualenv step. 05:09:25 INFO - ##### 05:09:25 INFO - Running pre-action listener: _resource_record_pre_action 05:09:25 INFO - Running main action method: create_virtualenv 05:09:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:25 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 05:09:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:25 INFO - Using real prefix '/usr' 05:09:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:27 INFO - Installing pip.................done. 05:09:27 INFO - Return code: 0 05:09:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:27 INFO - Using env: {'DISPLAY': ':0', 05:09:27 INFO - 'HOME': '/home/cltbld', 05:09:27 INFO - 'LANG': 'en_US.UTF-8', 05:09:27 INFO - 'LANGUAGE': 'en_US:en', 05:09:27 INFO - 'LOGNAME': 'cltbld', 05:09:27 INFO - 'MAIL': '/var/mail/cltbld', 05:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:27 INFO - 'MOZ_NO_REMOTE': '1', 05:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:27 INFO - 'NO_EM_RESTART': '1', 05:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:27 INFO - 'PWD': '/builds/slave/test', 05:09:27 INFO - 'SHELL': '/bin/bash', 05:09:27 INFO - 'SHLVL': '1', 05:09:27 INFO - 'TERM': 'linux', 05:09:27 INFO - 'TMOUT': '86400', 05:09:27 INFO - 'USER': 'cltbld', 05:09:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:27 INFO - '_': '/tools/buildbot/bin/python'} 05:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:27 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 05:09:27 INFO - Cleaning up... 05:09:27 INFO - Return code: 0 05:09:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 05:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 05:09:27 INFO - Using env: {'DISPLAY': ':0', 05:09:27 INFO - 'HOME': '/home/cltbld', 05:09:27 INFO - 'LANG': 'en_US.UTF-8', 05:09:27 INFO - 'LANGUAGE': 'en_US:en', 05:09:27 INFO - 'LOGNAME': 'cltbld', 05:09:27 INFO - 'MAIL': '/var/mail/cltbld', 05:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:27 INFO - 'MOZ_NO_REMOTE': '1', 05:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:27 INFO - 'NO_EM_RESTART': '1', 05:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:27 INFO - 'PWD': '/builds/slave/test', 05:09:27 INFO - 'SHELL': '/bin/bash', 05:09:27 INFO - 'SHLVL': '1', 05:09:27 INFO - 'TERM': 'linux', 05:09:27 INFO - 'TMOUT': '86400', 05:09:27 INFO - 'USER': 'cltbld', 05:09:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:27 INFO - '_': '/tools/buildbot/bin/python'} 05:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:28 INFO - Downloading/unpacking psutil>=3.1.1 05:09:28 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 05:09:28 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 05:09:28 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 05:09:28 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 05:09:28 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 05:09:28 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 05:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:30 INFO - Installing collected packages: psutil 05:09:30 INFO - Running setup.py install for psutil 05:09:30 INFO - building 'psutil._psutil_linux' extension 05:09:30 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 05:09:30 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 05:09:30 INFO - building 'psutil._psutil_posix' extension 05:09:30 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 05:09:30 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 05:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:30 INFO - Successfully installed psutil 05:09:30 INFO - Cleaning up... 05:09:30 INFO - Return code: 0 05:09:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 05:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 05:09:30 INFO - Using env: {'DISPLAY': ':0', 05:09:30 INFO - 'HOME': '/home/cltbld', 05:09:30 INFO - 'LANG': 'en_US.UTF-8', 05:09:30 INFO - 'LANGUAGE': 'en_US:en', 05:09:30 INFO - 'LOGNAME': 'cltbld', 05:09:30 INFO - 'MAIL': '/var/mail/cltbld', 05:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:30 INFO - 'MOZ_NO_REMOTE': '1', 05:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:30 INFO - 'NO_EM_RESTART': '1', 05:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:30 INFO - 'PWD': '/builds/slave/test', 05:09:30 INFO - 'SHELL': '/bin/bash', 05:09:30 INFO - 'SHLVL': '1', 05:09:30 INFO - 'TERM': 'linux', 05:09:30 INFO - 'TMOUT': '86400', 05:09:30 INFO - 'USER': 'cltbld', 05:09:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:30 INFO - '_': '/tools/buildbot/bin/python'} 05:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:30 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 05:09:30 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 05:09:30 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 05:09:30 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 05:09:30 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 05:09:30 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 05:09:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:32 INFO - Installing collected packages: mozsystemmonitor 05:09:32 INFO - Running setup.py install for mozsystemmonitor 05:09:32 INFO - Successfully installed mozsystemmonitor 05:09:32 INFO - Cleaning up... 05:09:32 INFO - Return code: 0 05:09:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 05:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 05:09:32 INFO - Using env: {'DISPLAY': ':0', 05:09:32 INFO - 'HOME': '/home/cltbld', 05:09:32 INFO - 'LANG': 'en_US.UTF-8', 05:09:32 INFO - 'LANGUAGE': 'en_US:en', 05:09:32 INFO - 'LOGNAME': 'cltbld', 05:09:32 INFO - 'MAIL': '/var/mail/cltbld', 05:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:32 INFO - 'MOZ_NO_REMOTE': '1', 05:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:32 INFO - 'NO_EM_RESTART': '1', 05:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:32 INFO - 'PWD': '/builds/slave/test', 05:09:32 INFO - 'SHELL': '/bin/bash', 05:09:32 INFO - 'SHLVL': '1', 05:09:32 INFO - 'TERM': 'linux', 05:09:32 INFO - 'TMOUT': '86400', 05:09:32 INFO - 'USER': 'cltbld', 05:09:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:32 INFO - '_': '/tools/buildbot/bin/python'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:33 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:33 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 05:09:33 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 05:09:33 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 05:09:33 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 05:09:33 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 05:09:33 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 05:09:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:35 INFO - warning: no files found matching '*.txt' 05:09:35 INFO - no previously-included directories found matching 'build' 05:09:35 INFO - no previously-included directories found matching 'dist' 05:09:35 INFO - no previously-included directories found matching '.git*' 05:09:35 INFO - Installing collected packages: jsonschema, functools32 05:09:35 INFO - Running setup.py install for functools32 05:09:35 INFO - warning: no files found matching '*.txt' 05:09:35 INFO - no previously-included directories found matching 'build' 05:09:35 INFO - no previously-included directories found matching 'dist' 05:09:35 INFO - no previously-included directories found matching '.git*' 05:09:35 INFO - Successfully installed jsonschema functools32 05:09:35 INFO - Cleaning up... 05:09:35 INFO - Return code: 0 05:09:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:35 INFO - Using env: {'DISPLAY': ':0', 05:09:35 INFO - 'HOME': '/home/cltbld', 05:09:35 INFO - 'LANG': 'en_US.UTF-8', 05:09:35 INFO - 'LANGUAGE': 'en_US:en', 05:09:35 INFO - 'LOGNAME': 'cltbld', 05:09:35 INFO - 'MAIL': '/var/mail/cltbld', 05:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:35 INFO - 'MOZ_NO_REMOTE': '1', 05:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:35 INFO - 'NO_EM_RESTART': '1', 05:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:35 INFO - 'PWD': '/builds/slave/test', 05:09:35 INFO - 'SHELL': '/bin/bash', 05:09:35 INFO - 'SHLVL': '1', 05:09:35 INFO - 'TERM': 'linux', 05:09:35 INFO - 'TMOUT': '86400', 05:09:35 INFO - 'USER': 'cltbld', 05:09:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:35 INFO - '_': '/tools/buildbot/bin/python'} 05:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:35 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 05:09:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:37 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 05:09:37 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 05:09:37 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 05:09:37 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 05:09:37 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 05:09:37 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 05:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:38 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 05:09:38 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 05:09:38 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 05:09:38 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 05:09:38 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 05:09:38 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 05:09:38 INFO - Downloading docopt-0.6.1.tar.gz 05:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:38 INFO - Running setup.py install for blobuploader 05:09:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:38 INFO - Running setup.py install for requests 05:09:38 INFO - Running setup.py install for docopt 05:09:38 INFO - Successfully installed blobuploader requests docopt 05:09:38 INFO - Cleaning up... 05:09:39 INFO - Return code: 0 05:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:09:39 INFO - Using env: {'DISPLAY': ':0', 05:09:39 INFO - 'HOME': '/home/cltbld', 05:09:39 INFO - 'LANG': 'en_US.UTF-8', 05:09:39 INFO - 'LANGUAGE': 'en_US:en', 05:09:39 INFO - 'LOGNAME': 'cltbld', 05:09:39 INFO - 'MAIL': '/var/mail/cltbld', 05:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:39 INFO - 'MOZ_NO_REMOTE': '1', 05:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:39 INFO - 'NO_EM_RESTART': '1', 05:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:39 INFO - 'PWD': '/builds/slave/test', 05:09:39 INFO - 'SHELL': '/bin/bash', 05:09:39 INFO - 'SHLVL': '1', 05:09:39 INFO - 'TERM': 'linux', 05:09:39 INFO - 'TMOUT': '86400', 05:09:39 INFO - 'USER': 'cltbld', 05:09:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:39 INFO - '_': '/tools/buildbot/bin/python'} 05:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:39 INFO - Running setup.py (path:/tmp/pip-jsmCEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:39 INFO - Running setup.py (path:/tmp/pip-R_gVJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:39 INFO - Running setup.py (path:/tmp/pip-Grgqqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:39 INFO - Running setup.py (path:/tmp/pip-q3Blx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:39 INFO - Running setup.py (path:/tmp/pip-A8R7xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:39 INFO - Running setup.py (path:/tmp/pip-ChnGqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:39 INFO - Running setup.py (path:/tmp/pip-ev7f2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:39 INFO - Running setup.py (path:/tmp/pip-TFNjqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:39 INFO - Running setup.py (path:/tmp/pip-t23wtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:39 INFO - Running setup.py (path:/tmp/pip-sUlrTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:39 INFO - Running setup.py (path:/tmp/pip-3GJBdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:40 INFO - Running setup.py (path:/tmp/pip-8GB22p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:40 INFO - Running setup.py (path:/tmp/pip-yr9onO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:40 INFO - Running setup.py (path:/tmp/pip-VprwW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:40 INFO - Running setup.py (path:/tmp/pip-92mLyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:40 INFO - Running setup.py (path:/tmp/pip-2G0HCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:40 INFO - Running setup.py (path:/tmp/pip-VnAcgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:40 INFO - Running setup.py install for manifestparser 05:09:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Running setup.py install for mozcrash 05:09:40 INFO - Running setup.py install for mozdebug 05:09:40 INFO - Running setup.py install for mozdevice 05:09:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Running setup.py install for mozfile 05:09:40 INFO - Running setup.py install for mozhttpd 05:09:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozinfo 05:09:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozInstall 05:09:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozleak 05:09:41 INFO - Running setup.py install for mozlog 05:09:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for moznetwork 05:09:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozprocess 05:09:41 INFO - Running setup.py install for mozprofile 05:09:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozrunner 05:09:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozscreenshot 05:09:42 INFO - Running setup.py install for moztest 05:09:42 INFO - Running setup.py install for mozversion 05:09:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:42 INFO - Cleaning up... 05:09:42 INFO - Return code: 0 05:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:42 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')]} 05:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 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')]} 05:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:42 INFO - Using env: {'DISPLAY': ':0', 05:09:42 INFO - 'HOME': '/home/cltbld', 05:09:42 INFO - 'LANG': 'en_US.UTF-8', 05:09:42 INFO - 'LANGUAGE': 'en_US:en', 05:09:42 INFO - 'LOGNAME': 'cltbld', 05:09:42 INFO - 'MAIL': '/var/mail/cltbld', 05:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:42 INFO - 'MOZ_NO_REMOTE': '1', 05:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:42 INFO - 'NO_EM_RESTART': '1', 05:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:42 INFO - 'PWD': '/builds/slave/test', 05:09:42 INFO - 'SHELL': '/bin/bash', 05:09:42 INFO - 'SHLVL': '1', 05:09:42 INFO - 'TERM': 'linux', 05:09:42 INFO - 'TMOUT': '86400', 05:09:42 INFO - 'USER': 'cltbld', 05:09:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:42 INFO - '_': '/tools/buildbot/bin/python'} 05:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:42 INFO - Running setup.py (path:/tmp/pip-0kG7sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:42 INFO - Running setup.py (path:/tmp/pip-os9K9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:42 INFO - Running setup.py (path:/tmp/pip-_GR0Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:42 INFO - Running setup.py (path:/tmp/pip-2lA6o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:42 INFO - Running setup.py (path:/tmp/pip-ODKrvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:42 INFO - Running setup.py (path:/tmp/pip-Qv5piR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:42 INFO - Running setup.py (path:/tmp/pip-QYNfPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:42 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)) 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:42 INFO - Running setup.py (path:/tmp/pip-04zTim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:43 INFO - Running setup.py (path:/tmp/pip-aAp0y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:43 INFO - Running setup.py (path:/tmp/pip-4iJIqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:43 INFO - Running setup.py (path:/tmp/pip-wtfYg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:43 INFO - Running setup.py (path:/tmp/pip-rMpCLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:43 INFO - Running setup.py (path:/tmp/pip-kTEgfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:43 INFO - Running setup.py (path:/tmp/pip-uqGzk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:43 INFO - Running setup.py (path:/tmp/pip-WWq5sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:43 INFO - Running setup.py (path:/tmp/pip-CQcuAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:43 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)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:43 INFO - Running setup.py (path:/tmp/pip-2GQYh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:43 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)) 05:09:43 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:43 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:43 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)) 05:09:43 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)) 05:09:43 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)) 05:09:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:45 INFO - Downloading blessings-1.6.tar.gz 05:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:45 INFO - Installing collected packages: blessings 05:09:45 INFO - Running setup.py install for blessings 05:09:45 INFO - Successfully installed blessings 05:09:45 INFO - Cleaning up... 05:09:45 INFO - Return code: 0 05:09:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:46 INFO - Reading from file tmpfile_stdout 05:09:46 INFO - Current package versions: 05:09:46 INFO - argparse == 1.2.1 05:09:46 INFO - blessings == 1.6 05:09:46 INFO - blobuploader == 1.2.4 05:09:46 INFO - docopt == 0.6.1 05:09:46 INFO - functools32 == 3.2.3-2 05:09:46 INFO - jsonschema == 2.5.1 05:09:46 INFO - manifestparser == 1.1 05:09:46 INFO - mozInstall == 1.12 05:09:46 INFO - mozcrash == 0.17 05:09:46 INFO - mozdebug == 0.1 05:09:46 INFO - mozdevice == 0.48 05:09:46 INFO - mozfile == 1.2 05:09:46 INFO - mozhttpd == 0.7 05:09:46 INFO - mozinfo == 0.9 05:09:46 INFO - mozleak == 0.1 05:09:46 INFO - mozlog == 3.2 05:09:46 INFO - moznetwork == 0.27 05:09:46 INFO - mozprocess == 0.22 05:09:46 INFO - mozprofile == 0.28 05:09:46 INFO - mozrunner == 6.11 05:09:46 INFO - mozscreenshot == 0.1 05:09:46 INFO - mozsystemmonitor == 0.3 05:09:46 INFO - moztest == 0.7 05:09:46 INFO - mozversion == 1.4 05:09:46 INFO - psutil == 3.1.1 05:09:46 INFO - requests == 1.2.3 05:09:46 INFO - wsgiref == 0.1.2 05:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:46 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')]} 05:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 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')]} 05:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:46 INFO - Using env: {'DISPLAY': ':0', 05:09:46 INFO - 'HOME': '/home/cltbld', 05:09:46 INFO - 'LANG': 'en_US.UTF-8', 05:09:46 INFO - 'LANGUAGE': 'en_US:en', 05:09:46 INFO - 'LOGNAME': 'cltbld', 05:09:46 INFO - 'MAIL': '/var/mail/cltbld', 05:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:46 INFO - 'MOZ_NO_REMOTE': '1', 05:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:46 INFO - 'NO_EM_RESTART': '1', 05:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:46 INFO - 'PWD': '/builds/slave/test', 05:09:46 INFO - 'SHELL': '/bin/bash', 05:09:46 INFO - 'SHLVL': '1', 05:09:46 INFO - 'TERM': 'linux', 05:09:46 INFO - 'TMOUT': '86400', 05:09:46 INFO - 'USER': 'cltbld', 05:09:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:46 INFO - '_': '/tools/buildbot/bin/python'} 05:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 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)) 05:09:46 INFO - Cleaning up... 05:09:46 INFO - Return code: 0 05:09:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:46 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')]} 05:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 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')]} 05:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x204c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', '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 05:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:46 INFO - Using env: {'DISPLAY': ':0', 05:09:46 INFO - 'HOME': '/home/cltbld', 05:09:46 INFO - 'LANG': 'en_US.UTF-8', 05:09:46 INFO - 'LANGUAGE': 'en_US:en', 05:09:46 INFO - 'LOGNAME': 'cltbld', 05:09:46 INFO - 'MAIL': '/var/mail/cltbld', 05:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:46 INFO - 'MOZ_NO_REMOTE': '1', 05:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:46 INFO - 'NO_EM_RESTART': '1', 05:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:46 INFO - 'PWD': '/builds/slave/test', 05:09:46 INFO - 'SHELL': '/bin/bash', 05:09:46 INFO - 'SHLVL': '1', 05:09:46 INFO - 'TERM': 'linux', 05:09:46 INFO - 'TMOUT': '86400', 05:09:46 INFO - 'USER': 'cltbld', 05:09:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:46 INFO - '_': '/tools/buildbot/bin/python'} 05:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:46 INFO - Cleaning up... 05:09:46 INFO - Return code: 0 05:09:46 INFO - Running post-action listener: _resource_record_post_action 05:09:46 INFO - Running post-action listener: _start_resource_monitoring 05:09:46 INFO - Starting resource monitoring. 05:09:46 INFO - ##### 05:09:46 INFO - ##### Finished create-virtualenv step (success) 05:09:46 INFO - ##### 05:09:46 INFO - ##### 05:09:46 INFO - ##### Running install step. 05:09:46 INFO - ##### 05:09:46 INFO - Running pre-action listener: _resource_record_pre_action 05:09:46 INFO - Running main action method: install 05:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:46 INFO - Reading from file tmpfile_stdout 05:09:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:46 INFO - Reading from file tmpfile_stdout 05:09:46 INFO - Output received: 05:09:46 INFO - Usage: mozinstall [options] installer 05:09:46 INFO - Options: 05:09:46 INFO - -h, --help show this help message and exit 05:09:46 INFO - -d DEST, --destination=DEST 05:09:46 INFO - Directory to install application into. [default: 05:09:46 INFO - "/builds/slave/test"] 05:09:46 INFO - --app=APP Application being installed. [default: firefox] 05:09:46 INFO - mkdir: /builds/slave/test/build/application 05:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:10:03 INFO - Reading from file tmpfile_stdout 05:10:03 INFO - Output received: 05:10:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:03 INFO - Running post-action listener: _resource_record_post_action 05:10:03 INFO - ##### 05:10:03 INFO - ##### Finished install step (success) 05:10:03 INFO - ##### 05:10:03 INFO - ##### 05:10:03 INFO - ##### Running run-tests step. 05:10:03 INFO - ##### 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: run_tests 05:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:03 INFO - Python 2.7.3 05:10:03 INFO - Return code: 0 05:10:03 INFO - grabbing minidump binary from tooltool 05:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:03 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230b3b0>, '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 0x230c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:03 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 05:10:03 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 05:10:03 INFO - Calling ['/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'] with output_timeout 600 05:10:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:04 INFO - Return code: 0 05:10:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 05:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 05:10:04 INFO - Using env: {'DISPLAY': ':0', 05:10:04 INFO - 'HOME': '/home/cltbld', 05:10:04 INFO - 'LANG': 'en_US.UTF-8', 05:10:04 INFO - 'LANGUAGE': 'en_US:en', 05:10:04 INFO - 'LOGNAME': 'cltbld', 05:10:04 INFO - 'MAIL': '/var/mail/cltbld', 05:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:04 INFO - 'MOZ_NO_REMOTE': '1', 05:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:04 INFO - 'NO_EM_RESTART': '1', 05:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:04 INFO - 'PWD': '/builds/slave/test', 05:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:04 INFO - 'SHELL': '/bin/bash', 05:10:04 INFO - 'SHLVL': '1', 05:10:04 INFO - 'TERM': 'linux', 05:10:04 INFO - 'TMOUT': '86400', 05:10:04 INFO - 'USER': 'cltbld', 05:10:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484', 05:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:04 INFO - '_': '/tools/buildbot/bin/python'} 05:10:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 05:10:04 INFO - mozversion application_buildid: 20160702023007 05:10:04 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:10:04 INFO - mozversion application_display_name: Nightly 05:10:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:04 INFO - mozversion application_name: Firefox 05:10:04 INFO - mozversion application_remotingname: firefox 05:10:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:04 INFO - mozversion application_vendor: Mozilla 05:10:04 INFO - mozversion application_version: 50.0a1 05:10:04 INFO - mozversion platform_buildid: 20160702023007 05:10:04 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 05:10:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:04 INFO - mozversion platform_version: 50.0a1 05:10:04 INFO - using testdate: 1467461404 05:10:04 INFO - actual date: 1467461404 05:10:04 INFO - starting webserver on 'localhost:40350' 05:10:04 INFO - SUITE-START | Running 2 tests 05:10:04 INFO - TEST-START | dromaeo_css 05:10:04 INFO - operating with platform_type : linux_ 05:10:04 INFO - Initialising browser for dromaeo_css test... 05:10:04 INFO - TEST-INFO | started process 14439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFjGut/profile http://localhost:40350/getInfo.html) 05:10:08 INFO - PROCESS | 14439 | __metrics Screen width/height:1600/1200 05:10:08 INFO - PROCESS | 14439 | colorDepth:24 05:10:08 INFO - PROCESS | 14439 | Browser inner width/height: 1024/697 05:10:08 INFO - PROCESS | 14439 | __metrics 05:10:09 ERROR - PROCESS | 14439 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:10:10 INFO - TEST-INFO | 14439: exit 0 05:10:10 INFO - Browser initialized. 05:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:10 INFO - TEST-INFO | started process 14559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFjGut/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:21 INFO - PROCESS | 14559 | RSS: Main: 168333312 05:10:21 INFO - PROCESS | 14559 | 05:11:11 INFO - PROCESS | 14559 | 1467461471548 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] 05:13:19 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40350/tests/dromaeo/cssquery-ext.html) 05:13:20 INFO - PROCESS | 14559 | RSS: Main: 172158976 05:13:20 INFO - PROCESS | 14559 | 05:16:22 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-ext.html (next: http://localhost:40350/tests/dromaeo/cssquery-jquery.html) 05:16:23 INFO - PROCESS | 14559 | RSS: Main: 169140224 05:16:23 INFO - PROCESS | 14559 | 05:19:25 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40350/tests/dromaeo/cssquery-mootools.html) 05:19:25 INFO - PROCESS | 14559 | RSS: Main: 172191744 05:19:25 INFO - PROCESS | 14559 | 05:22:27 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40350/tests/dromaeo/cssquery-prototype.html) 05:22:28 INFO - PROCESS | 14559 | RSS: Main: 168435712 05:22:28 INFO - PROCESS | 14559 | 05:25:30 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40350/tests/dromaeo/cssquery-yui.html) 05:25:31 INFO - PROCESS | 14559 | RSS: Main: 170123264 05:25:31 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | Cycle 1(1): loaded http://localhost:40350/tests/dromaeo/cssquery-yui.html (next: http://localhost:40350/tests/dromaeo/cssquery-dojo.html) 05:28:34 INFO - PROCESS | 14559 | RSS: Main: 170762240 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | __start_tp_report 05:28:34 INFO - PROCESS | 14559 | _x_x_mozilla_page_load 05:28:34 INFO - PROCESS | 14559 | _x_x_mozilla_page_load_details 05:28:34 INFO - PROCESS | 14559 | |i|pagename|runs| 05:28:34 INFO - PROCESS | 14559 | |0;dojo.html;3125.4061728271627;3171.2389026633587;3190.3300306935535;3196.4566023775956;3211.0206387051967;5491.3684926233445;5541.445855414461;5573.164025396188;5576.609637325379;5648.124540696199;5389.487998640133;5515.7242137893145;5559.694216818073;5567.415421380758;5588.050031494646;4996.100701873661;5050.419201791786;5136.845894623168;5200.531952124308;5244.449332820056;691.991718243116;4963.057019166365;4968.254761785743;5085.982803439309;5091.083604951107;4971.577415919651;4989.75051247438;5009.849704508889;5020;5031.044101620699;4975.776090075955;4981.227909674007;5006.299118123466;5018.548330650223;5030.773615187325;5004.924926126111;5065.797368105272;5072.0870243356185;5092.057969275659;5093.592512598983;5529.944700552983;5621.297337832771;5621.297337832771;5630.634008789416;5630.859228519279;5838.124281357788;5905.645661260338;5975.894459524959;5999.044928170619;6038.698065096728;5891.586019355366;5931.851703707399;5972.25346831646;5978.2228310319815;6005.279366476007;5517.117261238222;5519.944800551943;5533.6956467394275;5536.861578460531;5537.307836520435;5955.851103722442;6059.303180134253;6073.423024812636;6121.173641558422;6141.170941922784;5780;5780.104083867007;5796.594238403271;5841.2990441146485;5857.062869940789;5906.320773111147;5908.05471124618;5908.527317814651;5910.468057874812;5936.436038576328;5859.824205273849;5959.106134079922;6011.248593925759;6029.065494848305;6063.151158837766;5991.7603295867675;6020.909686354708;6060.696965151725;6075.179850720185;6078.544109191828;4297.376880352332;4441.733495990251;4450.310201918708;4457.2199865023495;4489.012417268195;3863.690904727615;3885.592012838668;3887.9611203888167;3900.4539364488996;3908.5309762828642;5538.44615538451;5599.580031497654;5631.690257035821;5635.5773317001385;5643.633163844337;5935.643861368331;6016.909746353808;6025.397460253939;6029.758809647653;6032.426919442733;5461.754221060062;5591.049521581341;5622.943770562242;5629.971850140723;5648.661080335193;4953.578945789576;4959.752012399365;4960;4963.205887058053;4992.8002879885125;6076.058210977306;6179.783707570304;6189.288231853305;6199.473044791153;6213.689315534296;5924.496417804535;5955.255593050869;5972.372900845348;6049.122877182695;6059.545534084873;6186.041163619466;6188.907166392418;6203.255609326729;6211.9068213975925;6213.161223234986;5620.8875822482505;5840.795572154954;5862;5868.471837534642;5882;5999.460048595647;6084.513238940963;6098.32918378969;6142.385761423822;6142.539309551712;5927.377625349449;5939.316978547522;5940.287165540163;5952.136940143741;5952.285725712942;5694.17434471991;5754.19441278213;5868.501177399969;5907.645541267538;5908.970455147697;5790.305163380252;5847.356790753099;5857.414258574108;5886.705664716661;5913.733881975408;5925.4370834770625;5943.732532035982;5959.67221802805;5971.970140149445;5972.104184372379;5609.018421776254;5723.456271654186;5762.798302059407;5815.883682326415;5817.680027598522 05:28:34 INFO - PROCESS | 14559 | |1;ext.html;580.4282781460264;618.7586841131958;623.7224435126368;636.9904451433232;687.8142901416621;39511.60488395115;44740.328895066516;44889.7755511222;44946.7752661237;44978.325325120146;44526.55473445264;44619.77690111553;45196;45196.32205516912;45211.54788452115;8754.781130471742;8818.559072046404;8831.823363532758;8858.202761751441;8897.466152030867;8716.520591367473;8731.781705457382;8810.86783698245;8812.206901378875;8846.5576721164;8857;8889.066648001964;8900.465972041666;8908.777280567972;8911.376203665746;8713.738587842376;8819.691310804155;8835.425697329718;8838.602262898185;8875.112488751138;8735.519546424945;8762.299016078761;8809.075047120088;8826.86759698605;8847.73456796297;33319.50020749691;42116.368254476205;42647.36028959568;42754.57245427568;42857.35713964262;3447.4484082546674;3482.2687235680537;3876.9030774230587;4161.396597493346;4206.074663574009;31745.36509269825;32042.839785801156;32465.51301730476;34127.48808767871;34535;4443.666724995606;4503.482099558527;4524.29873369625;4551.5676010778925;4569.794359253841;370521;376200;378664;379210;379793;65338;65982.67008665022;66257;66261.6747665044;66448.33551664422;36097.278054438764;36502.634973649925;36514;36673.63326366756;68342;17817.376391826485;17924.103794810206;17956.640867182585;18032.819671803376;18090;13477.865221347856;13715.519956801663;13718.93140534311;13737.587872363845;13807;21289;21373.25193618247;21438.46403839885;21495;21555.137794488044;7895.407844411692;8067.39494537912;8081.555514446762;8192.713255036046;8198;968.8934217236099;1026.3636545341935;1083.1984331594563;1112.7440688641657;1120.7534342444649;33147.17132071669;33422.66577334244;33546.161345966546;33657;33890.830545847115;990.7919336939179;1153.3022521374448;1167.9708007299716;1170.3270619393882;1231.8644949055597;16626.085565294026;16907.83092169087;17005.404810831562;17038.403655872233;17156.39952601653;600546;604864;605347;606677;607416.5920874306;47302;48747;48985;50057;50605.24092138621;1351.6485713714308;1358.9728205435836;1373.2447154065223;1377.5178687459309;1396.0227840511682;30591.847040764653;31719.207019824687;31723.20691982719;31944.201394965312;32097.94509679537;50634.49365506445;51464.22803658023;51618;51682.741586293334;51762.22356664578;407660;408636;408840;410353;410369;29585;29929.59853213916;30129.548056779604;30307.09078727642;30438;48400;48835.26747098725;48962;49783.751081244365;49786.75106624444;40064;41633.79183104186;42006.789966049975;42117.78941105275;42187.3671894928;41594.58405415907;41911.580884191986;42210.84442668496;42212.36681449842;42224.36663449989;34496.137596560286;40440.39339409852;40495;40676.79661601673;41334.79332603318;35129;37589.624103758615;37891.62108378881;38193.42709859299;38218.235635287696;27864.16407507778;28341.291467713472;28400.147995560168;28617.42765144727;28645.570316445686 05:28:34 INFO - PROCESS | 14559 | |2;jquery.html;395.5397427997854;400.9919801603966;417.4197864967695;418.30143660087657;419.7565412061003;19268.518287042833;20018.899905500453;20727.585448291044;20835.166593336267;20964.475888102806;12341.938290308535;12571.937140314309;18155.364562240324;20107.59784804303;20187.89906050468;5274.681329667593;5294.92057619136;5408.080626293539;5414.8917021659545;5429.4570542945785;3924.3328634132267;5310.6017048721305;5322.148456247001;5624.184493248476;5885.7939972100985;5933.436323549256;5941.494972927307;5943.762249510036;5947.256592925884;5983.491403230731;5521.309836270466;5826.067829147359;5849.502792262663;5879.559033072536;5896.262967129109;5621.634593751434;5702.800401985952;5707.315122185323;5715.514181294595;5745.339285982123;23142.652860207112;23699.763002369928;24291.63562546563;25168.874155629106;25236.369090772692;2338.286822519131;2360.7757263060153;2389.0443822470975;2449.5835707929696;2494.725580186178;10533.578656853717;10740.462976851126;10813.134949204044;10932.890671093266;11054.447277636085;1944.6013567218686;2044.9284275050302;2048.5185981294385;2048.907799149027;2083.677030060343;88797;91223.54388228082;92068.53965730128;92154.07845921522;93099.53450232705;11519.654410367702;11641.359725215025;11805.291682499077;11840.407979601157;11929.701757456132;16206.675866482605;16262.837371626369;16327.59181020484;16340.428085016967;16604.335826567043;7053.294670533009;7108.822279442952;8370.665173393118;8699;8795.648174072965;8381.245687888118;8486.363522735819;8527.104654011364;8707.695230667023;8726.781830454289;4922.507749225048;4951.405831300267;4994.225894986283;5089.491050894955;5099.796008159632;1766;1841.327915310902;1847.6212376462793;2099.5171110644637;2204.7354317482004;998.5955687946393;1019.2814066083394;1039.095986491757;1043.274923927878;1051.033049594375;19650.410487685393;20430.38708838737;20644.69032964507;20822.687659685118;21080.156793728078;1018;1053.6259627832162;1060.6817954613584;1101.1961268274204;1105.9935458732514;11051.668449946354;11395.829062564067;11581.826272605918;11607;11648.301101933912;476999;482906;483258;488275;491444;90508;90749;91305;91319.54340228256;91433.54283228541;1008.8284991551454;1010.777628921636;1012.0284526854156;1021.4382089850701;1033.8914413986574;17418.216180271666;17525.649487010443;18016.288452596982;18057.277708891495;18157.909210453865;42927;43851.342229867216;44967.32549011833;45117.54882451134;45258.77370613126;59923.400765991784;62428.68785656043;63142;63402.68298658662;64497.67751161214;8235.9588202061;8265.95867020661;8382.874256886029;8458.957705211435;8487.490750554987;10146.878458823225;13520;13609.594549369061;14099;14399.064060836012;12026.338551379407;12121.636350909486;12215.26708397499;12342.13605047638;12346.876531234573;11738.295702257892;11767.411629418666;12086.637400877988;12194.146409751233;12349.073819463396;12388.132830702125;12434;12442.253464792142;12549.372531373578;12591.93704031474;7779.96110019469;8371.372147089114;8450.323974082181;8460.661573537236;8486.660533578835;9317.813643727222;10676.733081673021;10764.138868890313;10976.396298203676;10983.450827458755 05:28:34 INFO - PROCESS | 14559 | |3;mootools.html;1490.6869557392947;1511.4256582498651;1651.7439796831488;1801.999999999999;1805.864560157987;8216.876746848802;8800.075992020842;9089.90910090899;9609.807803843927;9614.278929080321;8861.955690221555;9054.094590540943;9307.627694892213;9329.626814927395;9371.390859594121;2355.787979081878;2415.698037745282;2425.0178677635586;2427.0777104700187;2433.5741245282093;2371.881405929705;2400.1599440195964;2448.6327050942323;2460.667809845666;2464.3346296499935;2425.648280999254;2433.5011322678806;2455.287966489716;2465.408302007523;2476.8761561921924;2325.1513197682807;2337;2339.099446713011;2353.3410645019253;2394.5091256292417;2345.0385342009695;2348.342464110052;2361;2380.1788383007834;2383.249276477904;9049.3665443419;9075.682351117744;9092.136247056518;9126.817463650756;9160;5631.887362252773;5682.374938756733;5750.7412166452195;5752.338481074647;5752.798652047159;3488.5464889564196;3497.265574229415;3577;3586.336527742376;3602.0994751312173;1197.3953153657435;1199.142613031678;1201.7956947318976;1207.2816674078908;1221.7556488702296;12949.705029496974;12964.675883102998;13087.607371778862;13132.0807543472;13203.339833008311;4871.683340582851;4896.11869863428;4903.705777653352;4954.1825598775795;5005.299258103868;11022.779544409066;11061.612843550438;11074.667759967213;11078.0583650389;11080.168987325982;5607.775688972477;5610.074337734228;5631.352394474606;5633.183188437653;5640.238567793377;4684.391029166187;5121.155009423478;5193.221016847428;5247.501487358772;5248.475152484797;4266.1254442839145;4309.267424537836;4394.692371533962;4442.20040392726;4443.178012067778;1364.9112807667668;1385.8059871617982;1389.4646415710495;1400.8319001719858;1413.2086031822212;837.4807619276088;863.7495126413395;912.6303846942;962.3119469579284;1013.2147585621202;6275.529335299871;6294.307626161119;6366.808995730135;6491.578047426902;6499.967500162469;956.93779904306;979.7844474215661;1001.2740762946805;1035.7980193862124;1041.9322744021615;4123;4404.911901761947;4411.955880441219;4453.576910193527;4461.910761784746;11802.704932376759;11964.162508624313;12084.758304833855;12104.394780260951;12128.636140915787;11923.821142682868;11965.341906195068;11979.640610781691;11988.700282493008;11996.040316774637;8350.958245208734;8693.478391296543;8713.477191368538;8801.47191168532;8802.031776504708;6101.84745381369;6598.703058362481;6617.205935287796;6643.534952553275;6682.365175308338;10779.51492182838;11051.502682379152;11121.165912556753;11126.221164518405;11224.607138750105;11269.774604508028;11290.040346570633;11342.773144537228;11410.657680269605;11481.253718508271;7439.367653749492;8061.0326760789085;8430.241278284984;8436.409451338593;8599.355048371272;9228.861567076634;9263.16631503168;9269.490178040272;9286.164245217693;9327.533623318943;8000.959995199987;8415.158484151536;8494.70268540598;8550.05949345559;8637.784055398666;8122.7157049502985;8161;8226.259636632733;8293.460925039853;8342.708005219789;7538.133114691881;7689.42329325314;7701.4608977371045;7719.498232614862;7738.613069346397;5423.589866634625;5480.506754392124;5485.862853428536;5640.4077571856005;5674.404187560247;5663.886722265449;5764.223327695802;5771.105478650816;5797.594168408171;5816 05:28:34 INFO - PROCESS | 14559 | |4;prototype.html;344.9292894956534;349.1408251063089;349.98600055997764;353.1224906108319;353.950446937429;5658.264425624669;5757.481826635607;5764.827055188351;5805.6066544029445;5830.30036395632;5655.462731040555;5675.233843431136;5700.287464066992;5711.686766859419;5738.3974682658345;4056.553779084306;4416.050549131936;4422.690411671184;4440.533743956887;4444.733316001034;4378.861496011028;4436.489803672571;4440.86677399677;4480.596746292833;4486.349479325496;4408.933865992013;4419.779011049451;4439.178751930887;4448.866534003969;4468.709533880304;4340.131973605276;4451.9777401113115;4455.487618923833;4466.503721253384;4466.731996080245;3915.8629447969183;3948.605139486057;3957.9010524736823;3962.1679447316096;3969.503812023497;5591.580631452657;5619.522340601013;5623.634463759842;5632;5636.971815140939;4933.28467372229;5088.567471764904;5137.717425541594;5147.974260128713;5165.22521621756;5970.104484327342;5977.282726072855;5980.850478738066;6021;6037.003894357425;4357;4358.3244597087505;4367.868963931087;4371.4972778130605;4371.868843934687;5902.2622172228475;6241.282252540925;6261.311255761862;6264.373562643745;6296.496280297565;4312.137572485515;4324.697271190987;4328.5022222444195;4355.412019377407;4362.345648152803;4311.8706438806885;4376.234159022159;4385.079133381962;4387.27609944362;4406.206882761134;4964.578010869117;4982.153033984231;5020.974895125501;5021.347224860745;5025.924611130836;5894.6757928314355;6015.2781666200335;6047.334793172748;6050.909236361458;6052.364501727343;1484.5991582272725;1488.977665335021;1502.4065494129977;1525.6033431307717;1529.2124555853745;944.6079876851168;960.2030314838668;1007.7027276953316;1024.206240163864;1042.9426381548935;5684.715764211773;5710.600257981901;5710.7430165642645;5713.600047996683;5739.454751798572;6048.788292409745;6115.327313995457;6142.6314421134875;6144.170536977451;6179.907301390483;5455.645383050089;5671.177679236487;5707.315122185364;5724.599278050497;5743.942560574341;3240.4815229563155;3253.755968302387;3278.278778668689;3292.93414131716;3295.3687924477535;6045.697715114226;6335.968320158369;6341.4292713656;6403;6412.903806442907;6322.525810564226;6332.240131184288;6336.366363363627;6374.681265936684;6421.486281097501;6082;6268.905966410507;6313.338263806981;6452.35476452351;6466.64433456155;6115;6141.631502109888;6167.691615419121;6186.845328866814;6190.442860142609;6055.303640081447;6144.385561443999;6149.139120523219;6166.150154953406;6180.907286390618;6150.446459818638;6343.175387199634;6370.458511026614;6381.457576106083;6386.552941294065;4243.596858298457;4350.412694286231;4366.563343665608;4367.912641747083;4394.648428125678;5992.161097446274;6172.993777022396;6207.075806499999;6242.470594704327;6269.592476489013;5943.58394912352;5953.702314884152;5960.6588517583195;6009.519238461;6017.759289628366;5898.144769008384;6019.307779605227;6030.276366836008;6036.547258955684;6037.275526936795;5808.477237048686;5940.762369505172;5947.226860508106;5961;5980.461758441761;6041.9395806041375;6043.637381756933;6054.878902422015;6085.208922840003;6093.390660933871;5744.482996530165;5868.413158684098;5897.498712609305;5913.083472061838;5940.6435613863305 05:28:34 INFO - PROCESS | 14559 | |5;yui.html;666.4568376772929;700.5061431690658;739.9519031262968;753.834156485573;810.282899633824;16662.91668541657;17144.142792860337;17286;17292.048937308442;17331.046792426427;17206.82793172068;17218.053007084607;17226.655466890654;17260.82739172611;17320;662.5031226580065;813.6541969662884;835.7826964989085;837.3092198935872;839.9034111077243;800.2517646001007;824.5588610093602;825.0470706334194;827.6937533112757;829.17911267845;866.9436486628349;877.4252864373846;882.6248844241172;884.4737381258141;885.4465958775766;869.3566760597175;870.3689824876946;874.7725591346232;875.2560323724815;880.5773228850123;636.6275728698716;639.5555089212999;640.9871802563969;642.0369445831253;642.9389208025231;15479.922600386926;15485.767713484307;15486.767698484531;15591.766123508156;15619.29713162899;14614.415423383052;14681.926590367086;14694.853051469456;14730.55808325752;14892.553223403314;11462.885371146265;11468.885311146865;11494.885051149466;11511.424428778528;11528.538858445652;3704.722145839046;3772.358699021173;3794.051487128218;3898.2203559288255;3898.2788184186015;79462.20537794605;80513.59743201305;81006.59496702538;82407;82578.58710706409;11491.942540287246;11511.48198331077;11592.88407115918;11617.070634349231;11811.822822657667;20662.276820311217;20901.059452324684;21861.12555497794;21862.89068554647;21888.562228755334;8586.055533891267;9143.725688229364;9229.861552076723;9683.176929961031;9828.967958364268;4883.975580122148;4981.875453113701;4999.600031997505;5001.524855138756;5095.923561146512;3651.72612054097;3753.981230093832;3766.152615661454;3773.962260377416;4065.89835254121;706.1455638677259;716.6094478509225;720.3013077314996;728.1517032657001;732.0702707561368;641.6150309814168;670.580886945659;682.1098466501263;686.2031577227569;700.3626699703245;9383.577739001761;9520.90479095214;9560.952195238979;9763.755906102262;10125.240606954509;632.253940350391;644.1046944746805;659.2385794407467;686.8626274745071;687.08274453604;4553.772311384418;4775.21209000511;4863.221884498464;4896.975515122473;4920.6801557898625;95228;118500;125813.37093314658;132611.3369433166;135092;113418.43290783493;114112.42943785393;114352;116114.41942790232;119605;66675.33259672885;87121.56439217764;94651;96307;98243;9349.57926893305;9393.248540116638;9418.88873900201;9423.434593924387;9469.053094690476;58124.4187558119;58804.41195587989;59587.657727917256;60057.39942600693;61435;80642.19357806347;81602;87352;89999.55000224957;90010;11957.162998590014;12035.75928481443;12306.446209920396;12355.073369497504;12533.185342952678;12990.415431305802;13096.345182741015;13114.278714670403;13187;13277.933610331887;12077.27536347822;12228.694282643006;12605.117641765355;12727.618171454871;13143.34283285851;12221.633350999484;12518.436670350038;12527.749445011232;12569.371531423576;12943.935280323538;11375.374354410587;11572.94213528927;11605.767884642091;11619.825702614298;11744.823827642764;9460.668876589287;9564.521773911416;9763.902360976299;9835.65575204893;10003.249756268164;9597.616095356108;10219.897801021894;10386.74033149147;10388.792224155626;10391.948040259751 05:28:34 INFO - PROCESS | 14559 | __end_tp_report 05:28:34 INFO - PROCESS | 14559 | __start_cc_report 05:28:34 INFO - PROCESS | 14559 | _x_x_mozilla_cycle_collect,348 05:28:34 INFO - PROCESS | 14559 | __end_cc_report 05:28:34 INFO - PROCESS | 14559 | __startTimestamp1467462514565__endTimestamp 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | ------- Summary: start ------- 05:28:34 INFO - PROCESS | 14559 | Number of tests: 6 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#0] dojo.html Cycles:165 Average:5502.66 Median:5790.31 stddev:767.00 (13.2%) stddev-sans-first:746.34 05:28:34 INFO - PROCESS | 14559 | Values: 3125.4 3171.2 3190.3 3196.5 3211.0 5491.4 5541.4 5573.2 5576.6 5648.1 5389.5 5515.7 5559.7 5567.4 5588.1 4996.1 5050.4 5136.8 5200.5 5244.4 692.0 4963.1 4968.3 5086.0 5091.1 4971.6 4989.8 5009.8 5020.0 5031.0 4975.8 4981.2 5006.3 5018.5 5030.8 5004.9 5065.8 5072.1 5092.1 5093.6 5529.9 5621.3 5621.3 5630.6 5630.9 5838.1 5905.6 5975.9 5999.0 6038.7 5891.6 5931.9 5972.3 5978.2 6005.3 5517.1 5519.9 5533.7 5536.9 5537.3 5955.9 6059.3 6073.4 6121.2 6141.2 5780.0 5780.1 5796.6 5841.3 5857.1 5906.3 5908.1 5908.5 5910.5 5936.4 5859.8 5959.1 6011.2 6029.1 6063.2 5991.8 6020.9 6060.7 6075.2 6078.5 4297.4 4441.7 4450.3 4457.2 4489.0 3863.7 3885.6 3888.0 3900.5 3908.5 5538.4 5599.6 5631.7 5635.6 5643.6 5935.6 6016.9 6025.4 6029.8 6032.4 5461.8 5591.0 5622.9 5630.0 5648.7 4953.6 4959.8 4960.0 4963.2 4992.8 6076.1 6179.8 6189.3 6199.5 6213.7 5924.5 5955.3 5972.4 6049.1 6059.5 6186.0 6188.9 6203.3 6211.9 6213.2 5620.9 5840.8 5862.0 5868.5 5882.0 5999.5 6084.5 6098.3 6142.4 6142.5 5927.4 5939.3 5940.3 5952.1 5952.3 5694.2 5754.2 5868.5 5907.6 5909.0 5790.3 5847.4 5857.4 5886.7 5913.7 5925.4 5943.7 5959.7 5972.0 5972.1 5609.0 5723.5 5762.8 5815.9 5817.7 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#1] ext.html Cycles:180 Average:61973.33 Median:41772.69 stddev:126158.99 (302.0%) stddev-sans-first:126428.70 05:28:34 INFO - PROCESS | 14559 | Values: 580.4 618.8 623.7 637.0 687.8 39511.6 44740.3 44889.8 44946.8 44978.3 44526.6 44619.8 45196.0 45196.3 45211.5 8754.8 8818.6 8831.8 8858.2 8897.5 8716.5 8731.8 8810.9 8812.2 8846.6 8857.0 8889.1 8900.5 8908.8 8911.4 8713.7 8819.7 8835.4 8838.6 8875.1 8735.5 8762.3 8809.1 8826.9 8847.7 33319.5 42116.4 42647.4 42754.6 42857.4 3447.4 3482.3 3876.9 4161.4 4206.1 31745.4 32042.8 32465.5 34127.5 34535.0 4443.7 4503.5 4524.3 4551.6 4569.8 370521.0 376200.0 378664.0 379210.0 379793.0 65338.0 65982.7 66257.0 66261.7 66448.3 36097.3 36502.6 36514.0 36673.6 68342.0 17817.4 17924.1 17956.6 18032.8 18090.0 13477.9 13715.5 13718.9 13737.6 13807.0 21289.0 21373.3 21438.5 21495.0 21555.1 7895.4 8067.4 8081.6 8192.7 8198.0 968.9 1026.4 1083.2 1112.7 1120.8 33147.2 33422.7 33546.2 33657.0 33890.8 990.8 1153.3 1168.0 1170.3 1231.9 16626.1 16907.8 17005.4 17038.4 17156.4 600546.0 604864.0 605347.0 606677.0 607416.6 47302.0 48747.0 48985.0 50057.0 50605.2 1351.6 1359.0 1373.2 1377.5 1396.0 30591.8 31719.2 31723.2 31944.2 32097.9 50634.5 51464.2 51618.0 51682.7 51762.2 407660.0 408636.0 408840.0 410353.0 410369.0 29585.0 29929.6 30129.5 30307.1 30438.0 48400.0 48835.3 48962.0 49783.8 49786.8 40064.0 41633.8 42006.8 42117.8 42187.4 41594.6 41911.6 42210.8 42212.4 42224.4 34496.1 40440.4 40495.0 40676.8 41334.8 35129.0 37589.6 37891.6 38193.4 38218.2 27864.2 28341.3 28400.1 28617.4 28645.6 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#2] jquery.html Cycles:180 Average:29469.40 Median:13030.27 stddev:80161.43 (615.2%) stddev-sans-first:80356.58 05:28:34 INFO - PROCESS | 14559 | Values: 395.5 401.0 417.4 418.3 419.8 19268.5 20018.9 20727.6 20835.2 20964.5 12341.9 12571.9 18155.4 20107.6 20187.9 5274.7 5294.9 5408.1 5414.9 5429.5 3924.3 5310.6 5322.1 5624.2 5885.8 5933.4 5941.5 5943.8 5947.3 5983.5 5521.3 5826.1 5849.5 5879.6 5896.3 5621.6 5702.8 5707.3 5715.5 5745.3 23142.7 23699.8 24291.6 25168.9 25236.4 2338.3 2360.8 2389.0 2449.6 2494.7 10533.6 10740.5 10813.1 10932.9 11054.4 1944.6 2044.9 2048.5 2048.9 2083.7 88797.0 91223.5 92068.5 92154.1 93099.5 11519.7 11641.4 11805.3 11840.4 11929.7 16206.7 16262.8 16327.6 16340.4 16604.3 7053.3 7108.8 8370.7 8699.0 8795.6 8381.2 8486.4 8527.1 8707.7 8726.8 4922.5 4951.4 4994.2 5089.5 5099.8 1766.0 1841.3 1847.6 2099.5 2204.7 998.6 1019.3 1039.1 1043.3 1051.0 19650.4 20430.4 20644.7 20822.7 21080.2 1018.0 1053.6 1060.7 1101.2 1106.0 11051.7 11395.8 11581.8 11607.0 11648.3 476999.0 482906.0 483258.0 488275.0 491444.0 90508.0 90749.0 91305.0 91319.5 91433.5 1008.8 1010.8 1012.0 1021.4 1033.9 17418.2 17525.6 18016.3 18057.3 18157.9 42927.0 43851.3 44967.3 45117.5 45258.8 59923.4 62428.7 63142.0 63402.7 64497.7 8236.0 8266.0 8382.9 8459.0 8487.5 10146.9 13520.0 13609.6 14099.0 14399.1 12026.3 12121.6 12215.3 12342.1 12346.9 11738.3 11767.4 12086.6 12194.1 12349.1 12388.1 12434.0 12442.3 12549.4 12591.9 7780.0 8371.4 8450.3 8460.7 8486.7 9317.8 10676.7 10764.1 10976.4 10983.5 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#3] mootools.html Cycles:180 Average:6233.50 Median:4883.90 stddev:3580.58 (73.3%) stddev-sans-first:3572.88 05:28:34 INFO - PROCESS | 14559 | Values: 1490.7 1511.4 1651.7 1802.0 1805.9 8216.9 8800.1 9089.9 9609.8 9614.3 8862.0 9054.1 9307.6 9329.6 9371.4 2355.8 2415.7 2425.0 2427.1 2433.6 2371.9 2400.2 2448.6 2460.7 2464.3 2425.6 2433.5 2455.3 2465.4 2476.9 2325.2 2337.0 2339.1 2353.3 2394.5 2345.0 2348.3 2361.0 2380.2 2383.2 9049.4 9075.7 9092.1 9126.8 9160.0 5631.9 5682.4 5750.7 5752.3 5752.8 3488.5 3497.3 3577.0 3586.3 3602.1 1197.4 1199.1 1201.8 1207.3 1221.8 12949.7 12964.7 13087.6 13132.1 13203.3 4871.7 4896.1 4903.7 4954.2 5005.3 11022.8 11061.6 11074.7 11078.1 11080.2 5607.8 5610.1 5631.4 5633.2 5640.2 4684.4 5121.2 5193.2 5247.5 5248.5 4266.1 4309.3 4394.7 4442.2 4443.2 1364.9 1385.8 1389.5 1400.8 1413.2 837.5 863.7 912.6 962.3 1013.2 6275.5 6294.3 6366.8 6491.6 6500.0 956.9 979.8 1001.3 1035.8 1041.9 4123.0 4404.9 4412.0 4453.6 4461.9 11802.7 11964.2 12084.8 12104.4 12128.6 11923.8 11965.3 11979.6 11988.7 11996.0 8351.0 8693.5 8713.5 8801.5 8802.0 6101.8 6598.7 6617.2 6643.5 6682.4 10779.5 11051.5 11121.2 11126.2 11224.6 11269.8 11290.0 11342.8 11410.7 11481.3 7439.4 8061.0 8430.2 8436.4 8599.4 9228.9 9263.2 9269.5 9286.2 9327.5 8001.0 8415.2 8494.7 8550.1 8637.8 8122.7 8161.0 8226.3 8293.5 8342.7 7538.1 7689.4 7701.5 7719.5 7738.6 5423.6 5480.5 5485.9 5640.4 5674.4 5663.9 5764.2 5771.1 5797.6 5816.0 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#4] prototype.html Cycles:180 Average:5046.62 Median:5731.50 stddev:1494.45 (26.1%) stddev-sans-first:1456.38 05:28:34 INFO - PROCESS | 14559 | Values: 344.9 349.1 350.0 353.1 354.0 5658.3 5757.5 5764.8 5805.6 5830.3 5655.5 5675.2 5700.3 5711.7 5738.4 4056.6 4416.1 4422.7 4440.5 4444.7 4378.9 4436.5 4440.9 4480.6 4486.3 4408.9 4419.8 4439.2 4448.9 4468.7 4340.1 4452.0 4455.5 4466.5 4466.7 3915.9 3948.6 3957.9 3962.2 3969.5 5591.6 5619.5 5623.6 5632.0 5637.0 4933.3 5088.6 5137.7 5148.0 5165.2 5970.1 5977.3 5980.9 6021.0 6037.0 4357.0 4358.3 4367.9 4371.5 4371.9 5902.3 6241.3 6261.3 6264.4 6296.5 4312.1 4324.7 4328.5 4355.4 4362.3 4311.9 4376.2 4385.1 4387.3 4406.2 4964.6 4982.2 5021.0 5021.3 5025.9 5894.7 6015.3 6047.3 6050.9 6052.4 1484.6 1489.0 1502.4 1525.6 1529.2 944.6 960.2 1007.7 1024.2 1042.9 5684.7 5710.6 5710.7 5713.6 5739.5 6048.8 6115.3 6142.6 6144.2 6179.9 5455.6 5671.2 5707.3 5724.6 5743.9 3240.5 3253.8 3278.3 3292.9 3295.4 6045.7 6336.0 6341.4 6403.0 6412.9 6322.5 6332.2 6336.4 6374.7 6421.5 6082.0 6268.9 6313.3 6452.4 6466.6 6115.0 6141.6 6167.7 6186.8 6190.4 6055.3 6144.4 6149.1 6166.2 6180.9 6150.4 6343.2 6370.5 6381.5 6386.6 4243.6 4350.4 4366.6 4367.9 4394.6 5992.2 6173.0 6207.1 6242.5 6269.6 5943.6 5953.7 5960.7 6009.5 6017.8 5898.1 6019.3 6030.3 6036.5 6037.3 5808.5 5940.8 5947.2 5961.0 5980.5 6041.9 6043.6 6054.9 6085.2 6093.4 5744.5 5868.4 5897.5 5913.1 5940.6 05:28:34 INFO - PROCESS | 14559 | 05:28:34 INFO - PROCESS | 14559 | [#5] yui.html Cycles:180 Average:22112.40 Median:4951.28 stddev:33145.47 (669.4%) stddev-sans-first:33199.33 05:28:34 INFO - PROCESS | 14559 | Values: 666.5 700.5 740.0 753.8 810.3 16662.9 17144.1 17286.0 17292.0 17331.0 17206.8 17218.1 17226.7 17260.8 17320.0 662.5 813.7 835.8 837.3 839.9 800.3 824.6 825.0 827.7 829.2 866.9 877.4 882.6 884.5 885.4 869.4 870.4 874.8 875.3 880.6 636.6 639.6 641.0 642.0 642.9 15479.9 15485.8 15486.8 15591.8 15619.3 14614.4 14681.9 14694.9 14730.6 14892.6 11462.9 11468.9 11494.9 11511.4 11528.5 3704.7 3772.4 3794.1 3898.2 3898.3 79462.2 80513.6 81006.6 82407.0 82578.6 11491.9 11511.5 11592.9 11617.1 11811.8 20662.3 20901.1 21861.1 21862.9 21888.6 8586.1 9143.7 9229.9 9683.2 9829.0 4884.0 4981.9 4999.6 5001.5 5095.9 3651.7 3754.0 3766.2 3774.0 4065.9 706.1 716.6 720.3 728.2 732.1 641.6 670.6 682.1 686.2 700.4 9383.6 9520.9 9561.0 9763.8 10125.2 632.3 644.1 659.2 686.9 687.1 4553.8 4775.2 4863.2 4897.0 4920.7 95228.0 118500.0 125813.4 132611.3 135092.0 113418.4 114112.4 114352.0 116114.4 119605.0 66675.3 87121.6 94651.0 96307.0 98243.0 9349.6 9393.2 9418.9 9423.4 9469.1 58124.4 58804.4 59587.7 60057.4 61435.0 80642.2 81602.0 87352.0 89999.6 90010.0 11957.2 12035.8 12306.4 12355.1 12533.2 12990.4 13096.3 13114.3 13187.0 13277.9 12077.3 12228.7 12605.1 12727.6 13143.3 12221.6 12518.4 12527.7 12569.4 12943.9 11375.4 11572.9 11605.8 11619.8 11744.8 9460.7 9564.5 9763.9 9835.7 10003.2 9597.6 10219.9 10386.7 10388.8 10391.9 05:28:34 INFO - PROCESS | 14559 | -------- Summary: end -------- 05:28:34 INFO - PROCESS | 14559 | 05:28:35 INFO - TEST-INFO | 14559: exit 0 05:28:35 INFO - TEST-OK | dromaeo_css | took 1110971ms 05:28:35 INFO - TEST-START | kraken 05:28:35 INFO - operating with platform_type : linux_ 05:28:35 INFO - Initialising browser for kraken test... 05:28:35 INFO - TEST-INFO | started process 14803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIlznz/profile http://localhost:40350/getInfo.html) 05:28:39 INFO - PROCESS | 14803 | __metrics Screen width/height:1600/1200 05:28:39 INFO - PROCESS | 14803 | colorDepth:24 05:28:39 INFO - PROCESS | 14803 | Browser inner width/height: 1024/697 05:28:39 INFO - PROCESS | 14803 | __metrics 05:28:40 ERROR - PROCESS | 14803 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:28:41 INFO - TEST-INFO | 14803: exit 0 05:28:41 INFO - Browser initialized. 05:28:41 INFO - Running cycle 1/1 for kraken test... 05:28:41 INFO - TEST-INFO | started process 14927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKIlznz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:52 INFO - PROCESS | 14927 | RSS: Main: 168771584 05:28:52 INFO - PROCESS | 14927 | 05:28:55 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40350/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:56 INFO - PROCESS | 14927 | RSS: Main: 174579712 05:28:56 INFO - PROCESS | 14927 | 05:28:58 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40350/tests/kraken/driver.html?testName=audio-dft) 05:28:59 INFO - PROCESS | 14927 | RSS: Main: 173383680 05:28:59 INFO - PROCESS | 14927 | 05:29:02 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40350/tests/kraken/driver.html?testName=audio-fft) 05:29:02 INFO - PROCESS | 14927 | RSS: Main: 168022016 05:29:02 INFO - PROCESS | 14927 | 05:29:05 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40350/tests/kraken/driver.html?testName=audio-oscillator) 05:29:05 INFO - PROCESS | 14927 | RSS: Main: 168845312 05:29:05 INFO - PROCESS | 14927 | 05:29:07 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:08 INFO - PROCESS | 14927 | RSS: Main: 169365504 05:29:08 INFO - PROCESS | 14927 | 05:29:11 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40350/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:12 INFO - PROCESS | 14927 | RSS: Main: 169443328 05:29:12 INFO - PROCESS | 14927 | 05:29:15 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40350/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:16 INFO - PROCESS | 14927 | RSS: Main: 167440384 05:29:16 INFO - PROCESS | 14927 | 05:29:19 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40350/tests/kraken/driver.html?testName=json-parse-financial) 05:29:19 INFO - PROCESS | 14927 | RSS: Main: 168644608 05:29:19 INFO - PROCESS | 14927 | 05:29:21 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:21 INFO - PROCESS | 14927 | RSS: Main: 168865792 05:29:21 INFO - PROCESS | 14927 | 05:29:23 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:24 INFO - PROCESS | 14927 | RSS: Main: 169422848 05:29:24 INFO - PROCESS | 14927 | 05:29:26 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:27 INFO - PROCESS | 14927 | RSS: Main: 169836544 05:29:27 INFO - PROCESS | 14927 | 05:29:29 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:30 INFO - PROCESS | 14927 | RSS: Main: 170156032 05:29:30 INFO - PROCESS | 14927 | 05:29:32 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:33 INFO - PROCESS | 14927 | RSS: Main: 170205184 05:29:33 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:40350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40350/tests/kraken/driver.html?testName=ai-astar) 05:29:35 INFO - PROCESS | 14927 | RSS: Main: 171188224 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | __start_tp_report 05:29:35 INFO - PROCESS | 14927 | _x_x_mozilla_page_load 05:29:35 INFO - PROCESS | 14927 | _x_x_mozilla_page_load_details 05:29:35 INFO - PROCESS | 14927 | |i|pagename|runs| 05:29:35 INFO - PROCESS | 14927 | |0;ai-astar;105;112;108;120;110;112;112;110;112;110 05:29:35 INFO - PROCESS | 14927 | |1;audio-beat-detection;147;118;145;175;123;151;152;116;177;124 05:29:35 INFO - PROCESS | 14927 | |2;audio-dft;161;164;162;163;163;163;177;166;163;161 05:29:35 INFO - PROCESS | 14927 | |3;audio-fft;76;74;75;160;76;75;74;75;171;74 05:29:35 INFO - PROCESS | 14927 | |4;audio-oscillator;83;83;150;85;83;83;146;84;85;139 05:29:35 INFO - PROCESS | 14927 | |5;imaging-gaussian-blur;118;117;117;118;119;118;117;117;118;117 05:29:35 INFO - PROCESS | 14927 | |6;imaging-darkroom;146;148;148;148;149;148;147;148;147;148 05:29:35 INFO - PROCESS | 14927 | |7;imaging-desaturate;97;97;95;96;96;96;96;96;95;95 05:29:35 INFO - PROCESS | 14927 | |8;json-parse-financial;54;55;54;54;56;57;53;54;62;61 05:29:35 INFO - PROCESS | 14927 | |9;json-stringify-tinderbox;60;60;61;61;62;61;61;61;61;61 05:29:35 INFO - PROCESS | 14927 | |10;stanford-crypto-aes;82;75;84;75;74;77;81;75;79;74 05:29:35 INFO - PROCESS | 14927 | |11;stanford-crypto-ccm;128;130;133;118;136;122;122;120;183;146 05:29:35 INFO - PROCESS | 14927 | |12;stanford-crypto-pbkdf2;158;156;155;153;158;156;157;153;154;152 05:29:35 INFO - PROCESS | 14927 | |13;stanford-crypto-sha256-iterative;64;64;63;62;66;65;62;61;62;67 05:29:35 INFO - PROCESS | 14927 | __end_tp_report 05:29:35 INFO - PROCESS | 14927 | __start_cc_report 05:29:35 INFO - PROCESS | 14927 | _x_x_mozilla_cycle_collect,921 05:29:35 INFO - PROCESS | 14927 | __end_cc_report 05:29:35 INFO - PROCESS | 14927 | __startTimestamp1467462575504__endTimestamp 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | ------- Summary: start ------- 05:29:35 INFO - PROCESS | 14927 | Number of tests: 14 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.84 (3.4%) stddev-sans-first:3.38 05:29:35 INFO - PROCESS | 14927 | Values: 105.0 112.0 108.0 120.0 110.0 112.0 112.0 110.0 112.0 110.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.00 stddev:22.26 (14.9%) stddev-sans-first:23.56 05:29:35 INFO - PROCESS | 14927 | Values: 147.0 118.0 145.0 175.0 123.0 151.0 152.0 116.0 177.0 124.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.69 (2.9%) stddev-sans-first:4.82 05:29:35 INFO - PROCESS | 14927 | Values: 161.0 164.0 162.0 163.0 163.0 163.0 177.0 166.0 163.0 161.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:38.31 (51.1%) stddev-sans-first:40.13 05:29:35 INFO - PROCESS | 14927 | Values: 76.0 74.0 75.0 160.0 76.0 75.0 74.0 75.0 171.0 74.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.00 stddev:29.73 (35.8%) stddev-sans-first:30.72 05:29:35 INFO - PROCESS | 14927 | Values: 83.0 83.0 150.0 85.0 83.0 83.0 146.0 84.0 85.0 139.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:29:35 INFO - PROCESS | 14927 | Values: 118.0 117.0 117.0 118.0 119.0 118.0 117.0 117.0 118.0 117.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 05:29:35 INFO - PROCESS | 14927 | Values: 146.0 148.0 148.0 148.0 149.0 148.0 147.0 148.0 147.0 148.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 05:29:35 INFO - PROCESS | 14927 | Values: 97.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.13 (5.6%) stddev-sans-first:3.23 05:29:35 INFO - PROCESS | 14927 | Values: 54.0 55.0 54.0 54.0 56.0 57.0 53.0 54.0 62.0 61.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 05:29:35 INFO - PROCESS | 14927 | Values: 60.0 60.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:3.66 (4.7%) stddev-sans-first:3.52 05:29:35 INFO - PROCESS | 14927 | Values: 82.0 75.0 84.0 75.0 74.0 77.0 81.0 75.0 79.0 74.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:131.50 stddev:19.27 (14.7%) stddev-sans-first:20.32 05:29:35 INFO - PROCESS | 14927 | Values: 128.0 130.0 133.0 118.0 136.0 122.0 122.0 120.0 183.0 146.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:2.15 (1.4%) stddev-sans-first:2.03 05:29:35 INFO - PROCESS | 14927 | Values: 158.0 156.0 155.0 153.0 158.0 156.0 157.0 153.0 154.0 152.0 05:29:35 INFO - PROCESS | 14927 | 05:29:35 INFO - PROCESS | 14927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.96 (3.1%) stddev-sans-first:2.07 05:29:35 INFO - PROCESS | 14927 | Values: 64.0 64.0 63.0 62.0 66.0 65.0 62.0 61.0 62.0 67.0 05:29:35 INFO - PROCESS | 14927 | -------- Summary: end -------- 05:29:35 INFO - PROCESS | 14927 | 05:29:36 INFO - TEST-INFO | 14927: exit 0 05:29:36 INFO - TEST-OK | kraken | took 61279ms 05:29:36 INFO - SUITE-END | took 1172s 05:29:36 INFO - Completed test suite (00:19:32) 05:29:36 INFO - javascript benchmark 05:29:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7524.132645138063, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.4061728271627, 3171.2389026633587, 3190.3300306935535, 3196.4566023775956, 3211.0206387051967, 5491.3684926233445, 5541.445855414461, 5573.164025396188, 5576.609637325379, 5648.124540696199, 5389.487998640133, 5515.7242137893145, 5559.694216818073, 5567.415421380758, 5588.050031494646, 4996.100701873661, 5050.419201791786, 5136.845894623168, 5200.531952124308, 5244.449332820056, 691.991718243116, 4963.057019166365, 4968.254761785743, 5085.982803439309, 5091.083604951107, 4971.577415919651, 4989.75051247438, 5009.849704508889, 5020.0, 5031.044101620699, 4975.776090075955, 4981.227909674007, 5006.299118123466, 5018.548330650223, 5030.773615187325, 5004.924926126111, 5065.797368105272, 5072.0870243356185, 5092.057969275659, 5093.592512598983, 5529.944700552983, 5621.297337832771, 5621.297337832771, 5630.634008789416, 5630.859228519279, 5838.124281357788, 5905.645661260338, 5975.894459524959, 5999.044928170619, 6038.698065096728, 5891.586019355366, 5931.851703707399, 5972.25346831646, 5978.2228310319815, 6005.279366476007, 5517.117261238222, 5519.944800551943, 5533.6956467394275, 5536.861578460531, 5537.307836520435, 5955.851103722442, 6059.303180134253, 6073.423024812636, 6121.173641558422, 6141.170941922784, 5780.0, 5780.104083867007, 5796.594238403271, 5841.2990441146485, 5857.062869940789, 5906.320773111147, 5908.05471124618, 5908.527317814651, 5910.468057874812, 5936.436038576328, 5859.824205273849, 5959.106134079922, 6011.248593925759, 6029.065494848305, 6063.151158837766, 5991.7603295867675, 6020.909686354708, 6060.696965151725, 6075.179850720185, 6078.544109191828, 4297.376880352332, 4441.733495990251, 4450.310201918708, 4457.2199865023495, 4489.012417268195, 3863.690904727615, 3885.592012838668, 3887.9611203888167, 3900.4539364488996, 3908.5309762828642, 5538.44615538451, 5599.580031497654, 5631.690257035821, 5635.5773317001385, 5643.633163844337, 5935.643861368331, 6016.909746353808, 6025.397460253939, 6029.758809647653, 6032.426919442733, 5461.754221060062, 5591.049521581341, 5622.943770562242, 5629.971850140723, 5648.661080335193, 4953.578945789576, 4959.752012399365, 4960.0, 4963.205887058053, 4992.8002879885125, 6076.058210977306, 6179.783707570304, 6189.288231853305, 6199.473044791153, 6213.689315534296, 5924.496417804535, 5955.255593050869, 5972.372900845348, 6049.122877182695, 6059.545534084873, 6186.041163619466, 6188.907166392418, 6203.255609326729, 6211.9068213975925, 6213.161223234986, 5620.8875822482505, 5840.795572154954, 5862.0, 5868.471837534642, 5882.0, 5999.460048595647, 6084.513238940963, 6098.32918378969, 6142.385761423822, 6142.539309551712, 5927.377625349449, 5939.316978547522, 5940.287165540163, 5952.136940143741, 5952.285725712942, 5694.17434471991, 5754.19441278213, 5868.501177399969, 5907.645541267538, 5908.970455147697, 5790.305163380252, 5847.356790753099, 5857.414258574108, 5886.705664716661, 5913.733881975408, 5925.4370834770625, 5943.732532035982, 5959.67221802805, 5971.970140149445, 5972.104184372379, 5609.018421776254, 5723.456271654186, 5762.798302059407, 5815.883682326415, 5817.680027598522], "value": 5449.2986150673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4282781460264, 618.7586841131958, 623.7224435126368, 636.9904451433232, 687.8142901416621, 39511.60488395115, 44740.328895066516, 44889.7755511222, 44946.7752661237, 44978.325325120146, 44526.55473445264, 44619.77690111553, 45196.0, 45196.32205516912, 45211.54788452115, 8754.781130471742, 8818.559072046404, 8831.823363532758, 8858.202761751441, 8897.466152030867, 8716.520591367473, 8731.781705457382, 8810.86783698245, 8812.206901378875, 8846.5576721164, 8857.0, 8889.066648001964, 8900.465972041666, 8908.777280567972, 8911.376203665746, 8713.738587842376, 8819.691310804155, 8835.425697329718, 8838.602262898185, 8875.112488751138, 8735.519546424945, 8762.299016078761, 8809.075047120088, 8826.86759698605, 8847.73456796297, 33319.50020749691, 42116.368254476205, 42647.36028959568, 42754.57245427568, 42857.35713964262, 3447.4484082546674, 3482.2687235680537, 3876.9030774230587, 4161.396597493346, 4206.074663574009, 31745.36509269825, 32042.839785801156, 32465.51301730476, 34127.48808767871, 34535.0, 4443.666724995606, 4503.482099558527, 4524.29873369625, 4551.5676010778925, 4569.794359253841, 370521.0, 376200.0, 378664.0, 379210.0, 379793.0, 65338.0, 65982.67008665022, 66257.0, 66261.6747665044, 66448.33551664422, 36097.278054438764, 36502.634973649925, 36514.0, 36673.63326366756, 68342.0, 17817.376391826485, 17924.103794810206, 17956.640867182585, 18032.819671803376, 18090.0, 13477.865221347856, 13715.519956801663, 13718.93140534311, 13737.587872363845, 13807.0, 21289.0, 21373.25193618247, 21438.46403839885, 21495.0, 21555.137794488044, 7895.407844411692, 8067.39494537912, 8081.555514446762, 8192.713255036046, 8198.0, 968.8934217236099, 1026.3636545341935, 1083.1984331594563, 1112.7440688641657, 1120.7534342444649, 33147.17132071669, 33422.66577334244, 33546.161345966546, 33657.0, 33890.830545847115, 990.7919336939179, 1153.3022521374448, 1167.9708007299716, 1170.3270619393882, 1231.8644949055597, 16626.085565294026, 16907.83092169087, 17005.404810831562, 17038.403655872233, 17156.39952601653, 600546.0, 604864.0, 605347.0, 606677.0, 607416.5920874306, 47302.0, 48747.0, 48985.0, 50057.0, 50605.24092138621, 1351.6485713714308, 1358.9728205435836, 1373.2447154065223, 1377.5178687459309, 1396.0227840511682, 30591.847040764653, 31719.207019824687, 31723.20691982719, 31944.201394965312, 32097.94509679537, 50634.49365506445, 51464.22803658023, 51618.0, 51682.741586293334, 51762.22356664578, 407660.0, 408636.0, 408840.0, 410353.0, 410369.0, 29585.0, 29929.59853213916, 30129.548056779604, 30307.09078727642, 30438.0, 48400.0, 48835.26747098725, 48962.0, 49783.751081244365, 49786.75106624444, 40064.0, 41633.79183104186, 42006.789966049975, 42117.78941105275, 42187.3671894928, 41594.58405415907, 41911.580884191986, 42210.84442668496, 42212.36681449842, 42224.36663449989, 34496.137596560286, 40440.39339409852, 40495.0, 40676.79661601673, 41334.79332603318, 35129.0, 37589.624103758615, 37891.62108378881, 38193.42709859299, 38218.235635287696, 27864.16407507778, 28341.291467713472, 28400.147995560168, 28617.42765144727, 28645.570316445686], "value": 20411.052017367143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.5397427997854, 400.9919801603966, 417.4197864967695, 418.30143660087657, 419.7565412061003, 19268.518287042833, 20018.899905500453, 20727.585448291044, 20835.166593336267, 20964.475888102806, 12341.938290308535, 12571.937140314309, 18155.364562240324, 20107.59784804303, 20187.89906050468, 5274.681329667593, 5294.92057619136, 5408.080626293539, 5414.8917021659545, 5429.4570542945785, 3924.3328634132267, 5310.6017048721305, 5322.148456247001, 5624.184493248476, 5885.7939972100985, 5933.436323549256, 5941.494972927307, 5943.762249510036, 5947.256592925884, 5983.491403230731, 5521.309836270466, 5826.067829147359, 5849.502792262663, 5879.559033072536, 5896.262967129109, 5621.634593751434, 5702.800401985952, 5707.315122185323, 5715.514181294595, 5745.339285982123, 23142.652860207112, 23699.763002369928, 24291.63562546563, 25168.874155629106, 25236.369090772692, 2338.286822519131, 2360.7757263060153, 2389.0443822470975, 2449.5835707929696, 2494.725580186178, 10533.578656853717, 10740.462976851126, 10813.134949204044, 10932.890671093266, 11054.447277636085, 1944.6013567218686, 2044.9284275050302, 2048.5185981294385, 2048.907799149027, 2083.677030060343, 88797.0, 91223.54388228082, 92068.53965730128, 92154.07845921522, 93099.53450232705, 11519.654410367702, 11641.359725215025, 11805.291682499077, 11840.407979601157, 11929.701757456132, 16206.675866482605, 16262.837371626369, 16327.59181020484, 16340.428085016967, 16604.335826567043, 7053.294670533009, 7108.822279442952, 8370.665173393118, 8699.0, 8795.648174072965, 8381.245687888118, 8486.363522735819, 8527.104654011364, 8707.695230667023, 8726.781830454289, 4922.507749225048, 4951.405831300267, 4994.225894986283, 5089.491050894955, 5099.796008159632, 1766.0, 1841.327915310902, 1847.6212376462793, 2099.5171110644637, 2204.7354317482004, 998.5955687946393, 1019.2814066083394, 1039.095986491757, 1043.274923927878, 1051.033049594375, 19650.410487685393, 20430.38708838737, 20644.69032964507, 20822.687659685118, 21080.156793728078, 1018.0, 1053.6259627832162, 1060.6817954613584, 1101.1961268274204, 1105.9935458732514, 11051.668449946354, 11395.829062564067, 11581.826272605918, 11607.0, 11648.301101933912, 476999.0, 482906.0, 483258.0, 488275.0, 491444.0, 90508.0, 90749.0, 91305.0, 91319.54340228256, 91433.54283228541, 1008.8284991551454, 1010.777628921636, 1012.0284526854156, 1021.4382089850701, 1033.8914413986574, 17418.216180271666, 17525.649487010443, 18016.288452596982, 18057.277708891495, 18157.909210453865, 42927.0, 43851.342229867216, 44967.32549011833, 45117.54882451134, 45258.77370613126, 59923.400765991784, 62428.68785656043, 63142.0, 63402.68298658662, 64497.67751161214, 8235.9588202061, 8265.95867020661, 8382.874256886029, 8458.957705211435, 8487.490750554987, 10146.878458823225, 13520.0, 13609.594549369061, 14099.0, 14399.064060836012, 12026.338551379407, 12121.636350909486, 12215.26708397499, 12342.13605047638, 12346.876531234573, 11738.295702257892, 11767.411629418666, 12086.637400877988, 12194.146409751233, 12349.073819463396, 12388.132830702125, 12434.0, 12442.253464792142, 12549.372531373578, 12591.93704031474, 7779.96110019469, 8371.372147089114, 8450.323974082181, 8460.661573537236, 8486.660533578835, 9317.813643727222, 10676.733081673021, 10764.138868890313, 10976.396298203676, 10983.450827458755], "value": 9425.882250137496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.6869557392947, 1511.4256582498651, 1651.7439796831488, 1801.999999999999, 1805.864560157987, 8216.876746848802, 8800.075992020842, 9089.90910090899, 9609.807803843927, 9614.278929080321, 8861.955690221555, 9054.094590540943, 9307.627694892213, 9329.626814927395, 9371.390859594121, 2355.787979081878, 2415.698037745282, 2425.0178677635586, 2427.0777104700187, 2433.5741245282093, 2371.881405929705, 2400.1599440195964, 2448.6327050942323, 2460.667809845666, 2464.3346296499935, 2425.648280999254, 2433.5011322678806, 2455.287966489716, 2465.408302007523, 2476.8761561921924, 2325.1513197682807, 2337.0, 2339.099446713011, 2353.3410645019253, 2394.5091256292417, 2345.0385342009695, 2348.342464110052, 2361.0, 2380.1788383007834, 2383.249276477904, 9049.3665443419, 9075.682351117744, 9092.136247056518, 9126.817463650756, 9160.0, 5631.887362252773, 5682.374938756733, 5750.7412166452195, 5752.338481074647, 5752.798652047159, 3488.5464889564196, 3497.265574229415, 3577.0, 3586.336527742376, 3602.0994751312173, 1197.3953153657435, 1199.142613031678, 1201.7956947318976, 1207.2816674078908, 1221.7556488702296, 12949.705029496974, 12964.675883102998, 13087.607371778862, 13132.0807543472, 13203.339833008311, 4871.683340582851, 4896.11869863428, 4903.705777653352, 4954.1825598775795, 5005.299258103868, 11022.779544409066, 11061.612843550438, 11074.667759967213, 11078.0583650389, 11080.168987325982, 5607.775688972477, 5610.074337734228, 5631.352394474606, 5633.183188437653, 5640.238567793377, 4684.391029166187, 5121.155009423478, 5193.221016847428, 5247.501487358772, 5248.475152484797, 4266.1254442839145, 4309.267424537836, 4394.692371533962, 4442.20040392726, 4443.178012067778, 1364.9112807667668, 1385.8059871617982, 1389.4646415710495, 1400.8319001719858, 1413.2086031822212, 837.4807619276088, 863.7495126413395, 912.6303846942, 962.3119469579284, 1013.2147585621202, 6275.529335299871, 6294.307626161119, 6366.808995730135, 6491.578047426902, 6499.967500162469, 956.93779904306, 979.7844474215661, 1001.2740762946805, 1035.7980193862124, 1041.9322744021615, 4123.0, 4404.911901761947, 4411.955880441219, 4453.576910193527, 4461.910761784746, 11802.704932376759, 11964.162508624313, 12084.758304833855, 12104.394780260951, 12128.636140915787, 11923.821142682868, 11965.341906195068, 11979.640610781691, 11988.700282493008, 11996.040316774637, 8350.958245208734, 8693.478391296543, 8713.477191368538, 8801.47191168532, 8802.031776504708, 6101.84745381369, 6598.703058362481, 6617.205935287796, 6643.534952553275, 6682.365175308338, 10779.51492182838, 11051.502682379152, 11121.165912556753, 11126.221164518405, 11224.607138750105, 11269.774604508028, 11290.040346570633, 11342.773144537228, 11410.657680269605, 11481.253718508271, 7439.367653749492, 8061.0326760789085, 8430.241278284984, 8436.409451338593, 8599.355048371272, 9228.861567076634, 9263.16631503168, 9269.490178040272, 9286.164245217693, 9327.533623318943, 8000.959995199987, 8415.158484151536, 8494.70268540598, 8550.05949345559, 8637.784055398666, 8122.7157049502985, 8161.0, 8226.259636632733, 8293.460925039853, 8342.708005219789, 7538.133114691881, 7689.42329325314, 7701.4608977371045, 7719.498232614862, 7738.613069346397, 5423.589866634625, 5480.506754392124, 5485.862853428536, 5640.4077571856005, 5674.404187560247, 5663.886722265449, 5764.223327695802, 5771.105478650816, 5797.594168408171, 5816.0], "value": 4952.531705483216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9292894956534, 349.1408251063089, 349.98600055997764, 353.1224906108319, 353.950446937429, 5658.264425624669, 5757.481826635607, 5764.827055188351, 5805.6066544029445, 5830.30036395632, 5655.462731040555, 5675.233843431136, 5700.287464066992, 5711.686766859419, 5738.3974682658345, 4056.553779084306, 4416.050549131936, 4422.690411671184, 4440.533743956887, 4444.733316001034, 4378.861496011028, 4436.489803672571, 4440.86677399677, 4480.596746292833, 4486.349479325496, 4408.933865992013, 4419.779011049451, 4439.178751930887, 4448.866534003969, 4468.709533880304, 4340.131973605276, 4451.9777401113115, 4455.487618923833, 4466.503721253384, 4466.731996080245, 3915.8629447969183, 3948.605139486057, 3957.9010524736823, 3962.1679447316096, 3969.503812023497, 5591.580631452657, 5619.522340601013, 5623.634463759842, 5632.0, 5636.971815140939, 4933.28467372229, 5088.567471764904, 5137.717425541594, 5147.974260128713, 5165.22521621756, 5970.104484327342, 5977.282726072855, 5980.850478738066, 6021.0, 6037.003894357425, 4357.0, 4358.3244597087505, 4367.868963931087, 4371.4972778130605, 4371.868843934687, 5902.2622172228475, 6241.282252540925, 6261.311255761862, 6264.373562643745, 6296.496280297565, 4312.137572485515, 4324.697271190987, 4328.5022222444195, 4355.412019377407, 4362.345648152803, 4311.8706438806885, 4376.234159022159, 4385.079133381962, 4387.27609944362, 4406.206882761134, 4964.578010869117, 4982.153033984231, 5020.974895125501, 5021.347224860745, 5025.924611130836, 5894.6757928314355, 6015.2781666200335, 6047.334793172748, 6050.909236361458, 6052.364501727343, 1484.5991582272725, 1488.977665335021, 1502.4065494129977, 1525.6033431307717, 1529.2124555853745, 944.6079876851168, 960.2030314838668, 1007.7027276953316, 1024.206240163864, 1042.9426381548935, 5684.715764211773, 5710.600257981901, 5710.7430165642645, 5713.600047996683, 5739.454751798572, 6048.788292409745, 6115.327313995457, 6142.6314421134875, 6144.170536977451, 6179.907301390483, 5455.645383050089, 5671.177679236487, 5707.315122185364, 5724.599278050497, 5743.942560574341, 3240.4815229563155, 3253.755968302387, 3278.278778668689, 3292.93414131716, 3295.3687924477535, 6045.697715114226, 6335.968320158369, 6341.4292713656, 6403.0, 6412.903806442907, 6322.525810564226, 6332.240131184288, 6336.366363363627, 6374.681265936684, 6421.486281097501, 6082.0, 6268.905966410507, 6313.338263806981, 6452.35476452351, 6466.64433456155, 6115.0, 6141.631502109888, 6167.691615419121, 6186.845328866814, 6190.442860142609, 6055.303640081447, 6144.385561443999, 6149.139120523219, 6166.150154953406, 6180.907286390618, 6150.446459818638, 6343.175387199634, 6370.458511026614, 6381.457576106083, 6386.552941294065, 4243.596858298457, 4350.412694286231, 4366.563343665608, 4367.912641747083, 4394.648428125678, 5992.161097446274, 6172.993777022396, 6207.075806499999, 6242.470594704327, 6269.592476489013, 5943.58394912352, 5953.702314884152, 5960.6588517583195, 6009.519238461, 6017.759289628366, 5898.144769008384, 6019.307779605227, 6030.276366836008, 6036.547258955684, 6037.275526936795, 5808.477237048686, 5940.762369505172, 5947.226860508106, 5961.0, 5980.461758441761, 6041.9395806041375, 6043.637381756933, 6054.878902422015, 6085.208922840003, 6093.390660933871, 5744.482996530165, 5868.413158684098, 5897.498712609305, 5913.083472061838, 5940.6435613863305], "value": 4565.333709782471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.4568376772929, 700.5061431690658, 739.9519031262968, 753.834156485573, 810.282899633824, 16662.91668541657, 17144.142792860337, 17286.0, 17292.048937308442, 17331.046792426427, 17206.82793172068, 17218.053007084607, 17226.655466890654, 17260.82739172611, 17320.0, 662.5031226580065, 813.6541969662884, 835.7826964989085, 837.3092198935872, 839.9034111077243, 800.2517646001007, 824.5588610093602, 825.0470706334194, 827.6937533112757, 829.17911267845, 866.9436486628349, 877.4252864373846, 882.6248844241172, 884.4737381258141, 885.4465958775766, 869.3566760597175, 870.3689824876946, 874.7725591346232, 875.2560323724815, 880.5773228850123, 636.6275728698716, 639.5555089212999, 640.9871802563969, 642.0369445831253, 642.9389208025231, 15479.922600386926, 15485.767713484307, 15486.767698484531, 15591.766123508156, 15619.29713162899, 14614.415423383052, 14681.926590367086, 14694.853051469456, 14730.55808325752, 14892.553223403314, 11462.885371146265, 11468.885311146865, 11494.885051149466, 11511.424428778528, 11528.538858445652, 3704.722145839046, 3772.358699021173, 3794.051487128218, 3898.2203559288255, 3898.2788184186015, 79462.20537794605, 80513.59743201305, 81006.59496702538, 82407.0, 82578.58710706409, 11491.942540287246, 11511.48198331077, 11592.88407115918, 11617.070634349231, 11811.822822657667, 20662.276820311217, 20901.059452324684, 21861.12555497794, 21862.89068554647, 21888.562228755334, 8586.055533891267, 9143.725688229364, 9229.861552076723, 9683.176929961031, 9828.967958364268, 4883.975580122148, 4981.875453113701, 4999.600031997505, 5001.524855138756, 5095.923561146512, 3651.72612054097, 3753.981230093832, 3766.152615661454, 3773.962260377416, 4065.89835254121, 706.1455638677259, 716.6094478509225, 720.3013077314996, 728.1517032657001, 732.0702707561368, 641.6150309814168, 670.580886945659, 682.1098466501263, 686.2031577227569, 700.3626699703245, 9383.577739001761, 9520.90479095214, 9560.952195238979, 9763.755906102262, 10125.240606954509, 632.253940350391, 644.1046944746805, 659.2385794407467, 686.8626274745071, 687.08274453604, 4553.772311384418, 4775.21209000511, 4863.221884498464, 4896.975515122473, 4920.6801557898625, 95228.0, 118500.0, 125813.37093314658, 132611.3369433166, 135092.0, 113418.43290783493, 114112.42943785393, 114352.0, 116114.41942790232, 119605.0, 66675.33259672885, 87121.56439217764, 94651.0, 96307.0, 98243.0, 9349.57926893305, 9393.248540116638, 9418.88873900201, 9423.434593924387, 9469.053094690476, 58124.4187558119, 58804.41195587989, 59587.657727917256, 60057.39942600693, 61435.0, 80642.19357806347, 81602.0, 87352.0, 89999.55000224957, 90010.0, 11957.162998590014, 12035.75928481443, 12306.446209920396, 12355.073369497504, 12533.185342952678, 12990.415431305802, 13096.345182741015, 13114.278714670403, 13187.0, 13277.933610331887, 12077.27536347822, 12228.694282643006, 12605.117641765355, 12727.618171454871, 13143.34283285851, 12221.633350999484, 12518.436670350038, 12527.749445011232, 12569.371531423576, 12943.935280323538, 11375.374354410587, 11572.94213528927, 11605.767884642091, 11619.825702614298, 11744.823827642764, 9460.668876589287, 9564.521773911416, 9763.902360976299, 9835.65575204893, 10003.249756268164, 9597.616095356108, 10219.897801021894, 10386.74033149147, 10388.792224155626, 10391.948040259751], "value": 7653.684895502741, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 108.0, 120.0, 110.0, 112.0, 112.0, 110.0, 112.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 145.0, 175.0, 123.0, 151.0, 152.0, 116.0, 177.0, 124.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 163.0, 163.0, 163.0, 177.0, 166.0, 163.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 160.0, 76.0, 75.0, 74.0, 75.0, 171.0, 74.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 150.0, 85.0, 83.0, 83.0, 146.0, 84.0, 85.0, 139.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 56.0, 57.0, 53.0, 54.0, 62.0, 61.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 84.0, 75.0, 74.0, 77.0, 81.0, 75.0, 79.0, 74.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 133.0, 118.0, 136.0, 122.0, 122.0, 120.0, 183.0, 146.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 155.0, 153.0, 158.0, 156.0, 157.0, 153.0, 154.0, 152.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 66.0, 65.0, 62.0, 61.0, 62.0, 67.0], "value": 63.6, "unit": "score"}]}]} 05:29:36 INFO - Return code: 0 05:29:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:36 ERROR - # TBPL SUCCESS # 05:29:36 INFO - Running post-action listener: _resource_record_post_action 05:29:36 INFO - ##### 05:29:36 INFO - ##### Finished run-tests step (success) 05:29:36 INFO - ##### 05:29:36 INFO - Running post-run listener: _resource_record_post_run 05:29:36 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553779200; Read time: 8; Write time: 489320 05:29:36 INFO - TinderboxPrint: CPU usage
13.3% 05:29:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:29:36 INFO - TinderboxPrint: I/O write bytes / time
553,779,200 / 489,320 05:29:36 INFO - TinderboxPrint: CPU idle
8,232.6 (86.7%) 05:29:36 INFO - TinderboxPrint: CPU user
1,209.2 (12.7%) 05:29:36 INFO - TinderboxPrint: Swap in / out
0 / 0 05:29:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256557056; Read time: 0; Write time: 290364 05:29:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 297222144; Read time: 0; Write time: 198956 05:29:37 INFO - Running post-run listener: _upload_blobber_files 05:29:37 INFO - Blob upload gear active. 05:29:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:37 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 05:29:37 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:37 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:37 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:38 INFO - (blobuploader) - INFO - Done attempting. 05:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:42 INFO - (blobuploader) - INFO - Done attempting. 05:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:42 INFO - (blobuploader) - INFO - Done attempting. 05:29:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:42 INFO - Return code: 0 05:29:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d598c15ad20efa10ef5886fd6e46258c338f639ab70c64e8bf9a83b2412f00721df0dd6faf3e230b199cb01d46225e8e30cbfa8d7c16f79b276f73a56ce55e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9422508ec46e4286eef36553c793945111affe7c0d9dc127e816585010883f7c6b1b25850cf3f67b36216c488e08610c979fd008cd90d1c0f674b796ec0e597f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f66b87cdc4f2e61e0335615658548a9bb9ee4c3b4c187152270a613623ce868d7c13110c296ee1f131fdf77979303d840fcaa8e0e6d05f8eae5f2cfb5c30954"} 05:29:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:42 INFO - Contents: 05:29:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d598c15ad20efa10ef5886fd6e46258c338f639ab70c64e8bf9a83b2412f00721df0dd6faf3e230b199cb01d46225e8e30cbfa8d7c16f79b276f73a56ce55e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9422508ec46e4286eef36553c793945111affe7c0d9dc127e816585010883f7c6b1b25850cf3f67b36216c488e08610c979fd008cd90d1c0f674b796ec0e597f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f66b87cdc4f2e61e0335615658548a9bb9ee4c3b4c187152270a613623ce868d7c13110c296ee1f131fdf77979303d840fcaa8e0e6d05f8eae5f2cfb5c30954"} 05:29:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:42 INFO - Copying logs to upload dir... 05:29:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.182665 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-02 05:29:42.427339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:42.430922) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 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/sha512/d598c15ad20efa10ef5886fd6e46258c338f639ab70c64e8bf9a83b2412f00721df0dd6faf3e230b199cb01d46225e8e30cbfa8d7c16f79b276f73a56ce55e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9422508ec46e4286eef36553c793945111affe7c0d9dc127e816585010883f7c6b1b25850cf3f67b36216c488e08610c979fd008cd90d1c0f674b796ec0e597f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f66b87cdc4f2e61e0335615658548a9bb9ee4c3b4c187152270a613623ce868d7c13110c296ee1f131fdf77979303d840fcaa8e0e6d05f8eae5f2cfb5c30954"} build_url:https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d598c15ad20efa10ef5886fd6e46258c338f639ab70c64e8bf9a83b2412f00721df0dd6faf3e230b199cb01d46225e8e30cbfa8d7c16f79b276f73a56ce55e06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9422508ec46e4286eef36553c793945111affe7c0d9dc127e816585010883f7c6b1b25850cf3f67b36216c488e08610c979fd008cd90d1c0f674b796ec0e597f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f66b87cdc4f2e61e0335615658548a9bb9ee4c3b4c187152270a613623ce868d7c13110c296ee1f131fdf77979303d840fcaa8e0e6d05f8eae5f2cfb5c30954"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:42.458984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:42.459306) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467458587.933357-1915018484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 05:29:42.538449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 05:29:42.541873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 05:29:42.542154) ========= ========= Total master_lag: 0.18 =========