builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1468748160.2 results: success (0) buildid: 20160717013351 builduid: c716241ec02443febeec2c20cbdeab0a revision: e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.204176) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.204723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.205065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.221112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.221565) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 02:36:00-- 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% 50.7M=0s 2016-07-17 02:36:00 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.321416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.322123) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014912 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:00.374905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 02:36:00.375279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 --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 e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 --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=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 02:36:00,675 truncating revision to first 12 chars 2016-07-17 02:36:00,675 Setting DEBUG logging. 2016-07-17 02:36:00,675 attempt 1/10 2016-07-17 02:36:00,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7a27a7538b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 02:36:01,518 unpacking tar archive at: fx-team-e7a27a7538b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 02:36:01.563469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:01.563792) ========= script_repo_revision: e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:01.564197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:01.564485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 02:36:01.574578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-17 02:36:01.574951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:36:01 INFO - MultiFileLogger online at 20160717 02:36:01 in /builds/slave/test 02:36:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:36:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:36:01 INFO - {'append_to_log': False, 02:36:01 INFO - 'base_work_dir': '/builds/slave/test', 02:36:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:36:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:36:01 INFO - 'branch': 'Fx-Team-Non-PGO', 02:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:36:01 INFO - 'config_files': ('talos/linux_config.py',), 02:36:01 INFO - 'default_actions': ('clobber', 02:36:01 INFO - 'read-buildbot-config', 02:36:01 INFO - 'download-and-extract', 02:36:01 INFO - 'populate-webroot', 02:36:01 INFO - 'create-virtualenv', 02:36:01 INFO - 'install', 02:36:01 INFO - 'run-tests'), 02:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:36:01 INFO - 'download_minidump_stackwalk': True, 02:36:01 INFO - 'download_symbols': 'ondemand', 02:36:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:36:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:36:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:36:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:36:01 INFO - 'installer_path': 'installer.exe', 02:36:01 INFO - 'log_level': 'info', 02:36:01 INFO - 'log_name': 'talos', 02:36:01 INFO - 'log_to_console': True, 02:36:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:36:01 INFO - 'opt_config_files': (), 02:36:01 INFO - 'pip_index': False, 02:36:01 INFO - 'sps_profile': False, 02:36:01 INFO - 'sps_profile_interval': 0, 02:36:01 INFO - 'suite': 'dromaeojs', 02:36:01 INFO - 'system_bits': '32', 02:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:36:01 INFO - 'title': 'talos-linux64-ix-057', 02:36:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:36:01 INFO - 'use_talos_json': True, 02:36:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:36:01 INFO - 'work_dir': 'build'} 02:36:01 INFO - ##### 02:36:01 INFO - ##### Running clobber step. 02:36:01 INFO - ##### 02:36:01 INFO - Running pre-action listener: _resource_record_pre_action 02:36:01 INFO - Running main action method: clobber 02:36:01 INFO - rmtree: /builds/slave/test/build 02:36:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:36:02 INFO - Running post-action listener: _resource_record_post_action 02:36:02 INFO - ##### 02:36:02 INFO - ##### Finished clobber step (success) 02:36:02 INFO - ##### 02:36:02 INFO - ##### 02:36:02 INFO - ##### Running read-buildbot-config step. 02:36:02 INFO - ##### 02:36:02 INFO - Running pre-action listener: _resource_record_pre_action 02:36:02 INFO - Running main action method: read_buildbot_config 02:36:02 INFO - Using buildbot properties: 02:36:02 INFO - { 02:36:02 INFO - "project": "", 02:36:02 INFO - "product": "firefox", 02:36:02 INFO - "script_repo_revision": "production", 02:36:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:36:02 INFO - "repository": "", 02:36:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:36:02 INFO - "buildid": "20160717013351", 02:36:02 INFO - "pgo_build": "False", 02:36:02 INFO - "basedir": "/builds/slave/test", 02:36:02 INFO - "buildnumber": 3168, 02:36:02 INFO - "slavename": "talos-linux64-ix-057", 02:36:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:36:02 INFO - "platform": "ubuntu64_hw", 02:36:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:36:02 INFO - "branch": "fx-team", 02:36:02 INFO - "repo_path": "integration/fx-team", 02:36:02 INFO - "revision": "e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8", 02:36:02 INFO - "stage_platform": "linux64", 02:36:02 INFO - "builduid": "c716241ec02443febeec2c20cbdeab0a", 02:36:02 INFO - "slavebuilddir": "test" 02:36:02 INFO - } 02:36:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:36:02 INFO - Running post-action listener: _resource_record_post_action 02:36:02 INFO - ##### 02:36:02 INFO - ##### Finished read-buildbot-config step (success) 02:36:02 INFO - ##### 02:36:02 INFO - ##### 02:36:02 INFO - ##### Running download-and-extract step. 02:36:02 INFO - ##### 02:36:02 INFO - Running pre-action listener: _resource_record_pre_action 02:36:02 INFO - Running main action method: download_and_extract 02:36:02 INFO - mkdir: /builds/slave/test/build/tests 02:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:02 INFO - https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:03 INFO - Downloaded 1361 bytes. 02:36:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:36:03 INFO - Using the following test package requirements: 02:36:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:36:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:36:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:36:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'jsshell-linux-x86_64.zip'], 02:36:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:36:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:36:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:36:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:36:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:36:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:36:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:36:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:03 INFO - https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:04 INFO - Downloaded 22763853 bytes. 02:36:04 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'] 02:36:04 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 02:36:05 INFO - Return code: 0 02:36:05 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 02:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:05 INFO - https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:07 INFO - Downloaded 22763853 bytes. 02:36:07 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'] 02:36:07 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 02:36:08 INFO - Return code: 0 02:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:08 INFO - https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:36:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:36:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:36:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:09 INFO - Downloaded 14403317 bytes. 02:36:09 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'] 02:36:09 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 02:36:09 INFO - Return code: 0 02:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:09 INFO - https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:36:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:36:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:36:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/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 02:36:13 INFO - Downloaded 57082141 bytes. 02:36:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:36:13 INFO - mkdir: /builds/slave/test/properties 02:36:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:13 INFO - Contents: 02:36:13 INFO - build_url:https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - Running post-action listener: set_extra_try_arguments 02:36:14 INFO - ##### 02:36:14 INFO - ##### Finished download-and-extract step (success) 02:36:14 INFO - ##### 02:36:14 INFO - ##### 02:36:14 INFO - ##### Running populate-webroot step. 02:36:14 INFO - ##### 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: populate_webroot 02:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:14 INFO - '--tppagecycles', 02:36:14 INFO - '7'], 02:36:14 INFO - 'tests': ['tsvgm']}}, 02:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:36:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['damp', 'tps']}, 02:36:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['damp', 'tps']}, 02:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['dromaeo_dom']}, 02:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['basic_compositor_video']}, 02:36:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tsvgx', 02:36:14 INFO - 'tsvgr_opacity', 02:36:14 INFO - 'tart', 02:36:14 INFO - 'tscrollx', 02:36:14 INFO - 'cart']}, 02:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:36:14 INFO - 'tsvgr_opacity', 02:36:14 INFO - 'tart', 02:36:14 INFO - 'tscrollx', 02:36:14 INFO - 'cart']}, 02:36:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tp5o']}, 02:36:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['tp5o']}, 02:36:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s', 02:36:14 INFO - '--xperf_path', 02:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:14 INFO - 'tests': ['tp5n']}, 02:36:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--xperf_path', 02:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:14 INFO - 'tests': ['tp5n']}}, 02:36:14 INFO - 'talos.zip': {'path': '', 02:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - ##### 02:36:14 INFO - ##### Finished populate-webroot step (success) 02:36:14 INFO - ##### 02:36:14 INFO - ##### 02:36:14 INFO - ##### Running create-virtualenv step. 02:36:14 INFO - ##### 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: create_virtualenv 02:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:14 INFO - Using real prefix '/usr' 02:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:17 INFO - Installing pip.................done. 02:36:17 INFO - Return code: 0 02:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:17 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 02:36:17 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 02:36:17 INFO - Using env: {'DISPLAY': ':0', 02:36:17 INFO - 'HOME': '/home/cltbld', 02:36:17 INFO - 'LANG': 'en_US.UTF-8', 02:36:17 INFO - 'LANGUAGE': 'en_US:en', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MAIL': '/var/mail/cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SHLVL': '1', 02:36:17 INFO - 'TERM': 'linux', 02:36:17 INFO - 'TMOUT': '86400', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - '_': '/tools/buildbot/bin/python'} 02:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:36:17 INFO - Cleaning up... 02:36:17 INFO - Return code: 0 02:36:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:17 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 02:36:17 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 02:36:17 INFO - Using env: {'DISPLAY': ':0', 02:36:17 INFO - 'HOME': '/home/cltbld', 02:36:17 INFO - 'LANG': 'en_US.UTF-8', 02:36:17 INFO - 'LANGUAGE': 'en_US:en', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MAIL': '/var/mail/cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SHLVL': '1', 02:36:17 INFO - 'TERM': 'linux', 02:36:17 INFO - 'TMOUT': '86400', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - '_': '/tools/buildbot/bin/python'} 02:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:17 INFO - Downloading/unpacking psutil>=3.1.1 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:19 INFO - Installing collected packages: psutil 02:36:19 INFO - Running setup.py install for psutil 02:36:19 INFO - building 'psutil._psutil_linux' extension 02:36:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:36:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:36:19 INFO - building 'psutil._psutil_posix' extension 02:36:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:36:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:20 INFO - Successfully installed psutil 02:36:20 INFO - Cleaning up... 02:36:20 INFO - Return code: 0 02:36:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:20 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:20 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 02:36:20 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 02:36:20 INFO - Using env: {'DISPLAY': ':0', 02:36:20 INFO - 'HOME': '/home/cltbld', 02:36:20 INFO - 'LANG': 'en_US.UTF-8', 02:36:20 INFO - 'LANGUAGE': 'en_US:en', 02:36:20 INFO - 'LOGNAME': 'cltbld', 02:36:20 INFO - 'MAIL': '/var/mail/cltbld', 02:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:20 INFO - 'MOZ_NO_REMOTE': '1', 02:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:20 INFO - 'NO_EM_RESTART': '1', 02:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:20 INFO - 'PWD': '/builds/slave/test', 02:36:20 INFO - 'SHELL': '/bin/bash', 02:36:20 INFO - 'SHLVL': '1', 02:36:20 INFO - 'TERM': 'linux', 02:36:20 INFO - 'TMOUT': '86400', 02:36:20 INFO - 'USER': 'cltbld', 02:36:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:20 INFO - '_': '/tools/buildbot/bin/python'} 02:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:22 INFO - Installing collected packages: mozsystemmonitor 02:36:22 INFO - Running setup.py install for mozsystemmonitor 02:36:22 INFO - Successfully installed mozsystemmonitor 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:22 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 02:36:22 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 02:36:22 INFO - Using env: {'DISPLAY': ':0', 02:36:22 INFO - 'HOME': '/home/cltbld', 02:36:22 INFO - 'LANG': 'en_US.UTF-8', 02:36:22 INFO - 'LANGUAGE': 'en_US:en', 02:36:22 INFO - 'LOGNAME': 'cltbld', 02:36:22 INFO - 'MAIL': '/var/mail/cltbld', 02:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:22 INFO - 'MOZ_NO_REMOTE': '1', 02:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:22 INFO - 'NO_EM_RESTART': '1', 02:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:22 INFO - 'PWD': '/builds/slave/test', 02:36:22 INFO - 'SHELL': '/bin/bash', 02:36:22 INFO - 'SHLVL': '1', 02:36:22 INFO - 'TERM': 'linux', 02:36:22 INFO - 'TMOUT': '86400', 02:36:22 INFO - 'USER': 'cltbld', 02:36:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:22 INFO - '_': '/tools/buildbot/bin/python'} 02:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:22 INFO - Downloading/unpacking jsonschema==2.5.1 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:24 INFO - warning: no files found matching '*.txt' 02:36:24 INFO - no previously-included directories found matching 'build' 02:36:24 INFO - no previously-included directories found matching 'dist' 02:36:24 INFO - no previously-included directories found matching '.git*' 02:36:24 INFO - Installing collected packages: jsonschema, functools32 02:36:24 INFO - Running setup.py install for functools32 02:36:24 INFO - warning: no files found matching '*.txt' 02:36:24 INFO - no previously-included directories found matching 'build' 02:36:24 INFO - no previously-included directories found matching 'dist' 02:36:24 INFO - no previously-included directories found matching '.git*' 02:36:24 INFO - Successfully installed jsonschema functools32 02:36:24 INFO - Cleaning up... 02:36:25 INFO - Return code: 0 02:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:25 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 02:36:25 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 02:36:25 INFO - Using env: {'DISPLAY': ':0', 02:36:25 INFO - 'HOME': '/home/cltbld', 02:36:25 INFO - 'LANG': 'en_US.UTF-8', 02:36:25 INFO - 'LANGUAGE': 'en_US:en', 02:36:25 INFO - 'LOGNAME': 'cltbld', 02:36:25 INFO - 'MAIL': '/var/mail/cltbld', 02:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:25 INFO - 'MOZ_NO_REMOTE': '1', 02:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:25 INFO - 'NO_EM_RESTART': '1', 02:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:25 INFO - 'PWD': '/builds/slave/test', 02:36:25 INFO - 'SHELL': '/bin/bash', 02:36:25 INFO - 'SHLVL': '1', 02:36:25 INFO - 'TERM': 'linux', 02:36:25 INFO - 'TMOUT': '86400', 02:36:25 INFO - 'USER': 'cltbld', 02:36:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:25 INFO - '_': '/tools/buildbot/bin/python'} 02:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - Downloading docopt-0.6.1.tar.gz 02:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:27 INFO - Running setup.py install for blobuploader 02:36:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:28 INFO - Running setup.py install for requests 02:36:28 INFO - Running setup.py install for docopt 02:36:28 INFO - Successfully installed blobuploader requests docopt 02:36:28 INFO - Cleaning up... 02:36:28 INFO - Return code: 0 02:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:28 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:28 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 02:36:28 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 02:36:28 INFO - Using env: {'DISPLAY': ':0', 02:36:28 INFO - 'HOME': '/home/cltbld', 02:36:28 INFO - 'LANG': 'en_US.UTF-8', 02:36:28 INFO - 'LANGUAGE': 'en_US:en', 02:36:28 INFO - 'LOGNAME': 'cltbld', 02:36:28 INFO - 'MAIL': '/var/mail/cltbld', 02:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:28 INFO - 'MOZ_NO_REMOTE': '1', 02:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:28 INFO - 'NO_EM_RESTART': '1', 02:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:28 INFO - 'PWD': '/builds/slave/test', 02:36:28 INFO - 'SHELL': '/bin/bash', 02:36:28 INFO - 'SHLVL': '1', 02:36:28 INFO - 'TERM': 'linux', 02:36:28 INFO - 'TMOUT': '86400', 02:36:28 INFO - 'USER': 'cltbld', 02:36:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:28 INFO - '_': '/tools/buildbot/bin/python'} 02:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:28 INFO - Running setup.py (path:/tmp/pip-lNOGUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:28 INFO - Running setup.py (path:/tmp/pip-VKIxdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:28 INFO - Running setup.py (path:/tmp/pip-Kat4TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:28 INFO - Running setup.py (path:/tmp/pip-vOmaJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:29 INFO - Running setup.py (path:/tmp/pip-Rzq_ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:29 INFO - Running setup.py (path:/tmp/pip-GK5_ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:29 INFO - Running setup.py (path:/tmp/pip-JHnEV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:29 INFO - Running setup.py (path:/tmp/pip-PKpB9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:29 INFO - Running setup.py (path:/tmp/pip-yP3nRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:29 INFO - Running setup.py (path:/tmp/pip-AneI7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:29 INFO - Running setup.py (path:/tmp/pip-URzDBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:29 INFO - Running setup.py (path:/tmp/pip-zIM4u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:29 INFO - Running setup.py (path:/tmp/pip-dh7kkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:29 INFO - Running setup.py (path:/tmp/pip-snp5Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:29 INFO - Running setup.py (path:/tmp/pip-5ORJgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:29 INFO - Running setup.py (path:/tmp/pip-bsAFmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:29 INFO - Running setup.py (path:/tmp/pip-swWaQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:29 INFO - Running setup.py install for manifestparser 02:36:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Running setup.py install for mozcrash 02:36:30 INFO - Running setup.py install for mozdebug 02:36:30 INFO - Running setup.py install for mozdevice 02:36:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Running setup.py install for mozfile 02:36:30 INFO - Running setup.py install for mozhttpd 02:36:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Running setup.py install for mozinfo 02:36:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Running setup.py install for mozInstall 02:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:30 INFO - Running setup.py install for mozleak 02:36:30 INFO - Running setup.py install for mozlog 02:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for moznetwork 02:36:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozprocess 02:36:31 INFO - Running setup.py install for mozprofile 02:36:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozrunner 02:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozscreenshot 02:36:31 INFO - Running setup.py install for moztest 02:36:31 INFO - Running setup.py install for mozversion 02:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:31 INFO - Cleaning up... 02:36:31 INFO - Return code: 0 02:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:31 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:31 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 02:36:31 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 02:36:31 INFO - Using env: {'DISPLAY': ':0', 02:36:31 INFO - 'HOME': '/home/cltbld', 02:36:31 INFO - 'LANG': 'en_US.UTF-8', 02:36:31 INFO - 'LANGUAGE': 'en_US:en', 02:36:31 INFO - 'LOGNAME': 'cltbld', 02:36:31 INFO - 'MAIL': '/var/mail/cltbld', 02:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:31 INFO - 'MOZ_NO_REMOTE': '1', 02:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:31 INFO - 'NO_EM_RESTART': '1', 02:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:31 INFO - 'PWD': '/builds/slave/test', 02:36:31 INFO - 'SHELL': '/bin/bash', 02:36:31 INFO - 'SHLVL': '1', 02:36:31 INFO - 'TERM': 'linux', 02:36:31 INFO - 'TMOUT': '86400', 02:36:31 INFO - 'USER': 'cltbld', 02:36:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:31 INFO - '_': '/tools/buildbot/bin/python'} 02:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:32 INFO - Running setup.py (path:/tmp/pip-q3qKlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:32 INFO - Running setup.py (path:/tmp/pip-_5s0i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:32 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)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:32 INFO - Running setup.py (path:/tmp/pip-hguQGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:32 INFO - Running setup.py (path:/tmp/pip-rY6OAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:32 INFO - Running setup.py (path:/tmp/pip-QylUYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:32 INFO - Running setup.py (path:/tmp/pip-4nr1x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:32 INFO - Running setup.py (path:/tmp/pip-Vfzqlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:32 INFO - Running setup.py (path:/tmp/pip-I0VTj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:32 INFO - Running setup.py (path:/tmp/pip-rK57TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:32 INFO - Running setup.py (path:/tmp/pip-pr8EFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:32 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)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:32 INFO - Running setup.py (path:/tmp/pip-QPuUwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:32 INFO - Running setup.py (path:/tmp/pip-d0_Pdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:32 INFO - Running setup.py (path:/tmp/pip-Vq0cKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:32 INFO - Running setup.py (path:/tmp/pip-kLYlkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:33 INFO - Running setup.py (path:/tmp/pip-xiLGqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:33 INFO - Running setup.py (path:/tmp/pip-gWFIB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:33 INFO - Running setup.py (path:/tmp/pip-cDvwMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:36:33 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)) 02:36:33 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)) 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:35 INFO - Downloading blessings-1.6.tar.gz 02:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:35 INFO - Installing collected packages: blessings 02:36:35 INFO - Running setup.py install for blessings 02:36:35 INFO - Successfully installed blessings 02:36:35 INFO - Cleaning up... 02:36:35 INFO - Return code: 0 02:36:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:35 INFO - Reading from file tmpfile_stdout 02:36:35 INFO - Current package versions: 02:36:35 INFO - argparse == 1.2.1 02:36:35 INFO - blessings == 1.6 02:36:35 INFO - blobuploader == 1.2.4 02:36:35 INFO - docopt == 0.6.1 02:36:35 INFO - functools32 == 3.2.3-2 02:36:35 INFO - jsonschema == 2.5.1 02:36:35 INFO - manifestparser == 1.1 02:36:35 INFO - mozInstall == 1.12 02:36:35 INFO - mozcrash == 0.17 02:36:35 INFO - mozdebug == 0.1 02:36:35 INFO - mozdevice == 0.48 02:36:35 INFO - mozfile == 1.2 02:36:35 INFO - mozhttpd == 0.7 02:36:35 INFO - mozinfo == 0.9 02:36:35 INFO - mozleak == 0.1 02:36:35 INFO - mozlog == 3.2 02:36:35 INFO - moznetwork == 0.27 02:36:35 INFO - mozprocess == 0.23 02:36:35 INFO - mozprofile == 0.28 02:36:35 INFO - mozrunner == 6.12 02:36:35 INFO - mozscreenshot == 0.1 02:36:35 INFO - mozsystemmonitor == 0.3 02:36:35 INFO - moztest == 0.7 02:36:35 INFO - mozversion == 1.4 02:36:35 INFO - psutil == 3.1.1 02:36:35 INFO - requests == 1.2.3 02:36:35 INFO - wsgiref == 0.1.2 02:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:35 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 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:35 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 02:36:35 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 02:36:35 INFO - Using env: {'DISPLAY': ':0', 02:36:35 INFO - 'HOME': '/home/cltbld', 02:36:35 INFO - 'LANG': 'en_US.UTF-8', 02:36:35 INFO - 'LANGUAGE': 'en_US:en', 02:36:35 INFO - 'LOGNAME': 'cltbld', 02:36:35 INFO - 'MAIL': '/var/mail/cltbld', 02:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:35 INFO - 'MOZ_NO_REMOTE': '1', 02:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:35 INFO - 'NO_EM_RESTART': '1', 02:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:35 INFO - 'PWD': '/builds/slave/test', 02:36:35 INFO - 'SHELL': '/bin/bash', 02:36:35 INFO - 'SHLVL': '1', 02:36:35 INFO - 'TERM': 'linux', 02:36:35 INFO - 'TMOUT': '86400', 02:36:35 INFO - 'USER': 'cltbld', 02:36:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:35 INFO - '_': '/tools/buildbot/bin/python'} 02:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:36:35 INFO - Cleaning up... 02:36:35 INFO - Return code: 0 02:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2330180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36: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', 'jsonschema'] in /builds/slave/test/build 02:36: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 jsonschema 02:36:35 INFO - Using env: {'DISPLAY': ':0', 02:36:35 INFO - 'HOME': '/home/cltbld', 02:36:35 INFO - 'LANG': 'en_US.UTF-8', 02:36:35 INFO - 'LANGUAGE': 'en_US:en', 02:36:35 INFO - 'LOGNAME': 'cltbld', 02:36:35 INFO - 'MAIL': '/var/mail/cltbld', 02:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:35 INFO - 'MOZ_NO_REMOTE': '1', 02:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:35 INFO - 'NO_EM_RESTART': '1', 02:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:35 INFO - 'PWD': '/builds/slave/test', 02:36:35 INFO - 'SHELL': '/bin/bash', 02:36:35 INFO - 'SHLVL': '1', 02:36:35 INFO - 'TERM': 'linux', 02:36:35 INFO - 'TMOUT': '86400', 02:36:35 INFO - 'USER': 'cltbld', 02:36:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:35 INFO - '_': '/tools/buildbot/bin/python'} 02:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:36 INFO - Cleaning up... 02:36:36 INFO - Return code: 0 02:36:36 INFO - Running post-action listener: _resource_record_post_action 02:36:36 INFO - Running post-action listener: _start_resource_monitoring 02:36:36 INFO - Starting resource monitoring. 02:36:36 INFO - ##### 02:36:36 INFO - ##### Finished create-virtualenv step (success) 02:36:36 INFO - ##### 02:36:36 INFO - ##### 02:36:36 INFO - ##### Running install step. 02:36:36 INFO - ##### 02:36:36 INFO - Running pre-action listener: _resource_record_pre_action 02:36:36 INFO - Running main action method: install 02:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:36 INFO - Reading from file tmpfile_stdout 02:36:36 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:36 INFO - Reading from file tmpfile_stdout 02:36:36 INFO - Output received: 02:36:36 INFO - Usage: mozinstall [options] installer 02:36:36 INFO - Options: 02:36:36 INFO - -h, --help show this help message and exit 02:36:36 INFO - -d DEST, --destination=DEST 02:36:36 INFO - Directory to install application into. [default: 02:36:36 INFO - "/builds/slave/test"] 02:36:36 INFO - --app=APP Application being installed. [default: firefox] 02:36:36 INFO - mkdir: /builds/slave/test/build/application 02:36:36 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'] 02:36:36 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 02:36:52 INFO - Reading from file tmpfile_stdout 02:36:52 INFO - Output received: 02:36:52 INFO - /builds/slave/test/build/application/firefox/firefox 02:36:52 INFO - Running post-action listener: _resource_record_post_action 02:36:52 INFO - ##### 02:36:52 INFO - ##### Finished install step (success) 02:36:52 INFO - ##### 02:36:52 INFO - ##### 02:36:52 INFO - ##### Running run-tests step. 02:36:52 INFO - ##### 02:36:52 INFO - Running pre-action listener: _resource_record_pre_action 02:36:52 INFO - Running main action method: run_tests 02:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:52 INFO - Python 2.7.3 02:36:52 INFO - Return code: 0 02:36:52 INFO - grabbing minidump binary from tooltool 02:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:52 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 0x232e3b0>, '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 0x232f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:36:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:36:52 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 02:36:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:52 INFO - Return code: 0 02:36:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:36:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:36:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:36:52 INFO - Using env: {'DISPLAY': ':0', 02:36:52 INFO - 'HOME': '/home/cltbld', 02:36:52 INFO - 'LANG': 'en_US.UTF-8', 02:36:52 INFO - 'LANGUAGE': 'en_US:en', 02:36:52 INFO - 'LOGNAME': 'cltbld', 02:36:52 INFO - 'MAIL': '/var/mail/cltbld', 02:36:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:52 INFO - 'MOZ_NO_REMOTE': '1', 02:36:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:52 INFO - 'NO_EM_RESTART': '1', 02:36:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:52 INFO - 'PWD': '/builds/slave/test', 02:36:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:52 INFO - 'SHELL': '/bin/bash', 02:36:52 INFO - 'SHLVL': '1', 02:36:52 INFO - 'TERM': 'linux', 02:36:52 INFO - 'TMOUT': '86400', 02:36:52 INFO - 'USER': 'cltbld', 02:36:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042', 02:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:52 INFO - '_': '/tools/buildbot/bin/python'} 02:36:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:36:52 INFO - mozversion application_buildid: 20160717013351 02:36:52 INFO - mozversion application_changeset: e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 02:36:52 INFO - mozversion application_display_name: Nightly 02:36:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:52 INFO - mozversion application_name: Firefox 02:36:52 INFO - mozversion application_remotingname: firefox 02:36:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:36:52 INFO - mozversion application_vendor: Mozilla 02:36:52 INFO - mozversion application_version: 50.0a1 02:36:52 INFO - mozversion platform_buildid: 20160717013351 02:36:52 INFO - mozversion platform_changeset: e7a27a7538b2bee268abdb08f4f3a6e41c5c58c8 02:36:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:36:52 INFO - mozversion platform_version: 50.0a1 02:36:52 INFO - using testdate: 1468748212 02:36:52 INFO - actual date: 1468748212 02:36:52 INFO - starting webserver on 'localhost:48717' 02:36:52 INFO - SUITE-START | Running 2 tests 02:36:52 INFO - TEST-START | dromaeo_css 02:36:52 INFO - operating with platform_type : linux_ 02:36:52 INFO - Initialising browser for dromaeo_css test... 02:36:53 INFO - TEST-INFO | started process 9721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIF6IUz/profile http://localhost:48717/getInfo.html) 02:36:56 INFO - PROCESS | 9721 | JavaScript error: , line 0: uncaught exception: undefined 02:36:57 INFO - PROCESS | 9721 | __metrics Screen width/height:1600/1200 02:36:57 INFO - PROCESS | 9721 | colorDepth:24 02:36:57 INFO - PROCESS | 9721 | Browser inner width/height: 1024/697 02:36:57 INFO - PROCESS | 9721 | __metrics 02:36:58 INFO - PROCESS | 9721 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:36:58 INFO - PROCESS | 9721 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:58 INFO - PROCESS | 9721 | console.error: PushService: 02:36:58 INFO - PROCESS | 9721 | stateChangeProcessEnqueue: Error transitioning state 02:36:58 INFO - PROCESS | 9721 | UnknownError 02:36:59 INFO - TEST-INFO | 9721: exit 0 02:36:59 INFO - Browser initialized. 02:36:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:36:59 INFO - TEST-INFO | started process 9803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIF6IUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:11 INFO - PROCESS | 9803 | RSS: Main: 159752192 02:37:11 INFO - PROCESS | 9803 | 02:38:03 INFO - PROCESS | 9803 | 1468748283028 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:40:16 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48717/tests/dromaeo/cssquery-ext.html) 02:40:17 INFO - PROCESS | 9803 | RSS: Main: 271650816 02:40:17 INFO - PROCESS | 9803 | 02:43:20 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-ext.html (next: http://localhost:48717/tests/dromaeo/cssquery-jquery.html) 02:43:20 INFO - PROCESS | 9803 | RSS: Main: 241209344 02:43:20 INFO - PROCESS | 9803 | 02:46:23 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48717/tests/dromaeo/cssquery-mootools.html) 02:46:23 INFO - PROCESS | 9803 | RSS: Main: 243380224 02:46:23 INFO - PROCESS | 9803 | 02:49:25 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48717/tests/dromaeo/cssquery-prototype.html) 02:49:26 INFO - PROCESS | 9803 | RSS: Main: 235155456 02:49:26 INFO - PROCESS | 9803 | 02:52:29 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48717/tests/dromaeo/cssquery-yui.html) 02:52:30 INFO - PROCESS | 9803 | RSS: Main: 220205056 02:52:30 INFO - PROCESS | 9803 | 02:55:32 INFO - PROCESS | 9803 | Cycle 1(1): loaded http://localhost:48717/tests/dromaeo/cssquery-yui.html (next: http://localhost:48717/tests/dromaeo/cssquery-dojo.html) 02:55:33 INFO - PROCESS | 9803 | RSS: Main: 279773184 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | __start_tp_report 02:55:33 INFO - PROCESS | 9803 | _x_x_mozilla_page_load 02:55:33 INFO - PROCESS | 9803 | _x_x_mozilla_page_load_details 02:55:33 INFO - PROCESS | 9803 | |i|pagename|runs| 02:55:33 INFO - PROCESS | 9803 | |0;dojo.html;2637.9340516487096;2642.815002949794;2671;2689.4889970905515;2690.1257091445273;4610.815567377309;4635.613553159041;4666.043461090477;4772.331873537708;4794.065157294324;4654.6974446661025;4659.301104834277;4694.4366675998845;4758.238681810911;4765.142274390617;4083.6528895043957;4226.218149642326;4312.892177695567;4343.283358245885;4441.777911104448;4328.177646247219;4343.5004974427875;4370.169667763115;4381.715188512737;4418.9337159942625;4209.7474151551005;4266.957330426687;4276.550962148961;4319.179355922396;4335.263005289108;4323.913521729579;4346.521882592912;4411.801468933906;4412.602865742067;4419.315006174048;4406.713563618387;4416.183006143874;4438.600525952647;4454.48773391061;4456.598906098434;4582.770861456914;4618.261078227468;4675.836345727917;4684.789184486673;4751.097291514601;4997.825076122318;5062.569681577071;5068.467810879842;5070.340855688773;5074.898502029976;4914.9999999999645;5018.372703412074;5096.439391666913;5103.23451482277;5105.438401775802;4646.140464014168;4678.204705200124;4679.719216847;4755.906141587454;4763.380760501182;5100.387953445536;5125.436202017775;5129.204973229155;5134.178531434953;5136.486351364908;4920.138975679313;4921.089598424303;4921.557059864558;4931.038447502702;4931.802727890844;4870.853874383774;4891.5353041461;4989.25161225819;4991.450940396553;5028.924566131511;5002.874928126826;5009.474005229471;5011;5019.47295533971;5052.469490703496;4807.495213002584;4978.352814134139;4990.90018199634;4998.2002879539095;5053.216751403538;3933.704972127102;3966.186931678999;3982.880513584597;3983.1635356574866;3990.082281075369;3534.2401383702627;3536.0982949347754;3544.4506101554302;3571.053670777246;3571.571411430593;4314.676399270004;4321.956780432155;4339.002029533225;4375.671824613103;4377.080813029236;4954.529319714694;5000.149974504343;5022.773975171126;5050.747462626854;5062.417821950523;4339.197248508973;4357.694961352739;4363.825446982149;4392.450943632046;4404.07514421975;4606.608438282717;4611.492735799059;4614.123316569908;4621.745803980746;4660.580547750651;4561.703489273186;4669.813207471663;4702.92945605823;4712.62299016071;4783.234682450791;5000.574951129195;5012.097822392005;5017.648764586444;5022.1964485683575;5061.038402703474;4724.126036683225;4735.14767341868;4744.122337367598;4746.454157771763;4784.067106914118;4897;4918.778654960607;4953.504649535018;4963.478834722447;4989.575886049726;5023.070731914608;5067.391912970467;5074.340335756328;5075.568576670877;5133.101707201299;4747.026859493864;4791.616670666269;4813.7352445615825;4813.844677277358;4862.270659401118;4813.3983252093485;4910.361652985089;4942.233953737176;4959.876003099951;4973.502649734997;4896.11869863428;4918.877028074184;4949.579285760607;4949.727764972961;4960.404751429707;4811.903761924812;4825.855224343275;4980.228064649985;4989.126902791924;4990.575801056805;4780.661414803861;4824.469308376146;4835.29888166221;4852.490488498657;4903 02:55:33 INFO - PROCESS | 9803 | |1;ext.html;552.8842757639834;582.7814569536424;592.6088781404274;597.2802772658946;600.5105838741423;26459.73540264597;38892;39848.60151398485;39859.20281594367;39909.800450997776;39832;40185.79907100468;40195.59804401955;40258.59741402593;40279;7299.124105107395;7437.962810185942;7454.254574542557;7785.844283114335;7933.246341597539;7486;9853.310268281222;10129.746756331077;10137.898621013806;10539.314944528582;10341.224408169379;10386.48067596621;10392.636257730981;10404.167666586654;10410.791784164312;7499;7672.271134242238;10072.798544029116;10109.191264698806;10146.441945692946;7532.736354227576;9726.756831079208;10153.847692284622;10171.135453486462;10514.894851051467;38681.22637547233;38786;38943.8052809737;38964;39029;2931.135315082056;2987.312918028844;3051.67957364478;3443;3447.637998010198;28347.716522834715;29011.564826527618;29478.705212948025;29530.26174345637;29816.40367192644;3333.5818114051435;3361.9327613447595;3367.3433680432327;3410.9147271318166;3452.8273586320834;250804;254695;255802;256113;257425;52661;53363.46636533585;53367;53371.19943200855;53434.198487022724;55994.44005559892;56283.71858140765;56422;56487.71756141193;56490;14029.859701402855;14365.281735913162;14387.064840785315;14391.928040359731;14406.855931440761;9021.188093071523;10636.893631063745;10897.073748731287;10906.563737450413;10955.780884382268;16301.755473667905;16304.429344972868;16333.346666133222;16344.85586008968;16382.590435239214;6098.847528811815;6100.455160905065;6119.816405507842;6123.632582045091;6222.848772977014;782.9608519573999;851.1531026628544;852.2117041736369;874.3704532736419;936.6534382278464;27678.727626245032;28178.85910570434;28506.287342816595;28579.28551786222;28826;904.2901322461968;946.4699768129869;961.5096300886598;979.4270351844109;1060;14989.775153372708;15048.548543543711;15355.92322038405;15481.612959676098;15530.689386212212;402043;405511;406274;406348;407179;49818;49901.75049124731;50033;50124.74937625288;50148;1046.4401545173296;1136.9943150284362;1149.5229479765972;1194.0268681025111;1205.3009254632468;29025.12924612265;29634.259143521584;29661.703382965894;29981.55027674543;30090.3981920356;42269;42843.785781070896;42904.99999999875;42905;43257.56742432535;315858;317176;317209;317412;317827;36424.27151457009;38119.23761524699;38147.23705525929;38150.99414561431;38167.236655266184;41659.58340416557;42400.57599423966;42446;42891.78554107335;43452.130957381305;36697.63302366942;37248.62751372452;37336;37468.43797342988;37615;36102.8194859024;36477.27045459023;36581;37050.6294937058;37119.814400927826;36055.63944360523;36535.26929461343;36799.63200367962;36927.07682307964;37158;32835.50746738753;33808.66191338055;34099;34251.314973700886;34390;25346.493070138124;25686;25920.22239332823;26185;26356.209313720618 02:55:33 INFO - PROCESS | 9803 | |2;jquery.html;347.3591224191366;364.9781013139211;367.935611268028;376.70805126027324;376.9641884021017;12934.223946563201;16344.591385215375;16452.91773541132;16863.40978065768;17700.91149544254;17331.82668173318;17384;17487.475375738748;17712.468625941212;17874.731879021823;5087.465816089313;5280.9207861882105;5570.944290557103;5570.944290557103;5655.773769049254;3470.0630829675974;3586.7130629549706;5270.262163297141;5536.169574563827;5581.413951535092;5594.49649531542;5595.888082238353;5608.663480191181;5619.831405057855;5621.072523033695;5504.779808807642;5923;6016.42843929826;6017.518598512109;6025.367336429656;5178.171492561172;5255.973720131413;5269.341332333458;5270.49930256625;5272.340957380327;19031.619367612708;19290.80709192904;19628;19644.214231430724;20975.643896976562;1797.290070422189;1829.4968883556994;1899.2877670873422;1925.8748181368305;2487.7885379742743;8849.203571678516;9273.39722918015;9489.810203795954;9614.95192524033;9680;1770.3980646580096;1973.289615738333;2071.2543484345624;2110.5778844231213;2126.627840127987;66179;68642;71115;84382;86451.56774216151;14054.85945140556;14073.507427239998;15959.202039897958;16693.83306166947;17208.1395930203;29217.269568260963;29234.415311693647;29430.705692942796;29522.852385737933;29792.255193620334;9177.128172823572;9237.30720195988;9311.860322095174;9318.813623727487;9402.247820174369;7470.215627359158;7483;7555.395568354518;7686.538807671557;7880.960595196987;8207.384446166561;8328.5002899825;8370.16298370158;8455.74632761018;8653.913460865437;3014.9397012059635;3088.9997453298033;3118.2672072063046;3339.395271688087;3367.4275373186615;800.1038836503154;816.93056090233;838.9161083891562;923.9260859131253;924.7410724997012;16565.751513727304;16837.41069062577;16997.830021699625;17456.91271543634;17683.646327073388;838.9706360277361;864.6671031652859;882.188386684252;882.8587426011808;893.6068130022899;9381.108794664497;9491;9555.808883822285;9579.952100239454;9818.90181098194;397218;401239;404367;405813;405821;71711.6414417935;74861;75747.62126189334;80876;87036;901.9458832470073;912.7535565397305;932.0399988012358;945.9148676619;946.1768261612441;16011;16183;16282.104484253006;16298.918505407397;16398.83601163973;39500.40749388819;40017.399739003355;40609.79695101624;40866;42090;57984.4201557979;58381;59278.70360648169;59529.10706339322;59538.70230648819;6934.861302773816;7032.26161253061;7090.220075791762;7149.642517873982;7222.530535515175;9423.764405889908;10193.0316619921;10259.948700256451;10422.062014418738;10574.154067674413;9146.314026448175;9164.605592519283;9268;9500.382475139093;9562.713118606453;8728.738137855875;8914.153155450222;9083.863742044006;9099.226565741987;9278.257739380968;8989.640414383352;9337.112974267433;9362.625494980124;9407.85888211691;9538.043072140526;6774.762883299061;6862.176538815374;6926.688299026455;6934.306569343227;7222.205557388578;8523.573821309034;8963.596638151168;9038.457692538468;9294.163525282487;9340.673076442292 02:55:33 INFO - PROCESS | 9803 | |3;mootools.html;1272.510083617807;1365.112676760106;1423.6369725719942;1473.6978919321534;1685.0479479094304;6791.626460544674;7463.2163622819635;7794.999999999985;7808.726694565684;8040.8391832163325;7773.6501857416415;7903.960480197606;7907.367410607152;7912.248336408046;7922.168172341893;2185.3007037747925;2214.26929113393;2214.2914267434426;2214.534947660985;2217.7227846519186;2132.349633361824;2161.3407910587266;2209.657503087024;2210.204326442479;2210.546837898235;2139.0267428320076;2147.7852214778477;2164.9891750541306;2167.349795061475;2193.517426166241;2076.4289820299464;2082.781307962665;2083.333333333334;2085.124247815921;2085.363963990982;2096.67501537262;2119.9152033918626;2142.700021996922;2142.8714277143267;2150.2259186692777;7681.57751323677;7813.453058285922;7931.365490760725;7961.761147165595;7962.283394494523;4455.086707225011;4646.256598944186;4654.2785868190485;4676.859694209179;4682.6019788318035;2934.7652187824924;2997.2357048952595;3044.40634076353;3062.8621712023014;3063.6476805167244;926.4672813132476;938.0994245524305;940.1867384712243;940.8353538130868;952.4904176265734;10512.421816800073;10559.41923194224;10566.577336906514;10568.15454763617;10587.364758114461;3886.145048089416;4030.8790736277374;4075.1645912587846;4076.5311989121633;4168.499780026416;8283.62723677436;8322.084570697218;8324.542150181676;8350.582470876432;8366.288865446384;4444.577765112309;4446.755428451402;4451.554844515523;4459.754713490789;4461.196984542748;3763.9059023524082;4077.734947228421;4172.499300083949;4179.059711564873;4258.61672449481;3461.6884480396884;3506.2111025019167;3578.964210357863;3590.0486371111674;3610.6389361063684;1006.7936073104996;1046.6598355534481;1047.3035431438161;1050.5272627317738;1054.8839627640953;694.3299715774201;747.6411322565199;860.8149247911729;876.0932434929817;882.6778225947482;5245.947540524622;5376.489233522809;5424.294841670637;5446.700431476307;5555.555555555546;401.4119315203183;402.57729384147115;407.802215925276;409.4390684761836;859.8968123825181;3416.931661366759;3669.5779985301497;3738.981305093457;3761.040934561724;3767;9615.951920240354;9810.21518278536;9841.45871977048;9975.25185611082;9999.800004000024;9699.078587534173;9703.07820757027;9721.70834874955;9730.513474326255;9881.25890558211;7008;7038.542494737928;7147.571145731169;7157;7159;5277.234800953764;5300.443453437488;5404.459554044564;5422.322209723785;5444.564434845282;8971.237444817003;8978.775530611787;9236.353455258337;9255.907440925504;9277.62889484413;8959.641614335615;9250.306227033134;9281.211097056555;9371.062893710574;9390.154886060287;5760.567957403296;5909.970450147722;5967.8209653710455;6521.771737989147;6635.502337324623;7530.774076777706;7845.29392354668;7908.288254057163;7912.0901096374655;7916.802079948047;6752.5948443093575;6899.344562266577;6900.137482814648;6921.792346229621;7031.613261270679;7034.402075823612;7042.929570704227;7068.71725130989;7111.82220444493;7161.104861892263;5829.242198514166;6109.969450152721;6148.754049837957;6238.469730072995;6299.338569450325;4382.101669157879;4466.173757854807;4480.843170489017;4505.5719706627815;4526.932096018497;4696.600788932979;4712.882177945578;4727.763611819464;4829.879253018703;4853.466118726867 02:55:33 INFO - PROCESS | 9803 | |4;prototype.html;295.1470250974684;299.42360955161314;307.98460076996145;312.0980366740123;312.8435782108946;4623.329617205503;4730.858074257778;4773.4510531288915;4846.612271018319;4857.829975950847;4617.630589552836;4754.429468463781;4771;4771.90456190876;4793.352897358855;3771.9811400943095;3773.9622603773887;3776.2636285924323;3806.0675134592066;3846.5576458707187;3622.47474116253;3666.7983260920637;3801.6388443097862;3823.847046118152;3829.8468061277517;3769.321522126016;3770.1328694400304;3793.5637401698746;3803.657670809627;3829.5978922213185;3782.773033617978;3802.16352402471;3804.7634518781506;3810.6760925321105;3816.599257078022;3394.439917413624;3397.4394224952853;3400.1839558506026;3404.285100128976;3410.28384039352;4630.699004564693;4646.326282688991;4653.557911998355;4682.274247491644;4723.244280915037;4304.956950430487;4307.396964424952;4312.180685669744;4326.610605045529;4338.652907767402;4832.395950506187;4979.7759100840185;5010.774515146827;5015.423226328982;5072.351485767103;3601.333753255656;3606.783592984429;3609.3864043112735;3612.9638703613155;3624.4925710400303;5259.316288882459;5278.9208161877605;5287.86780330491;5310.734463276859;5311.628186026941;3587.336342776595;3692.778433294011;3707.443883417455;3710.165212827092;3715.368387374153;3713.6843368313994;3736.1220113273357;3754.136548593784;3755.267722794029;3767.2842159989514;4257.169851878916;4267.16790225903;4269.274223382033;4284.91430171401;4291.592298731615;4783.521647835189;5023.598112151019;5029.698218106925;5035.345405097314;5054.9241761373605;1240.193873981919;1269.0989397527674;1269.3145701321182;1271.713864380507;1276.4638851682316;788.1921030943329;794.8211652378284;812.7196117339508;821.3347188776991;823.9782669489789;3971.960280397217;3974.7615143091507;3977.204559088194;3978.622030907059;3979.070150976774;4496.887577810516;4521.412216411845;4531.456225252925;4538.91066144123;4557.453105627346;3923.489946306962;3930.567637559866;3945.782981936021;3965.7025723070883;3996.3415182698855;2359.64605309205;2421.152596591179;2430.2709187243754;2454.251453306759;2479.863607501569;4248.235317642854;4276.957230427718;4279.33670281107;4353.238183317907;4372.398422938347;4634.814607415733;4654.930176047362;4658.231391820379;4667.159911215946;4668.276417155346;4115.279826030433;4265.1043280910735;4272.551382104896;4273.786310684515;4274.529801721808;4505.977470112629;4553.2942393929;4562.247229207143;4571.222892108283;4574.359589657517;4399.934000989923;4411.823527058882;4441.955580444154;4450.618918878385;4503.234450143418;4110.34234522475;4297.140571885698;4313.266744653479;4337.9783101084295;4338.717983331074;3281.8851340202978;3304.8512816922816;3309.6028476582965;3319.0042987104257;3334.9166270843425;4559.908801824011;4568.565986231436;4572.908541829078;4607.354970304227;4949.57928576075;4832.275158726219;4895.657303988686;4944.777485013111;4976.950230497793;4977.850664480072;4978.47725988766;4980.750962451935;4993.850184494471;4996.7001979881325;5002.299678045149;4789.976050119866;4953.18272485036;4958.2810492477665;4964.553190212898;4972.477889821516;4995.900081998267;5038.848834534823;5052.722100284373;5056.342675452168;5060.721660308718;4874.488178741323;4902.730349830794;4929.13740095489;4960.553550180501;4965.503449655005 02:55:33 INFO - PROCESS | 9803 | |5;yui.html;591.4735885062295;602.927648682158;609.5641616244384;675.294317438277;682.5358756045888;12854.871451285484;13564.253966031889;14186.361613727395;14192.290385480723;14282.214478203694;13153.802692959613;13347.733045339088;13396.397162127703;13408.731825363488;13420.798688019662;627.1126356205963;760.1524300405036;781.2109769133187;782.1552723059111;782.6321628834439;745.9813504662372;780.5784876166863;783.2363445640511;790.5809920742016;792.9048514178306;829.1294141151797;834.3950635789065;834.5827086456771;837.8617528107854;839.4879123734516;648.3775575447576;783.996080019602;824.575343697996;825.1253671108614;826.0252901576138;592.5082181789105;594.9821505354846;595.0271306414044;595.0538643556765;595.9046552551571;13774.035817492779;13780.793288100687;13821.170729756146;13867.514636987657;13880.236586987712;12041.458134383975;12643.93678031604;12684.175528590613;13004.739905201937;13044.217346959118;11141.442927853655;11376.146788990776;11437.370944598044;11674.591389301333;11731.88268117325;4017.35722284436;4090.447789548403;4098.446709694183;4203.012292111352;4233;65496;69197;69445.95831062588;70269;70728.6463567684;9656.95171524138;9749.853752193723;9749.902500975042;10012.69961901144;10155.543000564992;18045.639087218446;18070.819291807176;18095.63808723818;18119.909400452914;18214.726779098324;6600.60396376219;6723.562968407038;6737.831554211086;6794.864102717918;6915.066466027022;3542.992643155857;3562.2697347043795;3578.4990101385306;3587.0673624857204;3638.508801311842;2792.274008757697;2871.2104171353044;2873.324768679359;2886.898958536483;2890.2918784897834;506.2355842677583;507.57363814396086;514.7503460821498;515.0780103614563;521.7704210147523;486.5961252160698;510.6578592343139;510.98978020440126;514.7271945868696;520.565327951165;7176.210616832144;7226.710931562784;7333.4866559340335;7438.516496427715;7547.849043019219;457.32772823948744;459.57718898613354;487.2690963554668;527.947205279469;534.8689571055116;3425.6231814500384;3499.9125021874656;3524.101354154674;3532.8056956867617;3640.18095928414;104252;104556;107247;111009.44495277472;112509;90664.09335906689;90726.54636726774;91184.54407727919;91981;93162;47812.5218747815;81706.59146704228;83028.58485707654;83442.5827870869;83925.16074839295;6689.431398331197;6818.863622727418;6909.481788865955;7066.258042905421;7097.503174777922;47204.52795472001;48537.27194092021;49399;49831;50032.74983625204;67333;74197;74940.62529687317;75200.62399687967;75588;8815.735527934172;8936.776580585538;9236.30727695439;9396.483193424154;9816.607335706492;10092.394456332644;10348.275620706478;10431.269811113452;10728.141748660244;10777.784444311226;6279.497640188865;9393.295502837178;9705.563249653642;10464.215183861394;11270;10816.188785840935;11058.668239952814;11062.723431914266;11271;11336.263142895685;11530.481128349076;11604.477798499256;11653.126015548698;11915.52337906474;12420.689482762642;9901.970982618119;9975.107218906436;9978.850317245393;10357.274990750575;10449.268551201343;9523;9719.086348320918;9738.561764720464;9780.510974451392;9900.752481188028 02:55:33 INFO - PROCESS | 9803 | __end_tp_report 02:55:33 INFO - PROCESS | 9803 | __start_cc_report 02:55:33 INFO - PROCESS | 9803 | _x_x_mozilla_cycle_collect,1120 02:55:33 INFO - PROCESS | 9803 | __end_cc_report 02:55:33 INFO - PROCESS | 9803 | __startTimestamp1468749333219__endTimestamp 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | ------- Summary: start ------- 02:55:33 INFO - PROCESS | 9803 | Number of tests: 6 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#0] dojo.html Cycles:165 Average:4637.92 Median:4772.33 stddev:497.34 (10.4%) stddev-sans-first:473.47 02:55:33 INFO - PROCESS | 9803 | Values: 2637.9 2642.8 2671.0 2689.5 2690.1 4610.8 4635.6 4666.0 4772.3 4794.1 4654.7 4659.3 4694.4 4758.2 4765.1 4083.7 4226.2 4312.9 4343.3 4441.8 4328.2 4343.5 4370.2 4381.7 4418.9 4209.7 4267.0 4276.6 4319.2 4335.3 4323.9 4346.5 4411.8 4412.6 4419.3 4406.7 4416.2 4438.6 4454.5 4456.6 4582.8 4618.3 4675.8 4684.8 4751.1 4997.8 5062.6 5068.5 5070.3 5074.9 4915.0 5018.4 5096.4 5103.2 5105.4 4646.1 4678.2 4679.7 4755.9 4763.4 5100.4 5125.4 5129.2 5134.2 5136.5 4920.1 4921.1 4921.6 4931.0 4931.8 4870.9 4891.5 4989.3 4991.5 5028.9 5002.9 5009.5 5011.0 5019.5 5052.5 4807.5 4978.4 4990.9 4998.2 5053.2 3933.7 3966.2 3982.9 3983.2 3990.1 3534.2 3536.1 3544.5 3571.1 3571.6 4314.7 4322.0 4339.0 4375.7 4377.1 4954.5 5000.1 5022.8 5050.7 5062.4 4339.2 4357.7 4363.8 4392.5 4404.1 4606.6 4611.5 4614.1 4621.7 4660.6 4561.7 4669.8 4702.9 4712.6 4783.2 5000.6 5012.1 5017.6 5022.2 5061.0 4724.1 4735.1 4744.1 4746.5 4784.1 4897.0 4918.8 4953.5 4963.5 4989.6 5023.1 5067.4 5074.3 5075.6 5133.1 4747.0 4791.6 4813.7 4813.8 4862.3 4813.4 4910.4 4942.2 4959.9 4973.5 4896.1 4918.9 4949.6 4949.7 4960.4 4811.9 4825.9 4980.2 4989.1 4990.6 4780.7 4824.5 4835.3 4852.5 4903.0 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#1] ext.html Cycles:180 Average:48694.79 Median:36639.32 stddev:87240.91 (238.1%) stddev-sans-first:87410.76 02:55:33 INFO - PROCESS | 9803 | Values: 552.9 582.8 592.6 597.3 600.5 26459.7 38892.0 39848.6 39859.2 39909.8 39832.0 40185.8 40195.6 40258.6 40279.0 7299.1 7438.0 7454.3 7785.8 7933.2 7486.0 9853.3 10129.7 10137.9 10539.3 10341.2 10386.5 10392.6 10404.2 10410.8 7499.0 7672.3 10072.8 10109.2 10146.4 7532.7 9726.8 10153.8 10171.1 10514.9 38681.2 38786.0 38943.8 38964.0 39029.0 2931.1 2987.3 3051.7 3443.0 3447.6 28347.7 29011.6 29478.7 29530.3 29816.4 3333.6 3361.9 3367.3 3410.9 3452.8 250804.0 254695.0 255802.0 256113.0 257425.0 52661.0 53363.5 53367.0 53371.2 53434.2 55994.4 56283.7 56422.0 56487.7 56490.0 14029.9 14365.3 14387.1 14391.9 14406.9 9021.2 10636.9 10897.1 10906.6 10955.8 16301.8 16304.4 16333.3 16344.9 16382.6 6098.8 6100.5 6119.8 6123.6 6222.8 783.0 851.2 852.2 874.4 936.7 27678.7 28178.9 28506.3 28579.3 28826.0 904.3 946.5 961.5 979.4 1060.0 14989.8 15048.5 15355.9 15481.6 15530.7 402043.0 405511.0 406274.0 406348.0 407179.0 49818.0 49901.8 50033.0 50124.7 50148.0 1046.4 1137.0 1149.5 1194.0 1205.3 29025.1 29634.3 29661.7 29981.6 30090.4 42269.0 42843.8 42905.0 42905.0 43257.6 315858.0 317176.0 317209.0 317412.0 317827.0 36424.3 38119.2 38147.2 38151.0 38167.2 41659.6 42400.6 42446.0 42891.8 43452.1 36697.6 37248.6 37336.0 37468.4 37615.0 36102.8 36477.3 36581.0 37050.6 37119.8 36055.6 36535.3 36799.6 36927.1 37158.0 32835.5 33808.7 34099.0 34251.3 34390.0 25346.5 25686.0 25920.2 26185.0 26356.2 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#2] jquery.html Cycles:180 Average:25828.32 Median:58182.71 stddev:66651.29 (114.6%) stddev-sans-first:66810.80 02:55:33 INFO - PROCESS | 9803 | Values: 347.4 365.0 367.9 376.7 377.0 12934.2 16344.6 16452.9 16863.4 17700.9 17331.8 17384.0 17487.5 17712.5 17874.7 5087.5 5280.9 5570.9 5570.9 5655.8 3470.1 3586.7 5270.3 5536.2 5581.4 5594.5 5595.9 5608.7 5619.8 5621.1 5504.8 5923.0 6016.4 6017.5 6025.4 5178.2 5256.0 5269.3 5270.5 5272.3 19031.6 19290.8 19628.0 19644.2 20975.6 1797.3 1829.5 1899.3 1925.9 2487.8 8849.2 9273.4 9489.8 9615.0 9680.0 1770.4 1973.3 2071.3 2110.6 2126.6 66179.0 68642.0 71115.0 84382.0 86451.6 14054.9 14073.5 15959.2 16693.8 17208.1 29217.3 29234.4 29430.7 29522.9 29792.3 9177.1 9237.3 9311.9 9318.8 9402.2 7470.2 7483.0 7555.4 7686.5 7881.0 8207.4 8328.5 8370.2 8455.7 8653.9 3014.9 3089.0 3118.3 3339.4 3367.4 800.1 816.9 838.9 923.9 924.7 16565.8 16837.4 16997.8 17456.9 17683.6 839.0 864.7 882.2 882.9 893.6 9381.1 9491.0 9555.8 9580.0 9818.9 397218.0 401239.0 404367.0 405813.0 405821.0 71711.6 74861.0 75747.6 80876.0 87036.0 901.9 912.8 932.0 945.9 946.2 16011.0 16183.0 16282.1 16298.9 16398.8 39500.4 40017.4 40609.8 40866.0 42090.0 57984.4 58381.0 59278.7 59529.1 59538.7 6934.9 7032.3 7090.2 7149.6 7222.5 9423.8 10193.0 10259.9 10422.1 10574.2 9146.3 9164.6 9268.0 9500.4 9562.7 8728.7 8914.2 9083.9 9099.2 9278.3 8989.6 9337.1 9362.6 9407.9 9538.0 6774.8 6862.2 6926.7 6934.3 7222.2 8523.6 8963.6 9038.5 9294.2 9340.7 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#3] mootools.html Cycles:180 Average:5121.65 Median:5288.84 stddev:2910.41 (55.0%) stddev-sans-first:2904.20 02:55:33 INFO - PROCESS | 9803 | Values: 1272.5 1365.1 1423.6 1473.7 1685.0 6791.6 7463.2 7795.0 7808.7 8040.8 7773.7 7904.0 7907.4 7912.2 7922.2 2185.3 2214.3 2214.3 2214.5 2217.7 2132.3 2161.3 2209.7 2210.2 2210.5 2139.0 2147.8 2165.0 2167.3 2193.5 2076.4 2082.8 2083.3 2085.1 2085.4 2096.7 2119.9 2142.7 2142.9 2150.2 7681.6 7813.5 7931.4 7961.8 7962.3 4455.1 4646.3 4654.3 4676.9 4682.6 2934.8 2997.2 3044.4 3062.9 3063.6 926.5 938.1 940.2 940.8 952.5 10512.4 10559.4 10566.6 10568.2 10587.4 3886.1 4030.9 4075.2 4076.5 4168.5 8283.6 8322.1 8324.5 8350.6 8366.3 4444.6 4446.8 4451.6 4459.8 4461.2 3763.9 4077.7 4172.5 4179.1 4258.6 3461.7 3506.2 3579.0 3590.0 3610.6 1006.8 1046.7 1047.3 1050.5 1054.9 694.3 747.6 860.8 876.1 882.7 5245.9 5376.5 5424.3 5446.7 5555.6 401.4 402.6 407.8 409.4 859.9 3416.9 3669.6 3739.0 3761.0 3767.0 9616.0 9810.2 9841.5 9975.3 9999.8 9699.1 9703.1 9721.7 9730.5 9881.3 7008.0 7038.5 7147.6 7157.0 7159.0 5277.2 5300.4 5404.5 5422.3 5444.6 8971.2 8978.8 9236.4 9255.9 9277.6 8959.6 9250.3 9281.2 9371.1 9390.2 5760.6 5910.0 5967.8 6521.8 6635.5 7530.8 7845.3 7908.3 7912.1 7916.8 6752.6 6899.3 6900.1 6921.8 7031.6 7034.4 7042.9 7068.7 7111.8 7161.1 5829.2 6110.0 6148.8 6238.5 6299.3 4382.1 4466.2 4480.8 4505.6 4526.9 4696.6 4712.9 4727.8 4829.9 4853.5 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#4] prototype.html Cycles:180 Average:4003.37 Median:4338.32 stddev:1146.78 (26.4%) stddev-sans-first:1115.71 02:55:33 INFO - PROCESS | 9803 | Values: 295.1 299.4 308.0 312.1 312.8 4623.3 4730.9 4773.5 4846.6 4857.8 4617.6 4754.4 4771.0 4771.9 4793.4 3772.0 3774.0 3776.3 3806.1 3846.6 3622.5 3666.8 3801.6 3823.8 3829.8 3769.3 3770.1 3793.6 3803.7 3829.6 3782.8 3802.2 3804.8 3810.7 3816.6 3394.4 3397.4 3400.2 3404.3 3410.3 4630.7 4646.3 4653.6 4682.3 4723.2 4305.0 4307.4 4312.2 4326.6 4338.7 4832.4 4979.8 5010.8 5015.4 5072.4 3601.3 3606.8 3609.4 3613.0 3624.5 5259.3 5278.9 5287.9 5310.7 5311.6 3587.3 3692.8 3707.4 3710.2 3715.4 3713.7 3736.1 3754.1 3755.3 3767.3 4257.2 4267.2 4269.3 4284.9 4291.6 4783.5 5023.6 5029.7 5035.3 5054.9 1240.2 1269.1 1269.3 1271.7 1276.5 788.2 794.8 812.7 821.3 824.0 3972.0 3974.8 3977.2 3978.6 3979.1 4496.9 4521.4 4531.5 4538.9 4557.5 3923.5 3930.6 3945.8 3965.7 3996.3 2359.6 2421.2 2430.3 2454.3 2479.9 4248.2 4277.0 4279.3 4353.2 4372.4 4634.8 4654.9 4658.2 4667.2 4668.3 4115.3 4265.1 4272.6 4273.8 4274.5 4506.0 4553.3 4562.2 4571.2 4574.4 4399.9 4411.8 4442.0 4450.6 4503.2 4110.3 4297.1 4313.3 4338.0 4338.7 3281.9 3304.9 3309.6 3319.0 3334.9 4559.9 4568.6 4572.9 4607.4 4949.6 4832.3 4895.7 4944.8 4977.0 4977.9 4978.5 4980.8 4993.9 4996.7 5002.3 4790.0 4953.2 4958.3 4964.6 4972.5 4995.9 5038.8 5052.7 5056.3 5060.7 4874.5 4902.7 4929.1 4960.6 4965.5 02:55:33 INFO - PROCESS | 9803 | 02:55:33 INFO - PROCESS | 9803 | [#5] yui.html Cycles:180 Average:18693.68 Median:514.74 stddev:28082.66 (5455.7%) stddev-sans-first:28128.54 02:55:33 INFO - PROCESS | 9803 | Values: 591.5 602.9 609.6 675.3 682.5 12854.9 13564.3 14186.4 14192.3 14282.2 13153.8 13347.7 13396.4 13408.7 13420.8 627.1 760.2 781.2 782.2 782.6 746.0 780.6 783.2 790.6 792.9 829.1 834.4 834.6 837.9 839.5 648.4 784.0 824.6 825.1 826.0 592.5 595.0 595.0 595.1 595.9 13774.0 13780.8 13821.2 13867.5 13880.2 12041.5 12643.9 12684.2 13004.7 13044.2 11141.4 11376.1 11437.4 11674.6 11731.9 4017.4 4090.4 4098.4 4203.0 4233.0 65496.0 69197.0 69446.0 70269.0 70728.6 9657.0 9749.9 9749.9 10012.7 10155.5 18045.6 18070.8 18095.6 18119.9 18214.7 6600.6 6723.6 6737.8 6794.9 6915.1 3543.0 3562.3 3578.5 3587.1 3638.5 2792.3 2871.2 2873.3 2886.9 2890.3 506.2 507.6 514.8 515.1 521.8 486.6 510.7 511.0 514.7 520.6 7176.2 7226.7 7333.5 7438.5 7547.8 457.3 459.6 487.3 527.9 534.9 3425.6 3499.9 3524.1 3532.8 3640.2 104252.0 104556.0 107247.0 111009.4 112509.0 90664.1 90726.5 91184.5 91981.0 93162.0 47812.5 81706.6 83028.6 83442.6 83925.2 6689.4 6818.9 6909.5 7066.3 7097.5 47204.5 48537.3 49399.0 49831.0 50032.7 67333.0 74197.0 74940.6 75200.6 75588.0 8815.7 8936.8 9236.3 9396.5 9816.6 10092.4 10348.3 10431.3 10728.1 10777.8 6279.5 9393.3 9705.6 10464.2 11270.0 10816.2 11058.7 11062.7 11271.0 11336.3 11530.5 11604.5 11653.1 11915.5 12420.7 9902.0 9975.1 9978.9 10357.3 10449.3 9523.0 9719.1 9738.6 9780.5 9900.8 02:55:33 INFO - PROCESS | 9803 | -------- Summary: end -------- 02:55:33 INFO - PROCESS | 9803 | 02:55:34 INFO - TEST-INFO | 9803: exit 0 02:55:34 INFO - TEST-OK | dromaeo_css | took 1121146ms 02:55:34 INFO - TEST-START | kraken 02:55:34 INFO - operating with platform_type : linux_ 02:55:34 INFO - Initialising browser for kraken test... 02:55:34 INFO - TEST-INFO | started process 9997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3o78o9/profile http://localhost:48717/getInfo.html) 02:55:37 INFO - PROCESS | 9997 | JavaScript error: , line 0: uncaught exception: undefined 02:55:38 INFO - PROCESS | 9997 | __metrics Screen width/height:1600/1200 02:55:38 INFO - PROCESS | 9997 | colorDepth:24 02:55:38 INFO - PROCESS | 9997 | Browser inner width/height: 1024/697 02:55:38 INFO - PROCESS | 9997 | __metrics 02:55:39 INFO - PROCESS | 9997 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:55:39 INFO - PROCESS | 9997 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:40 INFO - TEST-INFO | 9997: exit 0 02:55:40 INFO - Browser initialized. 02:55:40 INFO - Running cycle 1/1 for kraken test... 02:55:40 INFO - TEST-INFO | started process 10081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3o78o9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:52 INFO - PROCESS | 10081 | RSS: Main: 159899648 02:55:52 INFO - PROCESS | 10081 | 02:55:55 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48717/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:56 INFO - PROCESS | 10081 | RSS: Main: 218488832 02:55:56 INFO - PROCESS | 10081 | 02:55:58 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48717/tests/kraken/driver.html?testName=audio-dft) 02:55:59 INFO - PROCESS | 10081 | RSS: Main: 205828096 02:55:59 INFO - PROCESS | 10081 | 02:56:02 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48717/tests/kraken/driver.html?testName=audio-fft) 02:56:03 INFO - PROCESS | 10081 | RSS: Main: 273080320 02:56:03 INFO - PROCESS | 10081 | 02:56:05 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48717/tests/kraken/driver.html?testName=audio-oscillator) 02:56:06 INFO - PROCESS | 10081 | RSS: Main: 182923264 02:56:06 INFO - PROCESS | 10081 | 02:56:08 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:08 INFO - PROCESS | 10081 | RSS: Main: 186052608 02:56:08 INFO - PROCESS | 10081 | 02:56:12 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48717/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:12 INFO - PROCESS | 10081 | RSS: Main: 222339072 02:56:12 INFO - PROCESS | 10081 | 02:56:16 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48717/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:16 INFO - PROCESS | 10081 | RSS: Main: 218341376 02:56:16 INFO - PROCESS | 10081 | 02:56:19 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48717/tests/kraken/driver.html?testName=json-parse-financial) 02:56:20 INFO - PROCESS | 10081 | RSS: Main: 221835264 02:56:20 INFO - PROCESS | 10081 | 02:56:22 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:22 INFO - PROCESS | 10081 | RSS: Main: 210423808 02:56:22 INFO - PROCESS | 10081 | 02:56:24 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:25 INFO - PROCESS | 10081 | RSS: Main: 215109632 02:56:25 INFO - PROCESS | 10081 | 02:56:27 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:28 INFO - PROCESS | 10081 | RSS: Main: 211574784 02:56:28 INFO - PROCESS | 10081 | 02:56:30 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:31 INFO - PROCESS | 10081 | RSS: Main: 224673792 02:56:31 INFO - PROCESS | 10081 | 02:56:34 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:34 INFO - PROCESS | 10081 | RSS: Main: 225456128 02:56:34 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | Cycle 1(1): loaded http://localhost:48717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48717/tests/kraken/driver.html?testName=ai-astar) 02:56:36 INFO - PROCESS | 10081 | RSS: Main: 267214848 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | __start_tp_report 02:56:36 INFO - PROCESS | 10081 | _x_x_mozilla_page_load 02:56:36 INFO - PROCESS | 10081 | _x_x_mozilla_page_load_details 02:56:36 INFO - PROCESS | 10081 | |i|pagename|runs| 02:56:36 INFO - PROCESS | 10081 | |0;ai-astar;103;114;114;114;114;114;113;113;113;116 02:56:36 INFO - PROCESS | 10081 | |1;audio-beat-detection;165;123;126;172;125;124;154;121;166;121 02:56:36 INFO - PROCESS | 10081 | |2;audio-dft;162;161;161;160;164;160;160;165;161;161 02:56:36 INFO - PROCESS | 10081 | |3;audio-fft;76;75;76;123;75;76;74;75;98;75 02:56:36 INFO - PROCESS | 10081 | |4;audio-oscillator;84;85;117;84;84;86;115;84;84;125 02:56:36 INFO - PROCESS | 10081 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;117;118 02:56:36 INFO - PROCESS | 10081 | |6;imaging-darkroom;147;147;146;146;146;147;147;146;146;146 02:56:36 INFO - PROCESS | 10081 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 02:56:36 INFO - PROCESS | 10081 | |8;json-parse-financial;64;62;62;63;63;62;62;63;63;63 02:56:36 INFO - PROCESS | 10081 | |9;json-stringify-tinderbox;65;66;66;65;66;66;67;65;66;66 02:56:36 INFO - PROCESS | 10081 | |10;stanford-crypto-aes;79;78;84;78;78;79;77;78;92;81 02:56:36 INFO - PROCESS | 10081 | |11;stanford-crypto-ccm;126;138;133;138;128;131;128;130;167;131 02:56:36 INFO - PROCESS | 10081 | |12;stanford-crypto-pbkdf2;163;164;166;164;162;162;168;168;169;164 02:56:36 INFO - PROCESS | 10081 | |13;stanford-crypto-sha256-iterative;67;66;67;66;65;74;64;64;64;64 02:56:36 INFO - PROCESS | 10081 | __end_tp_report 02:56:36 INFO - PROCESS | 10081 | __start_cc_report 02:56:36 INFO - PROCESS | 10081 | _x_x_mozilla_cycle_collect,1906 02:56:36 INFO - PROCESS | 10081 | __end_cc_report 02:56:36 INFO - PROCESS | 10081 | __startTimestamp1468749396851__endTimestamp 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | ------- Summary: start ------- 02:56:36 INFO - PROCESS | 10081 | Number of tests: 14 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.55 (3.1%) stddev-sans-first:0.93 02:56:36 INFO - PROCESS | 10081 | Values: 103.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 116.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:140.00 stddev:21.62 (15.4%) stddev-sans-first:20.91 02:56:36 INFO - PROCESS | 10081 | Values: 165.0 123.0 126.0 172.0 125.0 124.0 154.0 121.0 166.0 121.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.72 (1.1%) stddev-sans-first:1.81 02:56:36 INFO - PROCESS | 10081 | Values: 162.0 161.0 161.0 160.0 164.0 160.0 160.0 165.0 161.0 161.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:16.00 (21.2%) stddev-sans-first:16.81 02:56:36 INFO - PROCESS | 10081 | Values: 76.0 75.0 76.0 123.0 75.0 76.0 74.0 75.0 98.0 75.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:16.90 (20.1%) stddev-sans-first:17.46 02:56:36 INFO - PROCESS | 10081 | Values: 84.0 85.0 117.0 84.0 84.0 86.0 115.0 84.0 84.0 125.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:56:36 INFO - PROCESS | 10081 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:56:36 INFO - PROCESS | 10081 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 02:56:36 INFO - PROCESS | 10081 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 02:56:36 INFO - PROCESS | 10081 | Values: 64.0 62.0 62.0 63.0 63.0 62.0 62.0 63.0 63.0 63.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 02:56:36 INFO - PROCESS | 10081 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 67.0 65.0 66.0 66.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:4.55 (5.8%) stddev-sans-first:4.80 02:56:36 INFO - PROCESS | 10081 | Values: 79.0 78.0 84.0 78.0 78.0 79.0 77.0 78.0 92.0 81.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:132.00 stddev:11.94 (9.0%) stddev-sans-first:12.21 02:56:36 INFO - PROCESS | 10081 | Values: 126.0 138.0 133.0 138.0 128.0 131.0 128.0 130.0 167.0 131.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.64 02:56:36 INFO - PROCESS | 10081 | Values: 163.0 164.0 166.0 164.0 162.0 162.0 168.0 168.0 169.0 164.0 02:56:36 INFO - PROCESS | 10081 | 02:56:36 INFO - PROCESS | 10081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:3.03 (4.6%) stddev-sans-first:3.20 02:56:36 INFO - PROCESS | 10081 | Values: 67.0 66.0 67.0 66.0 65.0 74.0 64.0 64.0 64.0 64.0 02:56:36 INFO - PROCESS | 10081 | -------- Summary: end -------- 02:56:36 INFO - PROCESS | 10081 | 02:56:37 INFO - TEST-INFO | 10081: exit 0 02:56:37 INFO - TEST-OK | kraken | took 63729ms 02:56:37 INFO - SUITE-END | took 1184s 02:56:38 INFO - Completed test suite (00:19:45) 02:56:38 INFO - javascript benchmark 02:56:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.9340516487096, 2642.815002949794, 2671.0, 2689.4889970905515, 2690.1257091445273, 4610.815567377309, 4635.613553159041, 4666.043461090477, 4772.331873537708, 4794.065157294324, 4654.6974446661025, 4659.301104834277, 4694.4366675998845, 4758.238681810911, 4765.142274390617, 4083.6528895043957, 4226.218149642326, 4312.892177695567, 4343.283358245885, 4441.777911104448, 4328.177646247219, 4343.5004974427875, 4370.169667763115, 4381.715188512737, 4418.9337159942625, 4209.7474151551005, 4266.957330426687, 4276.550962148961, 4319.179355922396, 4335.263005289108, 4323.913521729579, 4346.521882592912, 4411.801468933906, 4412.602865742067, 4419.315006174048, 4406.713563618387, 4416.183006143874, 4438.600525952647, 4454.48773391061, 4456.598906098434, 4582.770861456914, 4618.261078227468, 4675.836345727917, 4684.789184486673, 4751.097291514601, 4997.825076122318, 5062.569681577071, 5068.467810879842, 5070.340855688773, 5074.898502029976, 4914.9999999999645, 5018.372703412074, 5096.439391666913, 5103.23451482277, 5105.438401775802, 4646.140464014168, 4678.204705200124, 4679.719216847, 4755.906141587454, 4763.380760501182, 5100.387953445536, 5125.436202017775, 5129.204973229155, 5134.178531434953, 5136.486351364908, 4920.138975679313, 4921.089598424303, 4921.557059864558, 4931.038447502702, 4931.802727890844, 4870.853874383774, 4891.5353041461, 4989.25161225819, 4991.450940396553, 5028.924566131511, 5002.874928126826, 5009.474005229471, 5011.0, 5019.47295533971, 5052.469490703496, 4807.495213002584, 4978.352814134139, 4990.90018199634, 4998.2002879539095, 5053.216751403538, 3933.704972127102, 3966.186931678999, 3982.880513584597, 3983.1635356574866, 3990.082281075369, 3534.2401383702627, 3536.0982949347754, 3544.4506101554302, 3571.053670777246, 3571.571411430593, 4314.676399270004, 4321.956780432155, 4339.002029533225, 4375.671824613103, 4377.080813029236, 4954.529319714694, 5000.149974504343, 5022.773975171126, 5050.747462626854, 5062.417821950523, 4339.197248508973, 4357.694961352739, 4363.825446982149, 4392.450943632046, 4404.07514421975, 4606.608438282717, 4611.492735799059, 4614.123316569908, 4621.745803980746, 4660.580547750651, 4561.703489273186, 4669.813207471663, 4702.92945605823, 4712.62299016071, 4783.234682450791, 5000.574951129195, 5012.097822392005, 5017.648764586444, 5022.1964485683575, 5061.038402703474, 4724.126036683225, 4735.14767341868, 4744.122337367598, 4746.454157771763, 4784.067106914118, 4897.0, 4918.778654960607, 4953.504649535018, 4963.478834722447, 4989.575886049726, 5023.070731914608, 5067.391912970467, 5074.340335756328, 5075.568576670877, 5133.101707201299, 4747.026859493864, 4791.616670666269, 4813.7352445615825, 4813.844677277358, 4862.270659401118, 4813.3983252093485, 4910.361652985089, 4942.233953737176, 4959.876003099951, 4973.502649734997, 4896.11869863428, 4918.877028074184, 4949.579285760607, 4949.727764972961, 4960.404751429707, 4811.903761924812, 4825.855224343275, 4980.228064649985, 4989.126902791924, 4990.575801056805, 4780.661414803861, 4824.469308376146, 4835.29888166221, 4852.490488498657, 4903.0], "value": 4605.765105749419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8842757639834, 582.7814569536424, 592.6088781404274, 597.2802772658946, 600.5105838741423, 26459.73540264597, 38892.0, 39848.60151398485, 39859.20281594367, 39909.800450997776, 39832.0, 40185.79907100468, 40195.59804401955, 40258.59741402593, 40279.0, 7299.124105107395, 7437.962810185942, 7454.254574542557, 7785.844283114335, 7933.246341597539, 7486.0, 9853.310268281222, 10129.746756331077, 10137.898621013806, 10539.314944528582, 10341.224408169379, 10386.48067596621, 10392.636257730981, 10404.167666586654, 10410.791784164312, 7499.0, 7672.271134242238, 10072.798544029116, 10109.191264698806, 10146.441945692946, 7532.736354227576, 9726.756831079208, 10153.847692284622, 10171.135453486462, 10514.894851051467, 38681.22637547233, 38786.0, 38943.8052809737, 38964.0, 39029.0, 2931.135315082056, 2987.312918028844, 3051.67957364478, 3443.0, 3447.637998010198, 28347.716522834715, 29011.564826527618, 29478.705212948025, 29530.26174345637, 29816.40367192644, 3333.5818114051435, 3361.9327613447595, 3367.3433680432327, 3410.9147271318166, 3452.8273586320834, 250804.0, 254695.0, 255802.0, 256113.0, 257425.0, 52661.0, 53363.46636533585, 53367.0, 53371.19943200855, 53434.198487022724, 55994.44005559892, 56283.71858140765, 56422.0, 56487.71756141193, 56490.0, 14029.859701402855, 14365.281735913162, 14387.064840785315, 14391.928040359731, 14406.855931440761, 9021.188093071523, 10636.893631063745, 10897.073748731287, 10906.563737450413, 10955.780884382268, 16301.755473667905, 16304.429344972868, 16333.346666133222, 16344.85586008968, 16382.590435239214, 6098.847528811815, 6100.455160905065, 6119.816405507842, 6123.632582045091, 6222.848772977014, 782.9608519573999, 851.1531026628544, 852.2117041736369, 874.3704532736419, 936.6534382278464, 27678.727626245032, 28178.85910570434, 28506.287342816595, 28579.28551786222, 28826.0, 904.2901322461968, 946.4699768129869, 961.5096300886598, 979.4270351844109, 1060.0, 14989.775153372708, 15048.548543543711, 15355.92322038405, 15481.612959676098, 15530.689386212212, 402043.0, 405511.0, 406274.0, 406348.0, 407179.0, 49818.0, 49901.75049124731, 50033.0, 50124.74937625288, 50148.0, 1046.4401545173296, 1136.9943150284362, 1149.5229479765972, 1194.0268681025111, 1205.3009254632468, 29025.12924612265, 29634.259143521584, 29661.703382965894, 29981.55027674543, 30090.3981920356, 42269.0, 42843.785781070896, 42904.99999999875, 42905.0, 43257.56742432535, 315858.0, 317176.0, 317209.0, 317412.0, 317827.0, 36424.27151457009, 38119.23761524699, 38147.23705525929, 38150.99414561431, 38167.236655266184, 41659.58340416557, 42400.57599423966, 42446.0, 42891.78554107335, 43452.130957381305, 36697.63302366942, 37248.62751372452, 37336.0, 37468.43797342988, 37615.0, 36102.8194859024, 36477.27045459023, 36581.0, 37050.6294937058, 37119.814400927826, 36055.63944360523, 36535.26929461343, 36799.63200367962, 36927.07682307964, 37158.0, 32835.50746738753, 33808.66191338055, 34099.0, 34251.314973700886, 34390.0, 25346.493070138124, 25686.0, 25920.22239332823, 26185.0, 26356.209313720618], "value": 18116.082350361525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3591224191366, 364.9781013139211, 367.935611268028, 376.70805126027324, 376.9641884021017, 12934.223946563201, 16344.591385215375, 16452.91773541132, 16863.40978065768, 17700.91149544254, 17331.82668173318, 17384.0, 17487.475375738748, 17712.468625941212, 17874.731879021823, 5087.465816089313, 5280.9207861882105, 5570.944290557103, 5570.944290557103, 5655.773769049254, 3470.0630829675974, 3586.7130629549706, 5270.262163297141, 5536.169574563827, 5581.413951535092, 5594.49649531542, 5595.888082238353, 5608.663480191181, 5619.831405057855, 5621.072523033695, 5504.779808807642, 5923.0, 6016.42843929826, 6017.518598512109, 6025.367336429656, 5178.171492561172, 5255.973720131413, 5269.341332333458, 5270.49930256625, 5272.340957380327, 19031.619367612708, 19290.80709192904, 19628.0, 19644.214231430724, 20975.643896976562, 1797.290070422189, 1829.4968883556994, 1899.2877670873422, 1925.8748181368305, 2487.7885379742743, 8849.203571678516, 9273.39722918015, 9489.810203795954, 9614.95192524033, 9680.0, 1770.3980646580096, 1973.289615738333, 2071.2543484345624, 2110.5778844231213, 2126.627840127987, 66179.0, 68642.0, 71115.0, 84382.0, 86451.56774216151, 14054.85945140556, 14073.507427239998, 15959.202039897958, 16693.83306166947, 17208.1395930203, 29217.269568260963, 29234.415311693647, 29430.705692942796, 29522.852385737933, 29792.255193620334, 9177.128172823572, 9237.30720195988, 9311.860322095174, 9318.813623727487, 9402.247820174369, 7470.215627359158, 7483.0, 7555.395568354518, 7686.538807671557, 7880.960595196987, 8207.384446166561, 8328.5002899825, 8370.16298370158, 8455.74632761018, 8653.913460865437, 3014.9397012059635, 3088.9997453298033, 3118.2672072063046, 3339.395271688087, 3367.4275373186615, 800.1038836503154, 816.93056090233, 838.9161083891562, 923.9260859131253, 924.7410724997012, 16565.751513727304, 16837.41069062577, 16997.830021699625, 17456.91271543634, 17683.646327073388, 838.9706360277361, 864.6671031652859, 882.188386684252, 882.8587426011808, 893.6068130022899, 9381.108794664497, 9491.0, 9555.808883822285, 9579.952100239454, 9818.90181098194, 397218.0, 401239.0, 404367.0, 405813.0, 405821.0, 71711.6414417935, 74861.0, 75747.62126189334, 80876.0, 87036.0, 901.9458832470073, 912.7535565397305, 932.0399988012358, 945.9148676619, 946.1768261612441, 16011.0, 16183.0, 16282.104484253006, 16298.918505407397, 16398.83601163973, 39500.40749388819, 40017.399739003355, 40609.79695101624, 40866.0, 42090.0, 57984.4201557979, 58381.0, 59278.70360648169, 59529.10706339322, 59538.70230648819, 6934.861302773816, 7032.26161253061, 7090.220075791762, 7149.642517873982, 7222.530535515175, 9423.764405889908, 10193.0316619921, 10259.948700256451, 10422.062014418738, 10574.154067674413, 9146.314026448175, 9164.605592519283, 9268.0, 9500.382475139093, 9562.713118606453, 8728.738137855875, 8914.153155450222, 9083.863742044006, 9099.226565741987, 9278.257739380968, 8989.640414383352, 9337.112974267433, 9362.625494980124, 9407.85888211691, 9538.043072140526, 6774.762883299061, 6862.176538815374, 6926.688299026455, 6934.306569343227, 7222.205557388578, 8523.573821309034, 8963.596638151168, 9038.457692538468, 9294.163525282487, 9340.673076442292], "value": 8823.143334135431, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.510083617807, 1365.112676760106, 1423.6369725719942, 1473.6978919321534, 1685.0479479094304, 6791.626460544674, 7463.2163622819635, 7794.999999999985, 7808.726694565684, 8040.8391832163325, 7773.6501857416415, 7903.960480197606, 7907.367410607152, 7912.248336408046, 7922.168172341893, 2185.3007037747925, 2214.26929113393, 2214.2914267434426, 2214.534947660985, 2217.7227846519186, 2132.349633361824, 2161.3407910587266, 2209.657503087024, 2210.204326442479, 2210.546837898235, 2139.0267428320076, 2147.7852214778477, 2164.9891750541306, 2167.349795061475, 2193.517426166241, 2076.4289820299464, 2082.781307962665, 2083.333333333334, 2085.124247815921, 2085.363963990982, 2096.67501537262, 2119.9152033918626, 2142.700021996922, 2142.8714277143267, 2150.2259186692777, 7681.57751323677, 7813.453058285922, 7931.365490760725, 7961.761147165595, 7962.283394494523, 4455.086707225011, 4646.256598944186, 4654.2785868190485, 4676.859694209179, 4682.6019788318035, 2934.7652187824924, 2997.2357048952595, 3044.40634076353, 3062.8621712023014, 3063.6476805167244, 926.4672813132476, 938.0994245524305, 940.1867384712243, 940.8353538130868, 952.4904176265734, 10512.421816800073, 10559.41923194224, 10566.577336906514, 10568.15454763617, 10587.364758114461, 3886.145048089416, 4030.8790736277374, 4075.1645912587846, 4076.5311989121633, 4168.499780026416, 8283.62723677436, 8322.084570697218, 8324.542150181676, 8350.582470876432, 8366.288865446384, 4444.577765112309, 4446.755428451402, 4451.554844515523, 4459.754713490789, 4461.196984542748, 3763.9059023524082, 4077.734947228421, 4172.499300083949, 4179.059711564873, 4258.61672449481, 3461.6884480396884, 3506.2111025019167, 3578.964210357863, 3590.0486371111674, 3610.6389361063684, 1006.7936073104996, 1046.6598355534481, 1047.3035431438161, 1050.5272627317738, 1054.8839627640953, 694.3299715774201, 747.6411322565199, 860.8149247911729, 876.0932434929817, 882.6778225947482, 5245.947540524622, 5376.489233522809, 5424.294841670637, 5446.700431476307, 5555.555555555546, 401.4119315203183, 402.57729384147115, 407.802215925276, 409.4390684761836, 859.8968123825181, 3416.931661366759, 3669.5779985301497, 3738.981305093457, 3761.040934561724, 3767.0, 9615.951920240354, 9810.21518278536, 9841.45871977048, 9975.25185611082, 9999.800004000024, 9699.078587534173, 9703.07820757027, 9721.70834874955, 9730.513474326255, 9881.25890558211, 7008.0, 7038.542494737928, 7147.571145731169, 7157.0, 7159.0, 5277.234800953764, 5300.443453437488, 5404.459554044564, 5422.322209723785, 5444.564434845282, 8971.237444817003, 8978.775530611787, 9236.353455258337, 9255.907440925504, 9277.62889484413, 8959.641614335615, 9250.306227033134, 9281.211097056555, 9371.062893710574, 9390.154886060287, 5760.567957403296, 5909.970450147722, 5967.8209653710455, 6521.771737989147, 6635.502337324623, 7530.774076777706, 7845.29392354668, 7908.288254057163, 7912.0901096374655, 7916.802079948047, 6752.5948443093575, 6899.344562266577, 6900.137482814648, 6921.792346229621, 7031.613261270679, 7034.402075823612, 7042.929570704227, 7068.71725130989, 7111.82220444493, 7161.104861892263, 5829.242198514166, 6109.969450152721, 6148.754049837957, 6238.469730072995, 6299.338569450325, 4382.101669157879, 4466.173757854807, 4480.843170489017, 4505.5719706627815, 4526.932096018497, 4696.600788932979, 4712.882177945578, 4727.763611819464, 4829.879253018703, 4853.466118726867], "value": 4052.6873170901854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1470250974684, 299.42360955161314, 307.98460076996145, 312.0980366740123, 312.8435782108946, 4623.329617205503, 4730.858074257778, 4773.4510531288915, 4846.612271018319, 4857.829975950847, 4617.630589552836, 4754.429468463781, 4771.0, 4771.90456190876, 4793.352897358855, 3771.9811400943095, 3773.9622603773887, 3776.2636285924323, 3806.0675134592066, 3846.5576458707187, 3622.47474116253, 3666.7983260920637, 3801.6388443097862, 3823.847046118152, 3829.8468061277517, 3769.321522126016, 3770.1328694400304, 3793.5637401698746, 3803.657670809627, 3829.5978922213185, 3782.773033617978, 3802.16352402471, 3804.7634518781506, 3810.6760925321105, 3816.599257078022, 3394.439917413624, 3397.4394224952853, 3400.1839558506026, 3404.285100128976, 3410.28384039352, 4630.699004564693, 4646.326282688991, 4653.557911998355, 4682.274247491644, 4723.244280915037, 4304.956950430487, 4307.396964424952, 4312.180685669744, 4326.610605045529, 4338.652907767402, 4832.395950506187, 4979.7759100840185, 5010.774515146827, 5015.423226328982, 5072.351485767103, 3601.333753255656, 3606.783592984429, 3609.3864043112735, 3612.9638703613155, 3624.4925710400303, 5259.316288882459, 5278.9208161877605, 5287.86780330491, 5310.734463276859, 5311.628186026941, 3587.336342776595, 3692.778433294011, 3707.443883417455, 3710.165212827092, 3715.368387374153, 3713.6843368313994, 3736.1220113273357, 3754.136548593784, 3755.267722794029, 3767.2842159989514, 4257.169851878916, 4267.16790225903, 4269.274223382033, 4284.91430171401, 4291.592298731615, 4783.521647835189, 5023.598112151019, 5029.698218106925, 5035.345405097314, 5054.9241761373605, 1240.193873981919, 1269.0989397527674, 1269.3145701321182, 1271.713864380507, 1276.4638851682316, 788.1921030943329, 794.8211652378284, 812.7196117339508, 821.3347188776991, 823.9782669489789, 3971.960280397217, 3974.7615143091507, 3977.204559088194, 3978.622030907059, 3979.070150976774, 4496.887577810516, 4521.412216411845, 4531.456225252925, 4538.91066144123, 4557.453105627346, 3923.489946306962, 3930.567637559866, 3945.782981936021, 3965.7025723070883, 3996.3415182698855, 2359.64605309205, 2421.152596591179, 2430.2709187243754, 2454.251453306759, 2479.863607501569, 4248.235317642854, 4276.957230427718, 4279.33670281107, 4353.238183317907, 4372.398422938347, 4634.814607415733, 4654.930176047362, 4658.231391820379, 4667.159911215946, 4668.276417155346, 4115.279826030433, 4265.1043280910735, 4272.551382104896, 4273.786310684515, 4274.529801721808, 4505.977470112629, 4553.2942393929, 4562.247229207143, 4571.222892108283, 4574.359589657517, 4399.934000989923, 4411.823527058882, 4441.955580444154, 4450.618918878385, 4503.234450143418, 4110.34234522475, 4297.140571885698, 4313.266744653479, 4337.9783101084295, 4338.717983331074, 3281.8851340202978, 3304.8512816922816, 3309.6028476582965, 3319.0042987104257, 3334.9166270843425, 4559.908801824011, 4568.565986231436, 4572.908541829078, 4607.354970304227, 4949.57928576075, 4832.275158726219, 4895.657303988686, 4944.777485013111, 4976.950230497793, 4977.850664480072, 4978.47725988766, 4980.750962451935, 4993.850184494471, 4996.7001979881325, 5002.299678045149, 4789.976050119866, 4953.18272485036, 4958.2810492477665, 4964.553190212898, 4972.477889821516, 4995.900081998267, 5038.848834534823, 5052.722100284373, 5056.342675452168, 5060.721660308718, 4874.488178741323, 4902.730349830794, 4929.13740095489, 4960.553550180501, 4965.503449655005], "value": 3643.7066640920093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4735885062295, 602.927648682158, 609.5641616244384, 675.294317438277, 682.5358756045888, 12854.871451285484, 13564.253966031889, 14186.361613727395, 14192.290385480723, 14282.214478203694, 13153.802692959613, 13347.733045339088, 13396.397162127703, 13408.731825363488, 13420.798688019662, 627.1126356205963, 760.1524300405036, 781.2109769133187, 782.1552723059111, 782.6321628834439, 745.9813504662372, 780.5784876166863, 783.2363445640511, 790.5809920742016, 792.9048514178306, 829.1294141151797, 834.3950635789065, 834.5827086456771, 837.8617528107854, 839.4879123734516, 648.3775575447576, 783.996080019602, 824.575343697996, 825.1253671108614, 826.0252901576138, 592.5082181789105, 594.9821505354846, 595.0271306414044, 595.0538643556765, 595.9046552551571, 13774.035817492779, 13780.793288100687, 13821.170729756146, 13867.514636987657, 13880.236586987712, 12041.458134383975, 12643.93678031604, 12684.175528590613, 13004.739905201937, 13044.217346959118, 11141.442927853655, 11376.146788990776, 11437.370944598044, 11674.591389301333, 11731.88268117325, 4017.35722284436, 4090.447789548403, 4098.446709694183, 4203.012292111352, 4233.0, 65496.0, 69197.0, 69445.95831062588, 70269.0, 70728.6463567684, 9656.95171524138, 9749.853752193723, 9749.902500975042, 10012.69961901144, 10155.543000564992, 18045.639087218446, 18070.819291807176, 18095.63808723818, 18119.909400452914, 18214.726779098324, 6600.60396376219, 6723.562968407038, 6737.831554211086, 6794.864102717918, 6915.066466027022, 3542.992643155857, 3562.2697347043795, 3578.4990101385306, 3587.0673624857204, 3638.508801311842, 2792.274008757697, 2871.2104171353044, 2873.324768679359, 2886.898958536483, 2890.2918784897834, 506.2355842677583, 507.57363814396086, 514.7503460821498, 515.0780103614563, 521.7704210147523, 486.5961252160698, 510.6578592343139, 510.98978020440126, 514.7271945868696, 520.565327951165, 7176.210616832144, 7226.710931562784, 7333.4866559340335, 7438.516496427715, 7547.849043019219, 457.32772823948744, 459.57718898613354, 487.2690963554668, 527.947205279469, 534.8689571055116, 3425.6231814500384, 3499.9125021874656, 3524.101354154674, 3532.8056956867617, 3640.18095928414, 104252.0, 104556.0, 107247.0, 111009.44495277472, 112509.0, 90664.09335906689, 90726.54636726774, 91184.54407727919, 91981.0, 93162.0, 47812.5218747815, 81706.59146704228, 83028.58485707654, 83442.5827870869, 83925.16074839295, 6689.431398331197, 6818.863622727418, 6909.481788865955, 7066.258042905421, 7097.503174777922, 47204.52795472001, 48537.27194092021, 49399.0, 49831.0, 50032.74983625204, 67333.0, 74197.0, 74940.62529687317, 75200.62399687967, 75588.0, 8815.735527934172, 8936.776580585538, 9236.30727695439, 9396.483193424154, 9816.607335706492, 10092.394456332644, 10348.275620706478, 10431.269811113452, 10728.141748660244, 10777.784444311226, 6279.497640188865, 9393.295502837178, 9705.563249653642, 10464.215183861394, 11270.0, 10816.188785840935, 11058.668239952814, 11062.723431914266, 11271.0, 11336.263142895685, 11530.481128349076, 11604.477798499256, 11653.126015548698, 11915.52337906474, 12420.689482762642, 9901.970982618119, 9975.107218906436, 9978.850317245393, 10357.274990750575, 10449.268551201343, 9523.0, 9719.086348320918, 9738.561764720464, 9780.510974451392, 9900.752481188028], "value": 6449.493165187168, "unit": "score"}], "name": "dromaeo_css", "value": 6421.5935362234895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 116.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 123.0, 126.0, 172.0, 125.0, 124.0, 154.0, 121.0, 166.0, 121.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 164.0, 160.0, 160.0, 165.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 123.0, 75.0, 76.0, 74.0, 75.0, 98.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 84.0, 84.0, 86.0, 115.0, 84.0, 84.0, 125.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 84.0, 78.0, 78.0, 79.0, 77.0, 78.0, 92.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 138.0, 133.0, 138.0, 128.0, 131.0, 128.0, 130.0, 167.0, 131.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 164.0, 162.0, 162.0, 168.0, 168.0, 169.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 65.0, 74.0, 64.0, 64.0, 64.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1524.9, "alertThreshold": 2.0}]} 02:56:38 INFO - Return code: 0 02:56:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:38 INFO - # TBPL SUCCESS # 02:56:38 INFO - Running post-action listener: _resource_record_post_action 02:56:38 INFO - ##### 02:56:38 INFO - ##### Finished run-tests step (success) 02:56:38 INFO - ##### 02:56:38 INFO - Running post-run listener: _resource_record_post_run 02:56:38 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 544600064; Read time: 0; Write time: 488840 02:56:38 INFO - TinderboxPrint: CPU usage
13.1% 02:56:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:56:38 INFO - TinderboxPrint: I/O write bytes / time
544,600,064 / 488,840 02:56:38 INFO - TinderboxPrint: CPU idle
8,339.7 (86.9%) 02:56:38 INFO - TinderboxPrint: CPU user
1,211.1 (12.6%) 02:56:38 INFO - TinderboxPrint: Swap in / out
0 / 0 02:56:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256032768; Read time: 0; Write time: 280332 02:56:38 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 288567296; Read time: 0; Write time: 208508 02:56:38 INFO - Running post-run listener: _upload_blobber_files 02:56:38 INFO - Blob upload gear active. 02:56:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:38 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 02:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:39 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:40 INFO - (blobuploader) - INFO - Done attempting. 02:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:58 INFO - (blobuploader) - INFO - Done attempting. 02:56:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:59 INFO - (blobuploader) - INFO - Done attempting. 02:56:59 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:59 INFO - Return code: 0 02:56:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3172ef7214860a7c5bf53c8ddc9ddad4f1b50e4514ffe35d6d1d4acaefdef748d6272e9ae4c65a476bd99d492b3153a6500b62fe2e4b3c73e4830421157826b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e059d9be35bc7454b359777634456742106e921955777b4281f6414be64a02a4e1e6cb41c904fe92c6c13b317ec1b6a5a4d1941450069fb769c5bf3fa02b36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dfa97ff9401d036431096425b56fbd3f42a28f26326a6c355cd271a3debc5c6b1d948c3a0aebad1c4a857f3605735a1727da717c27e7c62db62ffdf4f410de4"} 02:56:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:59 INFO - Contents: 02:56:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3172ef7214860a7c5bf53c8ddc9ddad4f1b50e4514ffe35d6d1d4acaefdef748d6272e9ae4c65a476bd99d492b3153a6500b62fe2e4b3c73e4830421157826b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e059d9be35bc7454b359777634456742106e921955777b4281f6414be64a02a4e1e6cb41c904fe92c6c13b317ec1b6a5a4d1941450069fb769c5bf3fa02b36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dfa97ff9401d036431096425b56fbd3f42a28f26326a6c355cd271a3debc5c6b1d948c3a0aebad1c4a857f3605735a1727da717c27e7c62db62ffdf4f410de4"} 02:56:59 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:59 INFO - Copying logs to upload dir... 02:56:59 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.824037 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-17 02:56:59.411434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:56:59.414772) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3172ef7214860a7c5bf53c8ddc9ddad4f1b50e4514ffe35d6d1d4acaefdef748d6272e9ae4c65a476bd99d492b3153a6500b62fe2e4b3c73e4830421157826b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e059d9be35bc7454b359777634456742106e921955777b4281f6414be64a02a4e1e6cb41c904fe92c6c13b317ec1b6a5a4d1941450069fb769c5bf3fa02b36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dfa97ff9401d036431096425b56fbd3f42a28f26326a6c355cd271a3debc5c6b1d948c3a0aebad1c4a857f3605735a1727da717c27e7c62db62ffdf4f410de4"} build_url:https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/C7r5mYX9TCOwDUR2pVjLLQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3172ef7214860a7c5bf53c8ddc9ddad4f1b50e4514ffe35d6d1d4acaefdef748d6272e9ae4c65a476bd99d492b3153a6500b62fe2e4b3c73e4830421157826b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e059d9be35bc7454b359777634456742106e921955777b4281f6414be64a02a4e1e6cb41c904fe92c6c13b317ec1b6a5a4d1941450069fb769c5bf3fa02b36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dfa97ff9401d036431096425b56fbd3f42a28f26326a6c355cd271a3debc5c6b1d948c3a0aebad1c4a857f3605735a1727da717c27e7c62db62ffdf4f410de4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 02:56:59.440642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:56:59.440985) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1468747874.69611-1223363042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 02:56:59.524539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:56:59.524895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 02:56:59.525227) ========= ========= Total master_lag: 0.18 =========