builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1472556397.4 results: success (0) buildid: 20160830034521 builduid: 2ece869453e94212b762b3e748362ed3 revision: 444b23193a56cec7f47763e4afb3d4881e40632e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.399499) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.399938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.400237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.428778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.429089) ========= 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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 04:26:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.3M=0s 2016-08-30 04:26:37 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085597 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.804354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.804642) ========= 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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016774 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.836824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:37.838775) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 444b23193a56cec7f47763e4afb3d4881e40632e --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 444b23193a56cec7f47763e4afb3d4881e40632e --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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 04:26:37,948 truncating revision to first 12 chars 2016-08-30 04:26:37,948 Setting DEBUG logging. 2016-08-30 04:26:37,948 attempt 1/10 2016-08-30 04:26:37,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/444b23193a56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 04:26:38,253 unpacking tar archive at: fx-team-444b23193a56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:38.473908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:38.474273) ========= script_repo_revision: 444b23193a56cec7f47763e4afb3d4881e40632e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:38.474670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:38.475029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 04:26:38.484714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-30 04:26:38.485142) ========= /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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:38 INFO - MultiFileLogger online at 20160830 04:26:38 in /builds/slave/test 04:26:38 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 04:26:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:38 INFO - {'append_to_log': False, 04:26:38 INFO - 'base_work_dir': '/builds/slave/test', 04:26:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:26:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:38 INFO - 'branch': 'Fx-Team-Non-PGO', 04:26:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:38 INFO - 'config_files': ('talos/linux_config.py',), 04:26:38 INFO - 'default_actions': ('clobber', 04:26:38 INFO - 'read-buildbot-config', 04:26:38 INFO - 'download-and-extract', 04:26:38 INFO - 'populate-webroot', 04:26:38 INFO - 'create-virtualenv', 04:26:38 INFO - 'install', 04:26:38 INFO - 'run-tests'), 04:26:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:38 INFO - 'download_minidump_stackwalk': True, 04:26:38 INFO - 'download_symbols': 'ondemand', 04:26:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:38 INFO - 'installer_path': 'installer.exe', 04:26:38 INFO - 'log_level': 'info', 04:26:38 INFO - 'log_name': 'talos', 04:26:38 INFO - 'log_to_console': True, 04:26:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:38 INFO - 'opt_config_files': (), 04:26:38 INFO - 'pip_index': False, 04:26:38 INFO - 'sps_profile': False, 04:26:38 INFO - 'sps_profile_interval': 0, 04:26:38 INFO - 'suite': 'dromaeojs', 04:26:38 INFO - 'system_bits': '32', 04:26:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:38 INFO - 'title': 'talos-linux64-ix-008', 04:26:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:38 INFO - 'use_talos_json': True, 04:26:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:38 INFO - 'work_dir': 'build'} 04:26:38 INFO - [mozharness: 2016-08-30 11:26:38.691720Z] Running clobber step. 04:26:38 INFO - Running pre-action listener: _resource_record_pre_action 04:26:38 INFO - Running main action method: clobber 04:26:38 INFO - rmtree: /builds/slave/test/build 04:26:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:39 INFO - Running post-action listener: _resource_record_post_action 04:26:39 INFO - [mozharness: 2016-08-30 11:26:39.143395Z] Finished clobber step (success) 04:26:39 INFO - [mozharness: 2016-08-30 11:26:39.143498Z] Running read-buildbot-config step. 04:26:39 INFO - Running pre-action listener: _resource_record_pre_action 04:26:39 INFO - Running main action method: read_buildbot_config 04:26:39 INFO - Using buildbot properties: 04:26:39 INFO - { 04:26:39 INFO - "project": "", 04:26:39 INFO - "product": "firefox", 04:26:39 INFO - "script_repo_revision": "production", 04:26:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:26:39 INFO - "repository": "", 04:26:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:26:39 INFO - "buildid": "20160830034521", 04:26:39 INFO - "pgo_build": "False", 04:26:39 INFO - "basedir": "/builds/slave/test", 04:26:39 INFO - "buildnumber": 1903, 04:26:39 INFO - "slavename": "talos-linux64-ix-008", 04:26:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:26:39 INFO - "platform": "ubuntu64_hw", 04:26:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:26:39 INFO - "branch": "fx-team", 04:26:39 INFO - "repo_path": "integration/fx-team", 04:26:39 INFO - "revision": "444b23193a56cec7f47763e4afb3d4881e40632e", 04:26:39 INFO - "stage_platform": "linux64", 04:26:39 INFO - "builduid": "2ece869453e94212b762b3e748362ed3", 04:26:39 INFO - "slavebuilddir": "test" 04:26:39 INFO - } 04:26:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:26:39 INFO - Running post-action listener: _resource_record_post_action 04:26:39 INFO - [mozharness: 2016-08-30 11:26:39.145923Z] Finished read-buildbot-config step (success) 04:26:39 INFO - [mozharness: 2016-08-30 11:26:39.146013Z] Running download-and-extract step. 04:26:39 INFO - Running pre-action listener: _resource_record_pre_action 04:26:39 INFO - Running main action method: download_and_extract 04:26:39 INFO - mkdir: /builds/slave/test/build/tests 04:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:39 INFO - trying https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:26:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:26:39 INFO - Downloaded 1361 bytes. 04:26:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:26:39 INFO - Using the following test package requirements: 04:26:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:26:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'jsshell-linux-x86_64.zip'], 04:26:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:39 INFO - trying https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:26:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:26:41 INFO - Downloaded 20315578 bytes. 04:26:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 04:26:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:45 INFO - trying https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:26:45 INFO - Downloading https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:26:46 INFO - Downloaded 20315578 bytes. 04:26:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 04:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:51 INFO - trying https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:51 INFO - Downloading https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:26:52 INFO - Downloaded 14413998 bytes. 04:26:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 04:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:52 INFO - trying https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:26:52 INFO - Downloading https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:26:55 INFO - Downloaded 55853722 bytes. 04:26:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:26:55 INFO - mkdir: /builds/slave/test/properties 04:26:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:55 INFO - Contents: 04:26:55 INFO - build_url:https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:26:55 INFO - Running post-action listener: _resource_record_post_action 04:26:55 INFO - Running post-action listener: set_extra_try_arguments 04:26:55 INFO - [mozharness: 2016-08-30 11:26:55.737197Z] Finished download-and-extract step (success) 04:26:55 INFO - [mozharness: 2016-08-30 11:26:55.737424Z] Running populate-webroot step. 04:26:55 INFO - Running pre-action listener: _resource_record_pre_action 04:26:55 INFO - Running main action method: populate_webroot 04:26:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:55 INFO - '--tppagecycles', 04:26:55 INFO - '7'], 04:26:55 INFO - 'tests': ['tsvgm']}}, 04:26:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['damp', 'tps']}, 04:26:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'tests': ['damp', 'tps']}, 04:26:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['dromaeo_dom']}, 04:26:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['basic_compositor_video']}, 04:26:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:26:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['a11yr', 04:26:55 INFO - 'ts_paint', 04:26:55 INFO - 'tpaint', 04:26:55 INFO - 'sessionrestore', 04:26:55 INFO - 'sessionrestore_no_auto_restore', 04:26:55 INFO - 'tabpaint']}, 04:26:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['tsvgx', 04:26:55 INFO - 'tsvgr_opacity', 04:26:55 INFO - 'tart', 04:26:55 INFO - 'tscrollx', 04:26:55 INFO - 'cart']}, 04:26:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:55 INFO - 'tsvgr_opacity', 04:26:55 INFO - 'tart', 04:26:55 INFO - 'tscrollx', 04:26:55 INFO - 'cart']}, 04:26:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'talos_options': ['--disable-e10s'], 04:26:55 INFO - 'tests': ['tp5o']}, 04:26:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'tests': ['tp5o']}, 04:26:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'talos_options': ['--disable-e10s', 04:26:55 INFO - '--xperf_path', 04:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:55 INFO - 'tests': ['tp5n']}, 04:26:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:55 INFO - 'talos_options': ['--xperf_path', 04:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:55 INFO - 'tests': ['tp5n']}}, 04:26:55 INFO - 'talos.zip': {'path': '', 04:26:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:55 INFO - Running post-action listener: _resource_record_post_action 04:26:55 INFO - [mozharness: 2016-08-30 11:26:55.754638Z] Finished populate-webroot step (success) 04:26:55 INFO - [mozharness: 2016-08-30 11:26:55.754727Z] Running create-virtualenv step. 04:26:55 INFO - Running pre-action listener: _resource_record_pre_action 04:26:55 INFO - Running main action method: create_virtualenv 04:26:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:55 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 04:26:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:55 INFO - Using real prefix '/usr' 04:26:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:58 INFO - Installing pip.................done. 04:26:58 INFO - Return code: 0 04:26:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:26:58 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 04:26:58 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 04:26:58 INFO - Using env: {'DISPLAY': ':0', 04:26:58 INFO - 'HOME': '/home/cltbld', 04:26:58 INFO - 'LANG': 'en_US.UTF-8', 04:26:58 INFO - 'LANGUAGE': 'en_US:en', 04:26:58 INFO - 'LOGNAME': 'cltbld', 04:26:58 INFO - 'MAIL': '/var/mail/cltbld', 04:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:58 INFO - 'MOZ_NO_REMOTE': '1', 04:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:58 INFO - 'NO_EM_RESTART': '1', 04:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:58 INFO - 'PWD': '/builds/slave/test', 04:26:58 INFO - 'SHELL': '/bin/bash', 04:26:58 INFO - 'SHLVL': '1', 04:26:58 INFO - 'TERM': 'linux', 04:26:58 INFO - 'TMOUT': '86400', 04:26:58 INFO - 'USER': 'cltbld', 04:26:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:58 INFO - '_': '/tools/buildbot/bin/python'} 04:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:58 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 04:26:58 INFO - Cleaning up... 04:26:58 INFO - Return code: 0 04:26:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:26:58 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 04:26:58 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 04:26:58 INFO - Using env: {'DISPLAY': ':0', 04:26:58 INFO - 'HOME': '/home/cltbld', 04:26:58 INFO - 'LANG': 'en_US.UTF-8', 04:26:58 INFO - 'LANGUAGE': 'en_US:en', 04:26:58 INFO - 'LOGNAME': 'cltbld', 04:26:58 INFO - 'MAIL': '/var/mail/cltbld', 04:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:58 INFO - 'MOZ_NO_REMOTE': '1', 04:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:58 INFO - 'NO_EM_RESTART': '1', 04:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:58 INFO - 'PWD': '/builds/slave/test', 04:26:58 INFO - 'SHELL': '/bin/bash', 04:26:58 INFO - 'SHLVL': '1', 04:26:58 INFO - 'TERM': 'linux', 04:26:58 INFO - 'TMOUT': '86400', 04:26:58 INFO - 'USER': 'cltbld', 04:26:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:58 INFO - '_': '/tools/buildbot/bin/python'} 04:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:58 INFO - Downloading/unpacking psutil>=3.1.1 04:26:58 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 04:26:58 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 04:26:58 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 04:26:58 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 04:26:58 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 04:26:58 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 04:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:00 INFO - Installing collected packages: psutil 04:27:00 INFO - Running setup.py install for psutil 04:27:00 INFO - building 'psutil._psutil_linux' extension 04:27:00 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 04:27:00 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 04:27:01 INFO - building 'psutil._psutil_posix' extension 04:27:01 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 04:27:01 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 04:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:01 INFO - Successfully installed psutil 04:27:01 INFO - Cleaning up... 04:27:01 INFO - Return code: 0 04:27:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:01 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:01 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 04:27:01 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 04:27:01 INFO - Using env: {'DISPLAY': ':0', 04:27:01 INFO - 'HOME': '/home/cltbld', 04:27:01 INFO - 'LANG': 'en_US.UTF-8', 04:27:01 INFO - 'LANGUAGE': 'en_US:en', 04:27:01 INFO - 'LOGNAME': 'cltbld', 04:27:01 INFO - 'MAIL': '/var/mail/cltbld', 04:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:01 INFO - 'MOZ_NO_REMOTE': '1', 04:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:01 INFO - 'NO_EM_RESTART': '1', 04:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:01 INFO - 'PWD': '/builds/slave/test', 04:27:01 INFO - 'SHELL': '/bin/bash', 04:27:01 INFO - 'SHLVL': '1', 04:27:01 INFO - 'TERM': 'linux', 04:27:01 INFO - 'TMOUT': '86400', 04:27:01 INFO - 'USER': 'cltbld', 04:27:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:01 INFO - '_': '/tools/buildbot/bin/python'} 04:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:01 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 04:27:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:03 INFO - Installing collected packages: mozsystemmonitor 04:27:03 INFO - Running setup.py install for mozsystemmonitor 04:27:03 INFO - Successfully installed mozsystemmonitor 04:27:03 INFO - Cleaning up... 04:27:03 INFO - Return code: 0 04:27:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:03 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:03 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 04:27:03 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 04:27:03 INFO - Using env: {'DISPLAY': ':0', 04:27:03 INFO - 'HOME': '/home/cltbld', 04:27:03 INFO - 'LANG': 'en_US.UTF-8', 04:27:03 INFO - 'LANGUAGE': 'en_US:en', 04:27:03 INFO - 'LOGNAME': 'cltbld', 04:27:03 INFO - 'MAIL': '/var/mail/cltbld', 04:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:03 INFO - 'MOZ_NO_REMOTE': '1', 04:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:03 INFO - 'NO_EM_RESTART': '1', 04:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:03 INFO - 'PWD': '/builds/slave/test', 04:27:03 INFO - 'SHELL': '/bin/bash', 04:27:03 INFO - 'SHLVL': '1', 04:27:03 INFO - 'TERM': 'linux', 04:27:03 INFO - 'TMOUT': '86400', 04:27:03 INFO - 'USER': 'cltbld', 04:27:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:03 INFO - '_': '/tools/buildbot/bin/python'} 04:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:03 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 04:27:03 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 04:27:03 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 04:27:03 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 04:27:03 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 04:27:03 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 04:27:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:05 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 04:27:05 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 04:27:05 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 04:27:05 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 04:27:05 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 04:27:05 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 04:27:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:05 INFO - warning: no files found matching '*.txt' 04:27:05 INFO - no previously-included directories found matching 'build' 04:27:05 INFO - no previously-included directories found matching 'dist' 04:27:05 INFO - no previously-included directories found matching '.git*' 04:27:05 INFO - Installing collected packages: jsonschema, functools32 04:27:06 INFO - Running setup.py install for functools32 04:27:06 INFO - warning: no files found matching '*.txt' 04:27:06 INFO - no previously-included directories found matching 'build' 04:27:06 INFO - no previously-included directories found matching 'dist' 04:27:06 INFO - no previously-included directories found matching '.git*' 04:27:06 INFO - Successfully installed jsonschema functools32 04:27:06 INFO - Cleaning up... 04:27:06 INFO - Return code: 0 04:27:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:06 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:06 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:27:06 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 functools32==3.2.3-2 04:27:06 INFO - Using env: {'DISPLAY': ':0', 04:27:06 INFO - 'HOME': '/home/cltbld', 04:27:06 INFO - 'LANG': 'en_US.UTF-8', 04:27:06 INFO - 'LANGUAGE': 'en_US:en', 04:27:06 INFO - 'LOGNAME': 'cltbld', 04:27:06 INFO - 'MAIL': '/var/mail/cltbld', 04:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:06 INFO - 'MOZ_NO_REMOTE': '1', 04:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:06 INFO - 'NO_EM_RESTART': '1', 04:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:06 INFO - 'PWD': '/builds/slave/test', 04:27:06 INFO - 'SHELL': '/bin/bash', 04:27:06 INFO - 'SHLVL': '1', 04:27:06 INFO - 'TERM': 'linux', 04:27:06 INFO - 'TMOUT': '86400', 04:27:06 INFO - 'USER': 'cltbld', 04:27:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:06 INFO - '_': '/tools/buildbot/bin/python'} 04:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:06 INFO - Cleaning up... 04:27:06 INFO - Return code: 0 04:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:06 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:06 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 04:27:06 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 04:27:06 INFO - Using env: {'DISPLAY': ':0', 04:27:06 INFO - 'HOME': '/home/cltbld', 04:27:06 INFO - 'LANG': 'en_US.UTF-8', 04:27:06 INFO - 'LANGUAGE': 'en_US:en', 04:27:06 INFO - 'LOGNAME': 'cltbld', 04:27:06 INFO - 'MAIL': '/var/mail/cltbld', 04:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:06 INFO - 'MOZ_NO_REMOTE': '1', 04:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:06 INFO - 'NO_EM_RESTART': '1', 04:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:06 INFO - 'PWD': '/builds/slave/test', 04:27:06 INFO - 'SHELL': '/bin/bash', 04:27:06 INFO - 'SHLVL': '1', 04:27:06 INFO - 'TERM': 'linux', 04:27:06 INFO - 'TMOUT': '86400', 04:27:06 INFO - 'USER': 'cltbld', 04:27:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:06 INFO - '_': '/tools/buildbot/bin/python'} 04:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:09 INFO - Downloading docopt-0.6.1.tar.gz 04:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:09 INFO - Running setup.py install for blobuploader 04:27:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:09 INFO - Running setup.py install for requests 04:27:09 INFO - Running setup.py install for docopt 04:27:09 INFO - Successfully installed blobuploader requests docopt 04:27:09 INFO - Cleaning up... 04:27:09 INFO - Return code: 0 04:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:09 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:09 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 04:27:09 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 04:27:09 INFO - Using env: {'DISPLAY': ':0', 04:27:09 INFO - 'HOME': '/home/cltbld', 04:27:09 INFO - 'LANG': 'en_US.UTF-8', 04:27:09 INFO - 'LANGUAGE': 'en_US:en', 04:27:09 INFO - 'LOGNAME': 'cltbld', 04:27:09 INFO - 'MAIL': '/var/mail/cltbld', 04:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:09 INFO - 'MOZ_NO_REMOTE': '1', 04:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:09 INFO - 'NO_EM_RESTART': '1', 04:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:09 INFO - 'PWD': '/builds/slave/test', 04:27:09 INFO - 'SHELL': '/bin/bash', 04:27:09 INFO - 'SHLVL': '1', 04:27:09 INFO - 'TERM': 'linux', 04:27:09 INFO - 'TMOUT': '86400', 04:27:09 INFO - 'USER': 'cltbld', 04:27:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:09 INFO - '_': '/tools/buildbot/bin/python'} 04:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:10 INFO - Running setup.py (path:/tmp/pip-a_nGC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:10 INFO - Running setup.py (path:/tmp/pip-5DQBq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:10 INFO - Running setup.py (path:/tmp/pip-C32EsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:10 INFO - Running setup.py (path:/tmp/pip-91Jhe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:10 INFO - Running setup.py (path:/tmp/pip-kqcn1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:10 INFO - Running setup.py (path:/tmp/pip-iQaFO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:10 INFO - Running setup.py (path:/tmp/pip-4PbWyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:10 INFO - Running setup.py (path:/tmp/pip-wQgDK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:10 INFO - Running setup.py (path:/tmp/pip-7uw_cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:10 INFO - Running setup.py (path:/tmp/pip-l9iNLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:10 INFO - Running setup.py (path:/tmp/pip-Mx2hx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:10 INFO - Running setup.py (path:/tmp/pip-YAGTkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:10 INFO - Running setup.py (path:/tmp/pip-1l6Dxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:11 INFO - Running setup.py (path:/tmp/pip-HSRcIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:11 INFO - Running setup.py (path:/tmp/pip-zcGtdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:11 INFO - Running setup.py (path:/tmp/pip-_3v2QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:11 INFO - Running setup.py (path:/tmp/pip-VfO1jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:11 INFO - Running setup.py install for manifestparser 04:27:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:11 INFO - Running setup.py install for mozcrash 04:27:11 INFO - Running setup.py install for mozdebug 04:27:11 INFO - Running setup.py install for mozdevice 04:27:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:11 INFO - Running setup.py install for mozfile 04:27:11 INFO - Running setup.py install for mozhttpd 04:27:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:11 INFO - Running setup.py install for mozinfo 04:27:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for mozInstall 04:27:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for mozleak 04:27:12 INFO - Running setup.py install for mozlog 04:27:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for moznetwork 04:27:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for mozprocess 04:27:12 INFO - Running setup.py install for mozprofile 04:27:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for mozrunner 04:27:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:12 INFO - Running setup.py install for mozscreenshot 04:27:12 INFO - Running setup.py install for moztest 04:27:12 INFO - Running setup.py install for mozversion 04:27:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:13 INFO - Cleaning up... 04:27:13 INFO - Return code: 0 04:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:13 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:13 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 04:27:13 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 04:27:13 INFO - Using env: {'DISPLAY': ':0', 04:27:13 INFO - 'HOME': '/home/cltbld', 04:27:13 INFO - 'LANG': 'en_US.UTF-8', 04:27:13 INFO - 'LANGUAGE': 'en_US:en', 04:27:13 INFO - 'LOGNAME': 'cltbld', 04:27:13 INFO - 'MAIL': '/var/mail/cltbld', 04:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:13 INFO - 'MOZ_NO_REMOTE': '1', 04:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:13 INFO - 'NO_EM_RESTART': '1', 04:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:13 INFO - 'PWD': '/builds/slave/test', 04:27:13 INFO - 'SHELL': '/bin/bash', 04:27:13 INFO - 'SHLVL': '1', 04:27:13 INFO - 'TERM': 'linux', 04:27:13 INFO - 'TMOUT': '86400', 04:27:13 INFO - 'USER': 'cltbld', 04:27:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:13 INFO - '_': '/tools/buildbot/bin/python'} 04:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:13 INFO - Running setup.py (path:/tmp/pip-jdBMC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:13 INFO - Running setup.py (path:/tmp/pip-ZwEPgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:13 INFO - Running setup.py (path:/tmp/pip-jxRXLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:13 INFO - Running setup.py (path:/tmp/pip-thvd45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:13 INFO - Running setup.py (path:/tmp/pip-rxVZx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:13 INFO - Running setup.py (path:/tmp/pip-kN6nxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:13 INFO - Running setup.py (path:/tmp/pip-NsAOQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:13 INFO - Running setup.py (path:/tmp/pip-tLQLkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:13 INFO - Running setup.py (path:/tmp/pip-hyl2tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:13 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)) 04:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:14 INFO - Running setup.py (path:/tmp/pip-YzUFmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:14 INFO - Running setup.py (path:/tmp/pip-y2Esto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:14 INFO - Running setup.py (path:/tmp/pip-JessGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:14 INFO - Running setup.py (path:/tmp/pip-KHTzuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:14 INFO - Running setup.py (path:/tmp/pip-zZtLUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:14 INFO - Running setup.py (path:/tmp/pip-5dwWK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:14 INFO - Running setup.py (path:/tmp/pip-nXOqrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:14 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)) 04:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:14 INFO - Running setup.py (path:/tmp/pip-Bd7bbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:14 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)) 04:27:14 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)) 04:27:14 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)) 04:27:14 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)) 04:27:14 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)) 04:27:14 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)) 04:27:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:14 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 04:27:14 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 04:27:14 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 04:27:14 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 04:27:14 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 04:27:14 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 04:27:16 INFO - Downloading blessings-1.6.tar.gz 04:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:16 INFO - Installing collected packages: blessings 04:27:16 INFO - Running setup.py install for blessings 04:27:16 INFO - Successfully installed blessings 04:27:16 INFO - Cleaning up... 04:27:16 INFO - Return code: 0 04:27:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:16 INFO - Reading from file tmpfile_stdout 04:27:16 INFO - Current package versions: 04:27:16 INFO - argparse == 1.2.1 04:27:16 INFO - blessings == 1.6 04:27:16 INFO - blobuploader == 1.2.4 04:27:16 INFO - docopt == 0.6.1 04:27:16 INFO - functools32 == 3.2.3-2 04:27:16 INFO - jsonschema == 2.5.1 04:27:16 INFO - manifestparser == 1.1 04:27:16 INFO - mozInstall == 1.12 04:27:16 INFO - mozcrash == 0.17 04:27:16 INFO - mozdebug == 0.1 04:27:16 INFO - mozdevice == 0.48 04:27:16 INFO - mozfile == 1.2 04:27:16 INFO - mozhttpd == 0.7 04:27:16 INFO - mozinfo == 0.9 04:27:16 INFO - mozleak == 0.1 04:27:16 INFO - mozlog == 3.3 04:27:16 INFO - moznetwork == 0.27 04:27:16 INFO - mozprocess == 0.23 04:27:16 INFO - mozprofile == 0.28 04:27:16 INFO - mozrunner == 6.12 04:27:16 INFO - mozscreenshot == 0.1 04:27:16 INFO - mozsystemmonitor == 0.3 04:27:16 INFO - moztest == 0.7 04:27:16 INFO - mozversion == 1.4 04:27:16 INFO - psutil == 3.1.1 04:27:16 INFO - requests == 1.2.3 04:27:16 INFO - wsgiref == 0.1.2 04:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:16 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 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27:16 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 04:27:16 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 04:27:16 INFO - Using env: {'DISPLAY': ':0', 04:27:16 INFO - 'HOME': '/home/cltbld', 04:27:16 INFO - 'LANG': 'en_US.UTF-8', 04:27:16 INFO - 'LANGUAGE': 'en_US:en', 04:27:16 INFO - 'LOGNAME': 'cltbld', 04:27:16 INFO - 'MAIL': '/var/mail/cltbld', 04:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:16 INFO - 'MOZ_NO_REMOTE': '1', 04:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:16 INFO - 'NO_EM_RESTART': '1', 04:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:16 INFO - 'PWD': '/builds/slave/test', 04:27:16 INFO - 'SHELL': '/bin/bash', 04:27:16 INFO - 'SHLVL': '1', 04:27:16 INFO - 'TERM': 'linux', 04:27:16 INFO - 'TMOUT': '86400', 04:27:16 INFO - 'USER': 'cltbld', 04:27:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:16 INFO - '_': '/tools/buildbot/bin/python'} 04:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 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)) 04:27:17 INFO - Cleaning up... 04:27:17 INFO - Return code: 0 04:27:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d478e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, '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': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', '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 04:27: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', 'jsonschema'] in /builds/slave/test/build 04:27: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 jsonschema 04:27:17 INFO - Using env: {'DISPLAY': ':0', 04:27:17 INFO - 'HOME': '/home/cltbld', 04:27:17 INFO - 'LANG': 'en_US.UTF-8', 04:27:17 INFO - 'LANGUAGE': 'en_US:en', 04:27:17 INFO - 'LOGNAME': 'cltbld', 04:27:17 INFO - 'MAIL': '/var/mail/cltbld', 04:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:17 INFO - 'MOZ_NO_REMOTE': '1', 04:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:17 INFO - 'NO_EM_RESTART': '1', 04:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:17 INFO - 'PWD': '/builds/slave/test', 04:27:17 INFO - 'SHELL': '/bin/bash', 04:27:17 INFO - 'SHLVL': '1', 04:27:17 INFO - 'TERM': 'linux', 04:27:17 INFO - 'TMOUT': '86400', 04:27:17 INFO - 'USER': 'cltbld', 04:27:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:17 INFO - '_': '/tools/buildbot/bin/python'} 04:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:17 INFO - Cleaning up... 04:27:17 INFO - Return code: 0 04:27:17 INFO - Running post-action listener: _resource_record_post_action 04:27:17 INFO - Running post-action listener: _start_resource_monitoring 04:27:17 INFO - Starting resource monitoring. 04:27:17 INFO - [mozharness: 2016-08-30 11:27:17.431263Z] Finished create-virtualenv step (success) 04:27:17 INFO - [mozharness: 2016-08-30 11:27:17.431836Z] Running install step. 04:27:17 INFO - Running pre-action listener: _resource_record_pre_action 04:27:17 INFO - Running main action method: install 04:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:17 INFO - Reading from file tmpfile_stdout 04:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:17 INFO - Reading from file tmpfile_stdout 04:27:17 INFO - Output received: 04:27:17 INFO - Usage: mozinstall [options] installer 04:27:17 INFO - Options: 04:27:17 INFO - -h, --help show this help message and exit 04:27:17 INFO - -d DEST, --destination=DEST 04:27:17 INFO - Directory to install application into. [default: 04:27:17 INFO - "/builds/slave/test"] 04:27:17 INFO - --app=APP Application being installed. [default: firefox] 04:27:17 INFO - mkdir: /builds/slave/test/build/application 04:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:27:33 INFO - Reading from file tmpfile_stdout 04:27:33 INFO - Output received: 04:27:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:33 INFO - Running post-action listener: _resource_record_post_action 04:27:33 INFO - [mozharness: 2016-08-30 11:27:33.843958Z] Finished install step (success) 04:27:33 INFO - [mozharness: 2016-08-30 11:27:33.844241Z] Running run-tests step. 04:27:33 INFO - Running pre-action listener: _resource_record_pre_action 04:27:33 INFO - Running main action method: run_tests 04:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:33 INFO - Python 2.7.3 04:27:33 INFO - Return code: 0 04:27:33 INFO - grabbing minidump binary from tooltool 04:27:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:33 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 0x14df090>, '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 0x14e29b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:33 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 04:27:33 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 04:27:33 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 04:27:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:33 INFO - Return code: 0 04:27:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:33 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/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:27:33 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/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 04:27:33 INFO - Using env: {'DISPLAY': ':0', 04:27:33 INFO - 'HOME': '/home/cltbld', 04:27:33 INFO - 'LANG': 'en_US.UTF-8', 04:27:33 INFO - 'LANGUAGE': 'en_US:en', 04:27:33 INFO - 'LOGNAME': 'cltbld', 04:27:33 INFO - 'MAIL': '/var/mail/cltbld', 04:27:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:33 INFO - 'MOZ_NO_REMOTE': '1', 04:27:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:33 INFO - 'NO_EM_RESTART': '1', 04:27:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:33 INFO - 'PWD': '/builds/slave/test', 04:27:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:33 INFO - 'SHELL': '/bin/bash', 04:27:33 INFO - 'SHLVL': '1', 04:27:33 INFO - 'TERM': 'linux', 04:27:33 INFO - 'TMOUT': '86400', 04:27:33 INFO - 'USER': 'cltbld', 04:27:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708', 04:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:33 INFO - '_': '/tools/buildbot/bin/python'} 04:27:33 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/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:27:34 INFO - mozversion application_buildid: 20160830034521 04:27:34 INFO - mozversion application_changeset: 444b23193a56cec7f47763e4afb3d4881e40632e 04:27:34 INFO - mozversion application_display_name: Nightly 04:27:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:34 INFO - mozversion application_name: Firefox 04:27:34 INFO - mozversion application_remotingname: firefox 04:27:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:27:34 INFO - mozversion application_vendor: Mozilla 04:27:34 INFO - mozversion application_version: 51.0a1 04:27:34 INFO - mozversion platform_buildid: 20160830034521 04:27:34 INFO - mozversion platform_changeset: 444b23193a56cec7f47763e4afb3d4881e40632e 04:27:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:27:34 INFO - mozversion platform_version: 51.0a1 04:27:34 INFO - using testdate: 1472556454 04:27:34 INFO - actual date: 1472556454 04:27:34 INFO - starting webserver on 'localhost:34458' 04:27:34 INFO - SUITE-START | Running 2 tests 04:27:34 INFO - TEST-START | dromaeo_css 04:27:34 INFO - operating with platform_type : linux_ 04:27:34 INFO - Initialising browser for dromaeo_css test... 04:27:34 INFO - TEST-INFO | started process 10121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5Ykey/profile http://localhost:34458/getInfo.html) 04:27:38 INFO - PROCESS | 10121 | __metrics Screen width/height:1600/1200 04:27:38 INFO - PROCESS | 10121 | colorDepth:24 04:27:38 INFO - PROCESS | 10121 | Browser inner width/height: 1024/697 04:27:38 INFO - PROCESS | 10121 | __metrics 04:27:39 INFO - PROCESS | 10121 | 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" 04:27:39 INFO - PROCESS | 10121 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:27:39 INFO - PROCESS | 10121 | console.error: PushService: 04:27:39 INFO - PROCESS | 10121 | stateChangeProcessEnqueue: Error transitioning state 04:27:39 INFO - PROCESS | 10121 | UnknownError 04:27:40 INFO - TEST-INFO | 10121: exit 0 04:27:40 INFO - Browser initialized. 04:27:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:40 INFO - TEST-INFO | started process 10201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5Ykey/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:52 INFO - PROCESS | 10201 | RSS: Main: 181714944 04:27:52 INFO - PROCESS | 10201 | 04:28:43 INFO - PROCESS | 10201 | 1472556523755 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] 04:30:56 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34458/tests/dromaeo/cssquery-ext.html) 04:30:58 INFO - PROCESS | 10201 | RSS: Main: 289177600 04:30:58 INFO - PROCESS | 10201 | 04:34:00 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-ext.html (next: http://localhost:34458/tests/dromaeo/cssquery-jquery.html) 04:34:01 INFO - PROCESS | 10201 | RSS: Main: 274780160 04:34:01 INFO - PROCESS | 10201 | 04:37:03 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34458/tests/dromaeo/cssquery-mootools.html) 04:37:04 INFO - PROCESS | 10201 | RSS: Main: 237563904 04:37:04 INFO - PROCESS | 10201 | 04:40:06 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34458/tests/dromaeo/cssquery-prototype.html) 04:40:07 INFO - PROCESS | 10201 | RSS: Main: 218931200 04:40:07 INFO - PROCESS | 10201 | 04:43:10 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34458/tests/dromaeo/cssquery-yui.html) 04:43:10 INFO - PROCESS | 10201 | RSS: Main: 218320896 04:43:10 INFO - PROCESS | 10201 | 04:46:13 INFO - PROCESS | 10201 | Cycle 1(1): loaded http://localhost:34458/tests/dromaeo/cssquery-yui.html (next: http://localhost:34458/tests/dromaeo/cssquery-dojo.html) 04:46:14 INFO - PROCESS | 10201 | RSS: Main: 309985280 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | __start_tp_report 04:46:14 INFO - PROCESS | 10201 | _x_x_mozilla_page_load 04:46:14 INFO - PROCESS | 10201 | _x_x_mozilla_page_load_details 04:46:14 INFO - PROCESS | 10201 | |i|pagename|runs| 04:46:14 INFO - PROCESS | 10201 | |0;dojo.html;2548.681414823147;2582.4447743735095;2588.7540683635048;2609.269404566721;2639.419327747896;4593.173228818811;4623.2140536108855;4716.599089077424;4745.122152401804;4784.712917224964;4605.286180641998;4756.120117778205;4773.665843390964;4775.594074503671;4776.235802271637;4272.615464608185;4333.934990975138;4351.73889566627;4400.339949007658;4431.047324825162;4361.60745532902;4401.383806267125;4403.339499075132;4404.647628189737;4422.7788610569505;4364.912701745963;4398.450193725785;4408.823647054114;4521.751303678297;4524.97737511312;4385.780710964471;4407.250767369523;4440.755758433284;4466.955330446686;4468.82124715011;4203.579642035803;4242.66058715302;4299.398084268205;4362.978185109086;4372.147431250907;4609.354690343354;4624.861254162381;4636.072785442925;4638.930416043762;4700;4992.475790042066;5023.522765337287;5030.924536131961;5042.067217564762;5044.47033061527;4928.162212423897;4981.128302547076;5072.873178170538;5080.212567052113;5104.770285337168;4738.289256611536;4740.956989462313;4747.12178247022;4751.429828420612;4758.238681810963;5171.81898633546;5202.661826981234;5206.245094461282;5209.6353255272525;5271.578273738091;4852.17513022787;4911.0423467424225;4942.728149951715;4948.282499037691;4995.275685025651;5033.119204139334;5065.949340506548;5068.163752980717;5069.670471419346;5117.820876269388;4996.475370086161;5008.824691135793;5011.599072074226;5017.096922553976;5026.371703537058;4856.344393506832;4903.436104847917;4905.435874874363;4958.7024778513405;4981.90036199274;4171.812268447927;4176.749395036247;4192.91614167721;4248.214080395137;4267.338562522814;3677.062349100962;3678.889633311005;3683.7421380503642;3726.8136593170234;3735.589085200626;4405.559444055569;4410.80151393188;4411.602955733999;4417.2269852775635;4466.173757854807;4905.8037678492465;4983.327250821165;5006.824761133343;5041.890784027508;5127.897442051213;4377.606015458624;4380.737155770664;4433.7561434121435;4444.822207111744;4447.266201076851;4423.51341352451;4451.10977804434;4466.151431228056;4468.754218518013;4522.547745225451;4618.630509559294;4704.50602686713;4727.787249573708;4764.2615394613895;4767.856964291077;5057.140286151437;5090.41460232078;5134.255532947627;5147.459516750687;5155.200943853709;4787.976060119677;4788.760561971957;4793.113274044313;4795.64032697556;4860.246661767432;4853.320535125014;4919.532644398776;4997.075541024922;5012.448630650699;5073.44192138857;4998.175301075282;5033.672811267256;5040.697558146377;5106.617003724809;5114.181730923183;4898.53463920927;4900.975495122501;4901.926471103007;4920.6555541111775;4963.280324352876;4791.880202994814;4896.338994235733;4900.362952816111;4923.901521969612;4972.477889821516;4853.466118726867;4927.137750893651;4931.211006238985;4970.204767237225;4971.428285747185;5011;5033.446320904624;5037.471065538212;5045.167547354646;5105.566026887756;4697.788599512962;4736.621070314435;4744.074905393415;4881.536254055859;4898.2652602109965 04:46:14 INFO - PROCESS | 10201 | |1;ext.html;551.4017291239005;553.919681646161;565.3159676791082;565.7878295639135;598.7664810723816;26838.329041773966;36824.44763328549;37689.05777355567;37843.24313513728;41618;38786.418203726964;39081.218375632474;39167.60832391682;39190.60809391905;39196.21607567847;6998.475114366417;7579.81050473737;7774.028246469192;7774.611269436534;7775.922240777605;7040.225575186725;7262.891056634155;7263.854722905538;9727.951360243223;10003.649872254473;10059.69820905374;10157.644482443116;10161.18710503158;10166.440845753481;10175.13511351536;9745.415275083482;9822.066903644143;9827.312088153833;9831.459269740162;9833.704988850346;9781.16860066888;9842.163416109639;9861.50692465381;9865.654702085465;9873.259505537042;37155.07112322187;37355;37413.43879841804;37646.62353376486;37695.62304376976;2411.2284069097896;2588.9482210355877;2604.1927002629054;2623.6606123198894;2648.589468632346;27796.30509237285;27813.582796258073;28437.431251374855;28467.57298640522;28682.569761453597;3233.4503134467195;3342.4652055670977;3374.3420033093557;3376.1728376547658;3389.9661003389897;224130;226198.86900565555;227180;227615;228411;45668.77165614151;45775.08449830985;45778.31332530015;45801.770991145495;45879.77060114678;31362;32006.679933200834;32053;53612.73193634007;53783.19325210125;12657;12851.100422970489;12865;12873.098883078095;12875.291858947849;9339.906600933904;9352.859707104399;9365.578548965314;9366.578503967337;9372.718818435458;15396.307166177548;17634.294628214728;18007.18967646459;18188.727169092475;18286.268549258148;6510.446612037935;6742.089817874524;6752.696128674222;6758;6807.285235050248;709.1844378964232;734.930181632744;803.3854101612271;843.1989609870648;869.1395518436702;26819.195424137306;26866.32834179161;26987.730122698915;26997.325066873484;27462.5880611791;897.6858099665066;901.9774505637412;904.412132114131;953.7377221264069;987.0376383026635;14272.21502817355;14438.494652687106;14620.488282910259;14722.190279534514;14846.851531484763;365473;371066;372068;372095;372172;47340.5265947343;47621;47630;47659.76170119127;47667.284990725166;1009.4700282351678;1096.9177311701494;1099.7305660113163;1111.7498562823623;1116.776644671069;26829.329266767705;28017.299567510974;28804.70054347487;28955;29208;40149.799251003555;40586;40604.79697601493;40606.18787624172;40618;288853;289613;290284;290473;514089;34308;34557;34611.40414468874;34836.82581587076;35230.29539409146;39979.60020399759;40143;40400.39399408952;40654.186916260915;40917.59082409138;33489;33650.49524257187;34043.82978085094;34094.48858267078;34116.658833412344;31763.523547147273;31957.840210798797;31966.68033319637;32830.507542387364;32877.83561082275;33631.66368336383;34325;34707.82646086753;34876.65123348734;34940.65059349374;30314.545281821232;32279.677203227668;32323.676763232066;32808.67191328056;32875.17812054718;24733.628995564723;24765.009399624534;24807.25578232656;25123.120690775737;25230.116945906804 04:46:14 INFO - PROCESS | 10201 | |2;jquery.html;333.33167000164667;348.1539858144708;350.8035500119933;351.1834983662984;367.37729548415444;12226.938865305672;15534.766978495318;15610.453634122821;16764.74852877205;16911;14904.701905961874;15150.24248787559;15405.845941540581;15909.681806363866;16028.75956860645;4556.954430455703;4702.036082603076;4707.152712511764;5012.172991456424;5237.528622423981;3369.4103531881824;5320.973395133019;5350.35795704514;5354.437784032679;5356.651817631861;5569.721513924287;5825.155352473888;5844.853878653025;5932.406759324054;5944.673042982634;5357.544608708265;5421;5707.543396528309;5925.437083477084;5948.791792287249;5240.79036838526;5256.421793602739;5256.526912577886;5256.553192978601;5256.894862102775;11458.197926145172;11508.367039812807;11515.42422878861;11656.067514598897;11758.823617645741;1607.9678406431922;1648.0523698873076;1661.1943207544332;1768.0629266488652;1950.1516840174427;8487.787805304855;8513.404061715682;8652.826943461096;8965.910340896638;9100.590473428712;1641.9261133249033;1685.3764107280385;1692.7968643762704;1757.6748301564123;1768.5578605348662;64444;67316.9999999995;68133;68486.65756671184;69555.30444695539;9260.953695231616;9270.768230794283;9301.581428835718;9505.952470237604;9568.856467152998;12392.132550721362;12422.37888105591;12429.75140497185;12462.003039756797;12463.813042804366;6656.434203092695;6862.725490980305;7021.929780702229;7026.648667566601;7033.542819716702;6480.125183100316;6528.934710652928;6563.278039415661;6688.86622267552;6713.597184168965;4127.195196936568;4139.317012692933;4143.91712165755;4241.512226093977;4244.38456423823;1718.6219031812982;1723.4743403261875;1748.7901451825862;1760.6390689908537;1771.6191018930733;764.399946042354;764.4343186042399;770.7764748223065;776.8407476467311;790.8260182759784;15246.009009414352;15353.923230384;15577.844221557865;15965.521034368987;17082.914585427243;745.3552676934521;764.1785081037907;789.7788619186637;795.2882170457408;847.4957400346784;9088.772780680536;9109.089091090838;9136.314776391797;9201.769955751026;9380.155785979294;272860;275689;276798;368341;368944;79093.60453197813;79124.54882669845;80189;80705.59647201726;82210;867.8134201146784;874.4578361415836;915.7985243246475;919.8114386550741;921.3642586615214;15525.456609019082;15655.608609784846;16222.67554648924;16331.918340408221;16610.66778664444;36431.45352819763;37935;37979.62020379761;38008.80995595004;38225.80887095658;45255.321170181815;47636.761816190694;50905.74547127241;52611;54630.726846367106;4422.778861056999;6792.811258029727;7192.928070719226;7286.854262914818;7686;9571.569279382584;11812.291262524275;11913.404329783649;12103.697407564881;12244.938775306422;9969.750756230862;10199.898001020192;10216.59133634676;10594.735131621772;10780.946095269474;10308.433036182782;10362.481875906024;10388.792224155324;10672.30630009047;10796.190285728444;10339.63811266602;10447.268691191848;10532.842007369742;10585.100266477128;10679.19906007037;7282.563046217244;7416.184219735716;7483.850322993619;7497.9250207497225;7672.80817979555;9274;9791.51042447889;9953.751156221153;10135.797284054424;10509.159267258754 04:46:14 INFO - PROCESS | 10201 | |3;mootools.html;1208.3958020989505;1311.1215485624627;1357.1246545977845;1401.1593044173496;1651.983480165198;7116.430685545157;7386.630668466575;7458.254174582539;7659.693612255517;7666.808329791744;7528.84942301155;7619.047619047619;7621.618919054039;7624.961875190616;7628.694852205919;2195.999999999996;2216.2021672198;2217.700610417589;2220.2340192633596;2222.355516900097;2156.7843215678463;2193.5393567350798;2208.4920468292303;2209.5801797658473;2209.657503087024;2162.9242976495825;2170.793774591419;2172.435166856621;2175.0973346061446;2223.2329846203115;2144.774798646143;2150.0432307623114;2151.0427859602405;2151.08578853988;2152.35429371188;2080.9479763006048;2124.4795025218764;2125.107454868959;2127.0322003488377;2128.5423633918626;7397;7506.249375062504;7567.621618919087;7581.203973582805;7581.658825352873;4342.196693611692;4537.591616754475;4556.066006468699;4556.270996640555;4562.315652652095;2782.401783616512;2874.7125287471295;2931;2933.838638874861;2935.6368123660445;920.5581320965907;926.6895589977365;931.1759093202497;971.7327734872896;982.1062832822169;10145.137663298628;10204.948975255076;10227.437490937995;10228.488575571266;10231.079202871777;3822;3949.921001579952;3972.1658451724884;4054.39184122384;4219.7046206765235;7932.881006784903;8080.030396352476;8100.878486822702;8102.878456823152;8120.106788253287;4342.804573794124;4348.630366418826;4350.151720414552;4351.260285751367;4352.347147927773;3533.205028868484;3823.2162406706557;3991.501062367204;4035.838566457309;4036.939445908255;3289.1283809790425;3305.5455599536126;3389.457686770105;3423.9144021399666;3432.8111953842777;1032.963846265377;1058.5448257249302;1071.346478648024;1076.5424694504804;1077.9946100269606;594.7829042399493;628.446966669328;646.6669665122465;666.8832954232989;668.6155460610071;4767.76161191939;4768.523147685273;4791.425028996473;4801.591864691541;4835.927461088087;392.7937832637888;393.6673510883299;396.843246917466;396.9144390093093;401.141557067875;3237.093613788143;3237.7409807215836;3281.6390197078304;3295.2915123248135;3401.9489707654407;9081.81836363269;9311.301652376098;9418.529073546433;9428.198603118675;9445.622175112918;9354.90645093554;9362.719118426457;9363.110504502061;9370.718878433658;9379.108984646447;7184.461165412615;7209.963950180216;7252.601106939169;7254.637268136572;7260.2013778484325;4769.284607308793;4840.927386089141;4891.388576427947;4912.901741965212;5045.041442125985;8269.669213231404;8537.829243414973;8559.914400855912;8572.742817715478;8578.571071446528;8603.870941936002;8680.131986801269;8774.034856165945;8826.42628229163;8923.73228803137;5497.560195184456;6019.789307374221;6073.119397687399;6077.787277445268;6078.54410919174;6334.778282760081;6419.069234960998;6806.7957961261245;6882.7591034313555;7059.470539709439;5942.881142377215;6093.542984276109;6129.325774164749;6135.754569817157;6226.25284965807;5810.912836307374;5918.3489816121055;6000.5799594028;6016.488598469179;6098;5701.201831743476;5704.771809127588;5723.5707321950185;5749.798757043483;5762.971185144047;4273.850415235452;4303.956960430356;4379.868603941887;4434.17967675981;4492.775361231991;4298.602954039887;4335.371371151103;4344.934825977676;4479.148961697267;4509.661775366926 04:46:14 INFO - PROCESS | 10201 | |4;prototype.html;267.04930447606523;270.8496784284722;273.34806486529635;274.15286763899553;276.3202521796381;4318.265894797884;4603.194440972825;4833.661643684939;4873.95126048739;4893.926591101136;4702;4749.002709431015;4764.833230836913;4803.783829727662;4818.566329030386;3525.5416795816636;3592.2276710507235;3717.5910649828634;3755.1738617504175;3764;3696.870609528667;3704.907377315575;3705.5368078990127;3711.1464363196483;3725.7205709571754;3675.4854320395166;3680.11677197472;3692.187718701895;3696.297703436352;3698.907527311825;3682.287736202665;3684.926301473969;3731.8507259709577;3732.9920921351354;3740.597276021492;3181.984090079535;3207.4226639204935;3213.373392188524;3232.5797646306064;3240;4595.195840727893;4604.631629469634;4610.423697037871;4611.30830375443;4638.8608341749805;3983.9203215935518;4195.307774217251;4222.134462435224;4226.85206017791;4231.449911511515;4925.310456536052;4934.841701311164;5000.849974500735;5014.5737612303;5018;3446.5174875517446;3459.394605943975;3466.861325546975;3476.3568739783223;3500.547272881751;4980.402351717781;5036.219385995177;5275.709835959021;5279.729716222023;5281.735913204325;3486.930261394758;3504.9474257886154;3522.383582872987;3523.700485458765;3533.5229743984232;3565.625609311037;3568.9643103568633;3585.4442561403025;3589.282143571244;3592.892213233607;4147.605977432139;4173.6661067114555;4175.645070169009;4184.205001049791;4187.581241875849;4824.975875120672;4937.87655308613;4960.206366981266;4974.27872958419;5092.541671249532;1207.2877002568528;1216.1365430544236;1219.6645922371242;1225.2403509823966;1225.8651548329676;758.135725273189;779.205210685098;781.0978320040363;792.6235038356734;796.3748457460981;4044.463104020512;4052.8378864845076;4065.918681626351;4068;4070.776107314126;4553.795079221443;4589.728084598145;4601.240795268744;4613.500612301015;4616.6537509686905;4021.617946295097;4054.290499162694;4056.6551843093075;4056.6957478189256;4075.449814275094;2278.8404811663354;2404.843685160459;2414.6740190074465;2426.5874801283826;2450.546648869965;4297;4301.0537681709975;4311.956880431218;4324.783760811947;4330.891727706769;4600.493945665974;4619.214733495314;4644.373009643722;4663.510331415153;4677.812887484531;4094.8566800161852;4244.575542445731;4311.741295522279;4320.8487702929615;4322.827086916551;4546.272596384562;4561.270196768501;4564.42944631921;4570.8857278566975;4586.88532786683;4455.309427038814;4503.909921801611;4539.843574302312;4575.192798844371;4576.88557786058;4315.633171180485;4317.309230523101;4362.694611377173;4511.571400716926;4584.312353146921;3547.911302217465;3550.573931128281;3551.75137740366;3558.8646811912645;3562.8040457775073;5156.587473002076;5170.871622668382;5176.792928282826;5181.35233095863;5181.663191892515;4753;5026.723530205873;5047.772850221822;5048.192289233705;5059.494050594911;5020.723860187724;5038.596912247085;5054.620903432184;5063.392392912727;5067.974660126676;4930.6795058321095;4977.253411988231;4986.526280003394;4987.900241995212;5000;4950.45544990058;5102.897942041064;5103.209002604603;5104.9489505104475;5153.793848246178;4915.852524424273;4919.778609962632;4932.42162507994;4945.455999839943;4949.975250123726 04:46:14 INFO - PROCESS | 10201 | |5;yui.html;553.5543887170826;573.5812856614672;585.0288521055049;606.6814922165862;664.8238216872529;11349.262297950638;12401.689957751061;12442.191257568264;12498.625041248755;12851.935740321285;13900.165990040605;14600.269986500685;14651.560453186396;14685;14723.411063557473;727.8507905879309;746.9813254668622;748.809053691308;749.7413392379648;750.6284389227313;595.6068994463654;731.3381389842175;755.5126943121684;760.0347558600574;764.2624867003341;796.3788245168778;796.557910359753;796.7848680856165;801.7434420985287;802.4623502253474;794.9483283586549;794.9920500795005;795.9442839001272;796.1401686178942;796.2873228460553;473.94312682477977;478.83240865697076;481.9710817350935;565.9547236221092;577.3822010448821;12784.232946023269;12791.74416511674;12808.10343275971;12825.422855971503;12852.357382130856;11910.523579056828;12309.507619695201;12444.128910976235;12817.03872209588;12996.41516131767;9684.661036863747;9840.65557705484;11377.772444551145;11413.942930285379;11488.195826292163;4141.192467468844;4184;4196.874093777192;4300.849470268526;4406.05269866977;50649.49350506521;52178.73910630422;52331.73834130843;58975.82048359052;59647;9779.951100244596;10049.497525123714;10059.144972677259;10130.189584833342;10321.225908056926;18884.90557547231;18919.716204256947;18934.52663683419;18935.905320473586;18953.810461895206;7017.543859649107;7043.049188359506;7045.647717614099;7109.964450177716;7384;3637.797948932998;3750.1749615084636;3761.887143385703;3801.1827457096306;3887.7084218683144;2849.900253491118;3001.6398032235834;3010.909672709822;3013.804102733315;3017.5926249955974;503.47386980605353;505.6788939023746;507.32779067735396;512.7948820471842;516.3210378352529;482.9710217386968;500.8146985615273;532.566172591262;538.2948337677655;542.2950164785763;7793.454458187985;7934.116802011292;7984.560849153236;8001.4398992071165;8149.7147599833725;485.65033176113144;500.8923081537487;504.46022755651103;509.5388673250714;514.8944466384382;3518.736094792901;3820.4269359596283;3854.5952674969285;3856.903577410531;3937.2125574885135;99322;99448.50275748575;99672.50163749135;102267.4886625562;105106.47446762871;85059;85473.14526854776;87363.56318218369;88045;90592.09407905968;43344.78327608342;49449.25826112611;60127.69936150291;60216.698916505135;77564;7999.320057795153;8289.212524810133;8293.170682931659;8540.27407670355;8722.825543489222;32557.837210813796;40815.7959210202;41427.75014372412;45073.54926450693;45683.77158114188;56439;62852.685736571024;64106;64142;66730.66634666796;9554.952225238829;9725.221982241545;9772.56023478931;10156.542955567165;10682.73293167677;11313.321200727984;11829.52681892749;11855.644330670093;13076.673083172996;13100.475980960655;10968.835467467834;11081.168912331768;11272.66182014541;11305.26515776472;11892.881071189524;9842.606295748375;10051.894291628061;10132.746681333025;10364.067233948981;10409.843852342372;9960.900390995997;10229.283950123718;10482.423466709404;10528.526216320131;10782.946085269523;8917.68934124754;9145.222656074307;9441.48071856027;9496;9680.467574283482;9666.95166524163;9723;9738.80522389534;10109.292349535463;10209.438480883622 04:46:14 INFO - PROCESS | 10201 | __end_tp_report 04:46:14 INFO - PROCESS | 10201 | __start_cc_report 04:46:14 INFO - PROCESS | 10201 | _x_x_mozilla_cycle_collect,1093 04:46:14 INFO - PROCESS | 10201 | __end_cc_report 04:46:14 INFO - PROCESS | 10201 | __startTimestamp1472557574173__endTimestamp 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | ------- Summary: start ------- 04:46:14 INFO - PROCESS | 10201 | Number of tests: 6 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#0] dojo.html Cycles:165 Average:4667.63 Median:4784.71 stddev:494.13 (10.3%) stddev-sans-first:466.85 04:46:14 INFO - PROCESS | 10201 | Values: 2548.7 2582.4 2588.8 2609.3 2639.4 4593.2 4623.2 4716.6 4745.1 4784.7 4605.3 4756.1 4773.7 4775.6 4776.2 4272.6 4333.9 4351.7 4400.3 4431.0 4361.6 4401.4 4403.3 4404.6 4422.8 4364.9 4398.5 4408.8 4521.8 4525.0 4385.8 4407.3 4440.8 4467.0 4468.8 4203.6 4242.7 4299.4 4363.0 4372.1 4609.4 4624.9 4636.1 4638.9 4700.0 4992.5 5023.5 5030.9 5042.1 5044.5 4928.2 4981.1 5072.9 5080.2 5104.8 4738.3 4741.0 4747.1 4751.4 4758.2 5171.8 5202.7 5206.2 5209.6 5271.6 4852.2 4911.0 4942.7 4948.3 4995.3 5033.1 5065.9 5068.2 5069.7 5117.8 4996.5 5008.8 5011.6 5017.1 5026.4 4856.3 4903.4 4905.4 4958.7 4981.9 4171.8 4176.7 4192.9 4248.2 4267.3 3677.1 3678.9 3683.7 3726.8 3735.6 4405.6 4410.8 4411.6 4417.2 4466.2 4905.8 4983.3 5006.8 5041.9 5127.9 4377.6 4380.7 4433.8 4444.8 4447.3 4423.5 4451.1 4466.2 4468.8 4522.5 4618.6 4704.5 4727.8 4764.3 4767.9 5057.1 5090.4 5134.3 5147.5 5155.2 4788.0 4788.8 4793.1 4795.6 4860.2 4853.3 4919.5 4997.1 5012.4 5073.4 4998.2 5033.7 5040.7 5106.6 5114.2 4898.5 4901.0 4901.9 4920.7 4963.3 4791.9 4896.3 4900.4 4923.9 4972.5 4853.5 4927.1 4931.2 4970.2 4971.4 5011.0 5033.4 5037.5 5045.2 5105.6 4697.8 4736.6 4744.1 4881.5 4898.3 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#1] ext.html Cycles:180 Average:45873.99 Median:34856.74 stddev:84647.09 (242.8%) stddev-sans-first:84816.15 04:46:14 INFO - PROCESS | 10201 | Values: 551.4 553.9 565.3 565.8 598.8 26838.3 36824.4 37689.1 37843.2 41618.0 38786.4 39081.2 39167.6 39190.6 39196.2 6998.5 7579.8 7774.0 7774.6 7775.9 7040.2 7262.9 7263.9 9728.0 10003.6 10059.7 10157.6 10161.2 10166.4 10175.1 9745.4 9822.1 9827.3 9831.5 9833.7 9781.2 9842.2 9861.5 9865.7 9873.3 37155.1 37355.0 37413.4 37646.6 37695.6 2411.2 2588.9 2604.2 2623.7 2648.6 27796.3 27813.6 28437.4 28467.6 28682.6 3233.5 3342.5 3374.3 3376.2 3390.0 224130.0 226198.9 227180.0 227615.0 228411.0 45668.8 45775.1 45778.3 45801.8 45879.8 31362.0 32006.7 32053.0 53612.7 53783.2 12657.0 12851.1 12865.0 12873.1 12875.3 9339.9 9352.9 9365.6 9366.6 9372.7 15396.3 17634.3 18007.2 18188.7 18286.3 6510.4 6742.1 6752.7 6758.0 6807.3 709.2 734.9 803.4 843.2 869.1 26819.2 26866.3 26987.7 26997.3 27462.6 897.7 902.0 904.4 953.7 987.0 14272.2 14438.5 14620.5 14722.2 14846.9 365473.0 371066.0 372068.0 372095.0 372172.0 47340.5 47621.0 47630.0 47659.8 47667.3 1009.5 1096.9 1099.7 1111.7 1116.8 26829.3 28017.3 28804.7 28955.0 29208.0 40149.8 40586.0 40604.8 40606.2 40618.0 288853.0 289613.0 290284.0 290473.0 514089.0 34308.0 34557.0 34611.4 34836.8 35230.3 39979.6 40143.0 40400.4 40654.2 40917.6 33489.0 33650.5 34043.8 34094.5 34116.7 31763.5 31957.8 31966.7 32830.5 32877.8 33631.7 34325.0 34707.8 34876.7 34940.7 30314.5 32279.7 32323.7 32808.7 32875.2 24733.6 24765.0 24807.3 25123.1 25230.1 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#2] jquery.html Cycles:180 Average:21712.28 Median:26171.96 stddev:52911.13 (202.2%) stddev-sans-first:53035.21 04:46:14 INFO - PROCESS | 10201 | Values: 333.3 348.2 350.8 351.2 367.4 12226.9 15534.8 15610.5 16764.7 16911.0 14904.7 15150.2 15405.8 15909.7 16028.8 4557.0 4702.0 4707.2 5012.2 5237.5 3369.4 5321.0 5350.4 5354.4 5356.7 5569.7 5825.2 5844.9 5932.4 5944.7 5357.5 5421.0 5707.5 5925.4 5948.8 5240.8 5256.4 5256.5 5256.6 5256.9 11458.2 11508.4 11515.4 11656.1 11758.8 1608.0 1648.1 1661.2 1768.1 1950.2 8487.8 8513.4 8652.8 8965.9 9100.6 1641.9 1685.4 1692.8 1757.7 1768.6 64444.0 67317.0 68133.0 68486.7 69555.3 9261.0 9270.8 9301.6 9506.0 9568.9 12392.1 12422.4 12429.8 12462.0 12463.8 6656.4 6862.7 7021.9 7026.6 7033.5 6480.1 6528.9 6563.3 6688.9 6713.6 4127.2 4139.3 4143.9 4241.5 4244.4 1718.6 1723.5 1748.8 1760.6 1771.6 764.4 764.4 770.8 776.8 790.8 15246.0 15353.9 15577.8 15965.5 17082.9 745.4 764.2 789.8 795.3 847.5 9088.8 9109.1 9136.3 9201.8 9380.2 272860.0 275689.0 276798.0 368341.0 368944.0 79093.6 79124.5 80189.0 80705.6 82210.0 867.8 874.5 915.8 919.8 921.4 15525.5 15655.6 16222.7 16331.9 16610.7 36431.5 37935.0 37979.6 38008.8 38225.8 45255.3 47636.8 50905.7 52611.0 54630.7 4422.8 6792.8 7192.9 7286.9 7686.0 9571.6 11812.3 11913.4 12103.7 12244.9 9969.8 10199.9 10216.6 10594.7 10780.9 10308.4 10362.5 10388.8 10672.3 10796.2 10339.6 10447.3 10532.8 10585.1 10679.2 7282.6 7416.2 7483.9 7497.9 7672.8 9274.0 9791.5 9953.8 10135.8 10509.2 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#3] mootools.html Cycles:180 Average:4848.96 Median:4768.14 stddev:2746.13 (57.6%) stddev-sans-first:2740.20 04:46:14 INFO - PROCESS | 10201 | Values: 1208.4 1311.1 1357.1 1401.2 1652.0 7116.4 7386.6 7458.3 7659.7 7666.8 7528.8 7619.0 7621.6 7625.0 7628.7 2196.0 2216.2 2217.7 2220.2 2222.4 2156.8 2193.5 2208.5 2209.6 2209.7 2162.9 2170.8 2172.4 2175.1 2223.2 2144.8 2150.0 2151.0 2151.1 2152.4 2080.9 2124.5 2125.1 2127.0 2128.5 7397.0 7506.2 7567.6 7581.2 7581.7 4342.2 4537.6 4556.1 4556.3 4562.3 2782.4 2874.7 2931.0 2933.8 2935.6 920.6 926.7 931.2 971.7 982.1 10145.1 10204.9 10227.4 10228.5 10231.1 3822.0 3949.9 3972.2 4054.4 4219.7 7932.9 8080.0 8100.9 8102.9 8120.1 4342.8 4348.6 4350.2 4351.3 4352.3 3533.2 3823.2 3991.5 4035.8 4036.9 3289.1 3305.5 3389.5 3423.9 3432.8 1033.0 1058.5 1071.3 1076.5 1078.0 594.8 628.4 646.7 666.9 668.6 4767.8 4768.5 4791.4 4801.6 4835.9 392.8 393.7 396.8 396.9 401.1 3237.1 3237.7 3281.6 3295.3 3401.9 9081.8 9311.3 9418.5 9428.2 9445.6 9354.9 9362.7 9363.1 9370.7 9379.1 7184.5 7210.0 7252.6 7254.6 7260.2 4769.3 4840.9 4891.4 4912.9 5045.0 8269.7 8537.8 8559.9 8572.7 8578.6 8603.9 8680.1 8774.0 8826.4 8923.7 5497.6 6019.8 6073.1 6077.8 6078.5 6334.8 6419.1 6806.8 6882.8 7059.5 5942.9 6093.5 6129.3 6135.8 6226.3 5810.9 5918.3 6000.6 6016.5 6098.0 5701.2 5704.8 5723.6 5749.8 5763.0 4273.9 4304.0 4379.9 4434.2 4492.8 4298.6 4335.4 4344.9 4479.1 4509.7 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#4] prototype.html Cycles:180 Average:3998.89 Median:4323.81 stddev:1176.06 (27.2%) stddev-sans-first:1145.52 04:46:14 INFO - PROCESS | 10201 | Values: 267.0 270.8 273.3 274.2 276.3 4318.3 4603.2 4833.7 4874.0 4893.9 4702.0 4749.0 4764.8 4803.8 4818.6 3525.5 3592.2 3717.6 3755.2 3764.0 3696.9 3704.9 3705.5 3711.1 3725.7 3675.5 3680.1 3692.2 3696.3 3698.9 3682.3 3684.9 3731.9 3733.0 3740.6 3182.0 3207.4 3213.4 3232.6 3240.0 4595.2 4604.6 4610.4 4611.3 4638.9 3983.9 4195.3 4222.1 4226.9 4231.4 4925.3 4934.8 5000.8 5014.6 5018.0 3446.5 3459.4 3466.9 3476.4 3500.5 4980.4 5036.2 5275.7 5279.7 5281.7 3486.9 3504.9 3522.4 3523.7 3533.5 3565.6 3569.0 3585.4 3589.3 3592.9 4147.6 4173.7 4175.6 4184.2 4187.6 4825.0 4937.9 4960.2 4974.3 5092.5 1207.3 1216.1 1219.7 1225.2 1225.9 758.1 779.2 781.1 792.6 796.4 4044.5 4052.8 4065.9 4068.0 4070.8 4553.8 4589.7 4601.2 4613.5 4616.7 4021.6 4054.3 4056.7 4056.7 4075.4 2278.8 2404.8 2414.7 2426.6 2450.5 4297.0 4301.1 4312.0 4324.8 4330.9 4600.5 4619.2 4644.4 4663.5 4677.8 4094.9 4244.6 4311.7 4320.8 4322.8 4546.3 4561.3 4564.4 4570.9 4586.9 4455.3 4503.9 4539.8 4575.2 4576.9 4315.6 4317.3 4362.7 4511.6 4584.3 3547.9 3550.6 3551.8 3558.9 3562.8 5156.6 5170.9 5176.8 5181.4 5181.7 4753.0 5026.7 5047.8 5048.2 5059.5 5020.7 5038.6 5054.6 5063.4 5068.0 4930.7 4977.3 4986.5 4987.9 5000.0 4950.5 5102.9 5103.2 5104.9 5153.8 4915.9 4919.8 4932.4 4945.5 4950.0 04:46:14 INFO - PROCESS | 10201 | 04:46:14 INFO - PROCESS | 10201 | [#5] yui.html Cycles:180 Average:17068.69 Median:503.97 stddev:24709.35 (4903.0%) stddev-sans-first:24747.55 04:46:14 INFO - PROCESS | 10201 | Values: 553.6 573.6 585.0 606.7 664.8 11349.3 12401.7 12442.2 12498.6 12851.9 13900.2 14600.3 14651.6 14685.0 14723.4 727.9 747.0 748.8 749.7 750.6 595.6 731.3 755.5 760.0 764.3 796.4 796.6 796.8 801.7 802.5 794.9 795.0 795.9 796.1 796.3 473.9 478.8 482.0 566.0 577.4 12784.2 12791.7 12808.1 12825.4 12852.4 11910.5 12309.5 12444.1 12817.0 12996.4 9684.7 9840.7 11377.8 11413.9 11488.2 4141.2 4184.0 4196.9 4300.8 4406.1 50649.5 52178.7 52331.7 58975.8 59647.0 9780.0 10049.5 10059.1 10130.2 10321.2 18884.9 18919.7 18934.5 18935.9 18953.8 7017.5 7043.0 7045.6 7110.0 7384.0 3637.8 3750.2 3761.9 3801.2 3887.7 2849.9 3001.6 3010.9 3013.8 3017.6 503.5 505.7 507.3 512.8 516.3 483.0 500.8 532.6 538.3 542.3 7793.5 7934.1 7984.6 8001.4 8149.7 485.7 500.9 504.5 509.5 514.9 3518.7 3820.4 3854.6 3856.9 3937.2 99322.0 99448.5 99672.5 102267.5 105106.5 85059.0 85473.1 87363.6 88045.0 90592.1 43344.8 49449.3 60127.7 60216.7 77564.0 7999.3 8289.2 8293.2 8540.3 8722.8 32557.8 40815.8 41427.8 45073.5 45683.8 56439.0 62852.7 64106.0 64142.0 66730.7 9555.0 9725.2 9772.6 10156.5 10682.7 11313.3 11829.5 11855.6 13076.7 13100.5 10968.8 11081.2 11272.7 11305.3 11892.9 9842.6 10051.9 10132.7 10364.1 10409.8 9960.9 10229.3 10482.4 10528.5 10782.9 8917.7 9145.2 9441.5 9496.0 9680.5 9667.0 9723.0 9738.8 10109.3 10209.4 04:46:14 INFO - PROCESS | 10201 | -------- Summary: end -------- 04:46:14 INFO - PROCESS | 10201 | 04:46:15 INFO - TEST-INFO | 10201: exit 0 04:46:15 INFO - TEST-OK | dromaeo_css | took 1121039ms 04:46:15 INFO - TEST-START | kraken 04:46:15 INFO - operating with platform_type : linux_ 04:46:15 INFO - Initialising browser for kraken test... 04:46:15 INFO - TEST-INFO | started process 10507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSomI7l/profile http://localhost:34458/getInfo.html) 04:46:19 INFO - PROCESS | 10507 | __metrics Screen width/height:1600/1200 04:46:19 INFO - PROCESS | 10507 | colorDepth:24 04:46:19 INFO - PROCESS | 10507 | Browser inner width/height: 1024/697 04:46:19 INFO - PROCESS | 10507 | __metrics 04:46:20 INFO - PROCESS | 10507 | 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" 04:46:20 INFO - PROCESS | 10507 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:20 INFO - PROCESS | 10507 | console.error: PushService: 04:46:20 INFO - PROCESS | 10507 | stateChangeProcessEnqueue: Error transitioning state 04:46:20 INFO - PROCESS | 10507 | UnknownError 04:46:21 INFO - TEST-INFO | 10507: exit 0 04:46:21 INFO - Browser initialized. 04:46:21 INFO - Running cycle 1/1 for kraken test... 04:46:21 INFO - TEST-INFO | started process 10587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSomI7l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:33 INFO - PROCESS | 10587 | RSS: Main: 182198272 04:46:33 INFO - PROCESS | 10587 | 04:46:36 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34458/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:37 INFO - PROCESS | 10587 | RSS: Main: 235151360 04:46:37 INFO - PROCESS | 10587 | 04:46:40 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34458/tests/kraken/driver.html?testName=audio-dft) 04:46:40 INFO - PROCESS | 10587 | RSS: Main: 226103296 04:46:40 INFO - PROCESS | 10587 | 04:46:43 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34458/tests/kraken/driver.html?testName=audio-fft) 04:46:44 INFO - PROCESS | 10587 | RSS: Main: 303022080 04:46:44 INFO - PROCESS | 10587 | 04:46:46 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34458/tests/kraken/driver.html?testName=audio-oscillator) 04:46:47 INFO - PROCESS | 10587 | RSS: Main: 213753856 04:46:47 INFO - PROCESS | 10587 | 04:46:49 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:50 INFO - PROCESS | 10587 | RSS: Main: 215113728 04:46:50 INFO - PROCESS | 10587 | 04:46:53 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34458/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:53 INFO - PROCESS | 10587 | RSS: Main: 253624320 04:46:53 INFO - PROCESS | 10587 | 04:46:57 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34458/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:58 INFO - PROCESS | 10587 | RSS: Main: 252518400 04:46:58 INFO - PROCESS | 10587 | 04:47:00 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34458/tests/kraken/driver.html?testName=json-parse-financial) 04:47:01 INFO - PROCESS | 10587 | RSS: Main: 252493824 04:47:01 INFO - PROCESS | 10587 | 04:47:03 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:03 INFO - PROCESS | 10587 | RSS: Main: 215273472 04:47:03 INFO - PROCESS | 10587 | 04:47:05 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:06 INFO - PROCESS | 10587 | RSS: Main: 222531584 04:47:06 INFO - PROCESS | 10587 | 04:47:08 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:09 INFO - PROCESS | 10587 | RSS: Main: 223784960 04:47:09 INFO - PROCESS | 10587 | 04:47:12 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:12 INFO - PROCESS | 10587 | RSS: Main: 225103872 04:47:12 INFO - PROCESS | 10587 | 04:47:15 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:16 INFO - PROCESS | 10587 | RSS: Main: 222334976 04:47:16 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | Cycle 1(1): loaded http://localhost:34458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34458/tests/kraken/driver.html?testName=ai-astar) 04:47:18 INFO - PROCESS | 10587 | RSS: Main: 273526784 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | __start_tp_report 04:47:18 INFO - PROCESS | 10587 | _x_x_mozilla_page_load 04:47:18 INFO - PROCESS | 10587 | _x_x_mozilla_page_load_details 04:47:18 INFO - PROCESS | 10587 | |i|pagename|runs| 04:47:18 INFO - PROCESS | 10587 | |0;ai-astar;114;116;134;116;116;114;114;114;115;115 04:47:18 INFO - PROCESS | 10587 | |1;audio-beat-detection;154;122;153;188;122;147;153;129;187;129 04:47:18 INFO - PROCESS | 10587 | |2;audio-dft;161;163;161;162;161;160;161;164;161;159 04:47:18 INFO - PROCESS | 10587 | |3;audio-fft;75;76;77;162;76;76;75;75;162;76 04:47:18 INFO - PROCESS | 10587 | |4;audio-oscillator;84;84;145;83;84;83;143;83;83;129 04:47:18 INFO - PROCESS | 10587 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 04:47:18 INFO - PROCESS | 10587 | |6;imaging-darkroom;146;147;146;146;146;145;146;145;146;146 04:47:18 INFO - PROCESS | 10587 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;96;95 04:47:18 INFO - PROCESS | 10587 | |8;json-parse-financial;64;64;65;65;65;65;65;65;64;64 04:47:18 INFO - PROCESS | 10587 | |9;json-stringify-tinderbox;66;67;66;66;66;65;67;66;66;66 04:47:18 INFO - PROCESS | 10587 | |10;stanford-crypto-aes;89;81;83;92;86;83;83;81;88;91 04:47:18 INFO - PROCESS | 10587 | |11;stanford-crypto-ccm;144;133;132;130;130;133;132;133;170;136 04:47:18 INFO - PROCESS | 10587 | |12;stanford-crypto-pbkdf2;179;181;171;182;172;171;173;177;178;179 04:47:18 INFO - PROCESS | 10587 | |13;stanford-crypto-sha256-iterative;71;68;71;69;68;68;69;68;68;67 04:47:18 INFO - PROCESS | 10587 | __end_tp_report 04:47:18 INFO - PROCESS | 10587 | __start_cc_report 04:47:18 INFO - PROCESS | 10587 | _x_x_mozilla_cycle_collect,1962 04:47:18 INFO - PROCESS | 10587 | __end_cc_report 04:47:18 INFO - PROCESS | 10587 | __startTimestamp1472557638387__endTimestamp 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | ------- Summary: start ------- 04:47:18 INFO - PROCESS | 10587 | Number of tests: 14 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#0] ai-astar Cycles:10 Average:116.80 Median:115.50 stddev:6.11 (5.3%) stddev-sans-first:6.39 04:47:18 INFO - PROCESS | 10587 | Values: 114.0 116.0 134.0 116.0 116.0 114.0 114.0 114.0 115.0 115.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.00 stddev:24.22 (15.8%) stddev-sans-first:25.61 04:47:18 INFO - PROCESS | 10587 | Values: 154.0 122.0 153.0 188.0 122.0 147.0 153.0 129.0 187.0 129.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.42 (0.9%) stddev-sans-first:1.50 04:47:18 INFO - PROCESS | 10587 | Values: 161.0 163.0 161.0 162.0 161.0 160.0 161.0 164.0 161.0 159.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:36.37 (47.9%) stddev-sans-first:37.99 04:47:18 INFO - PROCESS | 10587 | Values: 75.0 76.0 77.0 162.0 76.0 76.0 75.0 75.0 162.0 76.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:83.00 stddev:27.16 (32.7%) stddev-sans-first:28.18 04:47:18 INFO - PROCESS | 10587 | Values: 84.0 84.0 145.0 83.0 84.0 83.0 143.0 83.0 83.0 129.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:47:18 INFO - PROCESS | 10587 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:47:18 INFO - PROCESS | 10587 | Values: 146.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:47:18 INFO - PROCESS | 10587 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:47:18 INFO - PROCESS | 10587 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 04:47:18 INFO - PROCESS | 10587 | Values: 66.0 67.0 66.0 66.0 66.0 65.0 67.0 66.0 66.0 66.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:87.00 stddev:4.08 (4.7%) stddev-sans-first:4.15 04:47:18 INFO - PROCESS | 10587 | Values: 89.0 81.0 83.0 92.0 86.0 83.0 83.0 81.0 88.0 91.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:133.00 stddev:12.18 (9.2%) stddev-sans-first:12.67 04:47:18 INFO - PROCESS | 10587 | Values: 144.0 133.0 132.0 130.0 130.0 133.0 132.0 133.0 170.0 136.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:178.50 stddev:4.19 (2.3%) stddev-sans-first:4.33 04:47:18 INFO - PROCESS | 10587 | Values: 179.0 181.0 171.0 182.0 172.0 171.0 173.0 177.0 178.0 179.0 04:47:18 INFO - PROCESS | 10587 | 04:47:18 INFO - PROCESS | 10587 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.34 (2.0%) stddev-sans-first:1.13 04:47:18 INFO - PROCESS | 10587 | Values: 71.0 68.0 71.0 69.0 68.0 68.0 69.0 68.0 68.0 67.0 04:47:18 INFO - PROCESS | 10587 | -------- Summary: end -------- 04:47:18 INFO - PROCESS | 10587 | 04:47:19 INFO - TEST-INFO | 10587: exit 0 04:47:19 INFO - TEST-OK | kraken | took 64548ms 04:47:19 INFO - SUITE-END | took 1185s 04:47:20 INFO - Completed test suite (00:19:45) 04:47:20 INFO - javascript benchmark 04:47:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.681414823147, 2582.4447743735095, 2588.7540683635048, 2609.269404566721, 2639.419327747896, 4593.173228818811, 4623.2140536108855, 4716.599089077424, 4745.122152401804, 4784.712917224964, 4605.286180641998, 4756.120117778205, 4773.665843390964, 4775.594074503671, 4776.235802271637, 4272.615464608185, 4333.934990975138, 4351.73889566627, 4400.339949007658, 4431.047324825162, 4361.60745532902, 4401.383806267125, 4403.339499075132, 4404.647628189737, 4422.7788610569505, 4364.912701745963, 4398.450193725785, 4408.823647054114, 4521.751303678297, 4524.97737511312, 4385.780710964471, 4407.250767369523, 4440.755758433284, 4466.955330446686, 4468.82124715011, 4203.579642035803, 4242.66058715302, 4299.398084268205, 4362.978185109086, 4372.147431250907, 4609.354690343354, 4624.861254162381, 4636.072785442925, 4638.930416043762, 4700.0, 4992.475790042066, 5023.522765337287, 5030.924536131961, 5042.067217564762, 5044.47033061527, 4928.162212423897, 4981.128302547076, 5072.873178170538, 5080.212567052113, 5104.770285337168, 4738.289256611536, 4740.956989462313, 4747.12178247022, 4751.429828420612, 4758.238681810963, 5171.81898633546, 5202.661826981234, 5206.245094461282, 5209.6353255272525, 5271.578273738091, 4852.17513022787, 4911.0423467424225, 4942.728149951715, 4948.282499037691, 4995.275685025651, 5033.119204139334, 5065.949340506548, 5068.163752980717, 5069.670471419346, 5117.820876269388, 4996.475370086161, 5008.824691135793, 5011.599072074226, 5017.096922553976, 5026.371703537058, 4856.344393506832, 4903.436104847917, 4905.435874874363, 4958.7024778513405, 4981.90036199274, 4171.812268447927, 4176.749395036247, 4192.91614167721, 4248.214080395137, 4267.338562522814, 3677.062349100962, 3678.889633311005, 3683.7421380503642, 3726.8136593170234, 3735.589085200626, 4405.559444055569, 4410.80151393188, 4411.602955733999, 4417.2269852775635, 4466.173757854807, 4905.8037678492465, 4983.327250821165, 5006.824761133343, 5041.890784027508, 5127.897442051213, 4377.606015458624, 4380.737155770664, 4433.7561434121435, 4444.822207111744, 4447.266201076851, 4423.51341352451, 4451.10977804434, 4466.151431228056, 4468.754218518013, 4522.547745225451, 4618.630509559294, 4704.50602686713, 4727.787249573708, 4764.2615394613895, 4767.856964291077, 5057.140286151437, 5090.41460232078, 5134.255532947627, 5147.459516750687, 5155.200943853709, 4787.976060119677, 4788.760561971957, 4793.113274044313, 4795.64032697556, 4860.246661767432, 4853.320535125014, 4919.532644398776, 4997.075541024922, 5012.448630650699, 5073.44192138857, 4998.175301075282, 5033.672811267256, 5040.697558146377, 5106.617003724809, 5114.181730923183, 4898.53463920927, 4900.975495122501, 4901.926471103007, 4920.6555541111775, 4963.280324352876, 4791.880202994814, 4896.338994235733, 4900.362952816111, 4923.901521969612, 4972.477889821516, 4853.466118726867, 4927.137750893651, 4931.211006238985, 4970.204767237225, 4971.428285747185, 5011.0, 5033.446320904624, 5037.471065538212, 5045.167547354646, 5105.566026887756, 4697.788599512962, 4736.621070314435, 4744.074905393415, 4881.536254055859, 4898.2652602109965], "value": 4635.380194148848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4017291239005, 553.919681646161, 565.3159676791082, 565.7878295639135, 598.7664810723816, 26838.329041773966, 36824.44763328549, 37689.05777355567, 37843.24313513728, 41618.0, 38786.418203726964, 39081.218375632474, 39167.60832391682, 39190.60809391905, 39196.21607567847, 6998.475114366417, 7579.81050473737, 7774.028246469192, 7774.611269436534, 7775.922240777605, 7040.225575186725, 7262.891056634155, 7263.854722905538, 9727.951360243223, 10003.649872254473, 10059.69820905374, 10157.644482443116, 10161.18710503158, 10166.440845753481, 10175.13511351536, 9745.415275083482, 9822.066903644143, 9827.312088153833, 9831.459269740162, 9833.704988850346, 9781.16860066888, 9842.163416109639, 9861.50692465381, 9865.654702085465, 9873.259505537042, 37155.07112322187, 37355.0, 37413.43879841804, 37646.62353376486, 37695.62304376976, 2411.2284069097896, 2588.9482210355877, 2604.1927002629054, 2623.6606123198894, 2648.589468632346, 27796.30509237285, 27813.582796258073, 28437.431251374855, 28467.57298640522, 28682.569761453597, 3233.4503134467195, 3342.4652055670977, 3374.3420033093557, 3376.1728376547658, 3389.9661003389897, 224130.0, 226198.86900565555, 227180.0, 227615.0, 228411.0, 45668.77165614151, 45775.08449830985, 45778.31332530015, 45801.770991145495, 45879.77060114678, 31362.0, 32006.679933200834, 32053.0, 53612.73193634007, 53783.19325210125, 12657.0, 12851.100422970489, 12865.0, 12873.098883078095, 12875.291858947849, 9339.906600933904, 9352.859707104399, 9365.578548965314, 9366.578503967337, 9372.718818435458, 15396.307166177548, 17634.294628214728, 18007.18967646459, 18188.727169092475, 18286.268549258148, 6510.446612037935, 6742.089817874524, 6752.696128674222, 6758.0, 6807.285235050248, 709.1844378964232, 734.930181632744, 803.3854101612271, 843.1989609870648, 869.1395518436702, 26819.195424137306, 26866.32834179161, 26987.730122698915, 26997.325066873484, 27462.5880611791, 897.6858099665066, 901.9774505637412, 904.412132114131, 953.7377221264069, 987.0376383026635, 14272.21502817355, 14438.494652687106, 14620.488282910259, 14722.190279534514, 14846.851531484763, 365473.0, 371066.0, 372068.0, 372095.0, 372172.0, 47340.5265947343, 47621.0, 47630.0, 47659.76170119127, 47667.284990725166, 1009.4700282351678, 1096.9177311701494, 1099.7305660113163, 1111.7498562823623, 1116.776644671069, 26829.329266767705, 28017.299567510974, 28804.70054347487, 28955.0, 29208.0, 40149.799251003555, 40586.0, 40604.79697601493, 40606.18787624172, 40618.0, 288853.0, 289613.0, 290284.0, 290473.0, 514089.0, 34308.0, 34557.0, 34611.40414468874, 34836.82581587076, 35230.29539409146, 39979.60020399759, 40143.0, 40400.39399408952, 40654.186916260915, 40917.59082409138, 33489.0, 33650.49524257187, 34043.82978085094, 34094.48858267078, 34116.658833412344, 31763.523547147273, 31957.840210798797, 31966.68033319637, 32830.507542387364, 32877.83561082275, 33631.66368336383, 34325.0, 34707.82646086753, 34876.65123348734, 34940.65059349374, 30314.545281821232, 32279.677203227668, 32323.676763232066, 32808.67191328056, 32875.17812054718, 24733.628995564723, 24765.009399624534, 24807.25578232656, 25123.120690775737, 25230.116945906804], "value": 17095.646497242407, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.33167000164667, 348.1539858144708, 350.8035500119933, 351.1834983662984, 367.37729548415444, 12226.938865305672, 15534.766978495318, 15610.453634122821, 16764.74852877205, 16911.0, 14904.701905961874, 15150.24248787559, 15405.845941540581, 15909.681806363866, 16028.75956860645, 4556.954430455703, 4702.036082603076, 4707.152712511764, 5012.172991456424, 5237.528622423981, 3369.4103531881824, 5320.973395133019, 5350.35795704514, 5354.437784032679, 5356.651817631861, 5569.721513924287, 5825.155352473888, 5844.853878653025, 5932.406759324054, 5944.673042982634, 5357.544608708265, 5421.0, 5707.543396528309, 5925.437083477084, 5948.791792287249, 5240.79036838526, 5256.421793602739, 5256.526912577886, 5256.553192978601, 5256.894862102775, 11458.197926145172, 11508.367039812807, 11515.42422878861, 11656.067514598897, 11758.823617645741, 1607.9678406431922, 1648.0523698873076, 1661.1943207544332, 1768.0629266488652, 1950.1516840174427, 8487.787805304855, 8513.404061715682, 8652.826943461096, 8965.910340896638, 9100.590473428712, 1641.9261133249033, 1685.3764107280385, 1692.7968643762704, 1757.6748301564123, 1768.5578605348662, 64444.0, 67316.9999999995, 68133.0, 68486.65756671184, 69555.30444695539, 9260.953695231616, 9270.768230794283, 9301.581428835718, 9505.952470237604, 9568.856467152998, 12392.132550721362, 12422.37888105591, 12429.75140497185, 12462.003039756797, 12463.813042804366, 6656.434203092695, 6862.725490980305, 7021.929780702229, 7026.648667566601, 7033.542819716702, 6480.125183100316, 6528.934710652928, 6563.278039415661, 6688.86622267552, 6713.597184168965, 4127.195196936568, 4139.317012692933, 4143.91712165755, 4241.512226093977, 4244.38456423823, 1718.6219031812982, 1723.4743403261875, 1748.7901451825862, 1760.6390689908537, 1771.6191018930733, 764.399946042354, 764.4343186042399, 770.7764748223065, 776.8407476467311, 790.8260182759784, 15246.009009414352, 15353.923230384, 15577.844221557865, 15965.521034368987, 17082.914585427243, 745.3552676934521, 764.1785081037907, 789.7788619186637, 795.2882170457408, 847.4957400346784, 9088.772780680536, 9109.089091090838, 9136.314776391797, 9201.769955751026, 9380.155785979294, 272860.0, 275689.0, 276798.0, 368341.0, 368944.0, 79093.60453197813, 79124.54882669845, 80189.0, 80705.59647201726, 82210.0, 867.8134201146784, 874.4578361415836, 915.7985243246475, 919.8114386550741, 921.3642586615214, 15525.456609019082, 15655.608609784846, 16222.67554648924, 16331.918340408221, 16610.66778664444, 36431.45352819763, 37935.0, 37979.62020379761, 38008.80995595004, 38225.80887095658, 45255.321170181815, 47636.761816190694, 50905.74547127241, 52611.0, 54630.726846367106, 4422.778861056999, 6792.811258029727, 7192.928070719226, 7286.854262914818, 7686.0, 9571.569279382584, 11812.291262524275, 11913.404329783649, 12103.697407564881, 12244.938775306422, 9969.750756230862, 10199.898001020192, 10216.59133634676, 10594.735131621772, 10780.946095269474, 10308.433036182782, 10362.481875906024, 10388.792224155324, 10672.30630009047, 10796.190285728444, 10339.63811266602, 10447.268691191848, 10532.842007369742, 10585.100266477128, 10679.19906007037, 7282.563046217244, 7416.184219735716, 7483.850322993619, 7497.9250207497225, 7672.80817979555, 9274.0, 9791.51042447889, 9953.751156221153, 10135.797284054424, 10509.159267258754], "value": 7761.655321821772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.3958020989505, 1311.1215485624627, 1357.1246545977845, 1401.1593044173496, 1651.983480165198, 7116.430685545157, 7386.630668466575, 7458.254174582539, 7659.693612255517, 7666.808329791744, 7528.84942301155, 7619.047619047619, 7621.618919054039, 7624.961875190616, 7628.694852205919, 2195.999999999996, 2216.2021672198, 2217.700610417589, 2220.2340192633596, 2222.355516900097, 2156.7843215678463, 2193.5393567350798, 2208.4920468292303, 2209.5801797658473, 2209.657503087024, 2162.9242976495825, 2170.793774591419, 2172.435166856621, 2175.0973346061446, 2223.2329846203115, 2144.774798646143, 2150.0432307623114, 2151.0427859602405, 2151.08578853988, 2152.35429371188, 2080.9479763006048, 2124.4795025218764, 2125.107454868959, 2127.0322003488377, 2128.5423633918626, 7397.0, 7506.249375062504, 7567.621618919087, 7581.203973582805, 7581.658825352873, 4342.196693611692, 4537.591616754475, 4556.066006468699, 4556.270996640555, 4562.315652652095, 2782.401783616512, 2874.7125287471295, 2931.0, 2933.838638874861, 2935.6368123660445, 920.5581320965907, 926.6895589977365, 931.1759093202497, 971.7327734872896, 982.1062832822169, 10145.137663298628, 10204.948975255076, 10227.437490937995, 10228.488575571266, 10231.079202871777, 3822.0, 3949.921001579952, 3972.1658451724884, 4054.39184122384, 4219.7046206765235, 7932.881006784903, 8080.030396352476, 8100.878486822702, 8102.878456823152, 8120.106788253287, 4342.804573794124, 4348.630366418826, 4350.151720414552, 4351.260285751367, 4352.347147927773, 3533.205028868484, 3823.2162406706557, 3991.501062367204, 4035.838566457309, 4036.939445908255, 3289.1283809790425, 3305.5455599536126, 3389.457686770105, 3423.9144021399666, 3432.8111953842777, 1032.963846265377, 1058.5448257249302, 1071.346478648024, 1076.5424694504804, 1077.9946100269606, 594.7829042399493, 628.446966669328, 646.6669665122465, 666.8832954232989, 668.6155460610071, 4767.76161191939, 4768.523147685273, 4791.425028996473, 4801.591864691541, 4835.927461088087, 392.7937832637888, 393.6673510883299, 396.843246917466, 396.9144390093093, 401.141557067875, 3237.093613788143, 3237.7409807215836, 3281.6390197078304, 3295.2915123248135, 3401.9489707654407, 9081.81836363269, 9311.301652376098, 9418.529073546433, 9428.198603118675, 9445.622175112918, 9354.90645093554, 9362.719118426457, 9363.110504502061, 9370.718878433658, 9379.108984646447, 7184.461165412615, 7209.963950180216, 7252.601106939169, 7254.637268136572, 7260.2013778484325, 4769.284607308793, 4840.927386089141, 4891.388576427947, 4912.901741965212, 5045.041442125985, 8269.669213231404, 8537.829243414973, 8559.914400855912, 8572.742817715478, 8578.571071446528, 8603.870941936002, 8680.131986801269, 8774.034856165945, 8826.42628229163, 8923.73228803137, 5497.560195184456, 6019.789307374221, 6073.119397687399, 6077.787277445268, 6078.54410919174, 6334.778282760081, 6419.069234960998, 6806.7957961261245, 6882.7591034313555, 7059.470539709439, 5942.881142377215, 6093.542984276109, 6129.325774164749, 6135.754569817157, 6226.25284965807, 5810.912836307374, 5918.3489816121055, 6000.5799594028, 6016.488598469179, 6098.0, 5701.201831743476, 5704.771809127588, 5723.5707321950185, 5749.798757043483, 5762.971185144047, 4273.850415235452, 4303.956960430356, 4379.868603941887, 4434.17967675981, 4492.775361231991, 4298.602954039887, 4335.371371151103, 4344.934825977676, 4479.148961697267, 4509.661775366926], "value": 3835.7948886028953, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.04930447606523, 270.8496784284722, 273.34806486529635, 274.15286763899553, 276.3202521796381, 4318.265894797884, 4603.194440972825, 4833.661643684939, 4873.95126048739, 4893.926591101136, 4702.0, 4749.002709431015, 4764.833230836913, 4803.783829727662, 4818.566329030386, 3525.5416795816636, 3592.2276710507235, 3717.5910649828634, 3755.1738617504175, 3764.0, 3696.870609528667, 3704.907377315575, 3705.5368078990127, 3711.1464363196483, 3725.7205709571754, 3675.4854320395166, 3680.11677197472, 3692.187718701895, 3696.297703436352, 3698.907527311825, 3682.287736202665, 3684.926301473969, 3731.8507259709577, 3732.9920921351354, 3740.597276021492, 3181.984090079535, 3207.4226639204935, 3213.373392188524, 3232.5797646306064, 3240.0, 4595.195840727893, 4604.631629469634, 4610.423697037871, 4611.30830375443, 4638.8608341749805, 3983.9203215935518, 4195.307774217251, 4222.134462435224, 4226.85206017791, 4231.449911511515, 4925.310456536052, 4934.841701311164, 5000.849974500735, 5014.5737612303, 5018.0, 3446.5174875517446, 3459.394605943975, 3466.861325546975, 3476.3568739783223, 3500.547272881751, 4980.402351717781, 5036.219385995177, 5275.709835959021, 5279.729716222023, 5281.735913204325, 3486.930261394758, 3504.9474257886154, 3522.383582872987, 3523.700485458765, 3533.5229743984232, 3565.625609311037, 3568.9643103568633, 3585.4442561403025, 3589.282143571244, 3592.892213233607, 4147.605977432139, 4173.6661067114555, 4175.645070169009, 4184.205001049791, 4187.581241875849, 4824.975875120672, 4937.87655308613, 4960.206366981266, 4974.27872958419, 5092.541671249532, 1207.2877002568528, 1216.1365430544236, 1219.6645922371242, 1225.2403509823966, 1225.8651548329676, 758.135725273189, 779.205210685098, 781.0978320040363, 792.6235038356734, 796.3748457460981, 4044.463104020512, 4052.8378864845076, 4065.918681626351, 4068.0, 4070.776107314126, 4553.795079221443, 4589.728084598145, 4601.240795268744, 4613.500612301015, 4616.6537509686905, 4021.617946295097, 4054.290499162694, 4056.6551843093075, 4056.6957478189256, 4075.449814275094, 2278.8404811663354, 2404.843685160459, 2414.6740190074465, 2426.5874801283826, 2450.546648869965, 4297.0, 4301.0537681709975, 4311.956880431218, 4324.783760811947, 4330.891727706769, 4600.493945665974, 4619.214733495314, 4644.373009643722, 4663.510331415153, 4677.812887484531, 4094.8566800161852, 4244.575542445731, 4311.741295522279, 4320.8487702929615, 4322.827086916551, 4546.272596384562, 4561.270196768501, 4564.42944631921, 4570.8857278566975, 4586.88532786683, 4455.309427038814, 4503.909921801611, 4539.843574302312, 4575.192798844371, 4576.88557786058, 4315.633171180485, 4317.309230523101, 4362.694611377173, 4511.571400716926, 4584.312353146921, 3547.911302217465, 3550.573931128281, 3551.75137740366, 3558.8646811912645, 3562.8040457775073, 5156.587473002076, 5170.871622668382, 5176.792928282826, 5181.35233095863, 5181.663191892515, 4753.0, 5026.723530205873, 5047.772850221822, 5048.192289233705, 5059.494050594911, 5020.723860187724, 5038.596912247085, 5054.620903432184, 5063.392392912727, 5067.974660126676, 4930.6795058321095, 4977.253411988231, 4986.526280003394, 4987.900241995212, 5000.0, 4950.45544990058, 5102.897942041064, 5103.209002604603, 5104.9489505104475, 5153.793848246178, 4915.852524424273, 4919.778609962632, 4932.42162507994, 4945.455999839943, 4949.975250123726], "value": 3618.384253878948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5543887170826, 573.5812856614672, 585.0288521055049, 606.6814922165862, 664.8238216872529, 11349.262297950638, 12401.689957751061, 12442.191257568264, 12498.625041248755, 12851.935740321285, 13900.165990040605, 14600.269986500685, 14651.560453186396, 14685.0, 14723.411063557473, 727.8507905879309, 746.9813254668622, 748.809053691308, 749.7413392379648, 750.6284389227313, 595.6068994463654, 731.3381389842175, 755.5126943121684, 760.0347558600574, 764.2624867003341, 796.3788245168778, 796.557910359753, 796.7848680856165, 801.7434420985287, 802.4623502253474, 794.9483283586549, 794.9920500795005, 795.9442839001272, 796.1401686178942, 796.2873228460553, 473.94312682477977, 478.83240865697076, 481.9710817350935, 565.9547236221092, 577.3822010448821, 12784.232946023269, 12791.74416511674, 12808.10343275971, 12825.422855971503, 12852.357382130856, 11910.523579056828, 12309.507619695201, 12444.128910976235, 12817.03872209588, 12996.41516131767, 9684.661036863747, 9840.65557705484, 11377.772444551145, 11413.942930285379, 11488.195826292163, 4141.192467468844, 4184.0, 4196.874093777192, 4300.849470268526, 4406.05269866977, 50649.49350506521, 52178.73910630422, 52331.73834130843, 58975.82048359052, 59647.0, 9779.951100244596, 10049.497525123714, 10059.144972677259, 10130.189584833342, 10321.225908056926, 18884.90557547231, 18919.716204256947, 18934.52663683419, 18935.905320473586, 18953.810461895206, 7017.543859649107, 7043.049188359506, 7045.647717614099, 7109.964450177716, 7384.0, 3637.797948932998, 3750.1749615084636, 3761.887143385703, 3801.1827457096306, 3887.7084218683144, 2849.900253491118, 3001.6398032235834, 3010.909672709822, 3013.804102733315, 3017.5926249955974, 503.47386980605353, 505.6788939023746, 507.32779067735396, 512.7948820471842, 516.3210378352529, 482.9710217386968, 500.8146985615273, 532.566172591262, 538.2948337677655, 542.2950164785763, 7793.454458187985, 7934.116802011292, 7984.560849153236, 8001.4398992071165, 8149.7147599833725, 485.65033176113144, 500.8923081537487, 504.46022755651103, 509.5388673250714, 514.8944466384382, 3518.736094792901, 3820.4269359596283, 3854.5952674969285, 3856.903577410531, 3937.2125574885135, 99322.0, 99448.50275748575, 99672.50163749135, 102267.4886625562, 105106.47446762871, 85059.0, 85473.14526854776, 87363.56318218369, 88045.0, 90592.09407905968, 43344.78327608342, 49449.25826112611, 60127.69936150291, 60216.698916505135, 77564.0, 7999.320057795153, 8289.212524810133, 8293.170682931659, 8540.27407670355, 8722.825543489222, 32557.837210813796, 40815.7959210202, 41427.75014372412, 45073.54926450693, 45683.77158114188, 56439.0, 62852.685736571024, 64106.0, 64142.0, 66730.66634666796, 9554.952225238829, 9725.221982241545, 9772.56023478931, 10156.542955567165, 10682.73293167677, 11313.321200727984, 11829.52681892749, 11855.644330670093, 13076.673083172996, 13100.475980960655, 10968.835467467834, 11081.168912331768, 11272.66182014541, 11305.26515776472, 11892.881071189524, 9842.606295748375, 10051.894291628061, 10132.746681333025, 10364.067233948981, 10409.843852342372, 9960.900390995997, 10229.283950123718, 10482.423466709404, 10528.526216320131, 10782.946085269523, 8917.68934124754, 9145.222656074307, 9441.48071856027, 9496.0, 9680.467574283482, 9666.95166524163, 9723.0, 9738.80522389534, 10109.292349535463, 10209.438480883622], "value": 6327.116321741393, "unit": "score"}], "name": "dromaeo_css", "value": 6148.356447840174, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 134.0, 116.0, 116.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 153.0, 188.0, 122.0, 147.0, 153.0, 129.0, 187.0, 129.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 161.0, 160.0, 161.0, 164.0, 161.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 162.0, 76.0, 76.0, 75.0, 75.0, 162.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 83.0, 84.0, 83.0, 143.0, 83.0, 83.0, 129.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 83.0, 92.0, 86.0, 83.0, 83.0, 81.0, 88.0, 91.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 132.0, 130.0, 130.0, 133.0, 132.0, 133.0, 170.0, 136.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 171.0, 182.0, 172.0, 171.0, 173.0, 177.0, 178.0, 179.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 71.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1576.2999999999997, "alertThreshold": 2.0}]} 04:47:20 INFO - Return code: 0 04:47:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:20 INFO - # TBPL SUCCESS # 04:47:20 INFO - Running post-action listener: _resource_record_post_action 04:47:20 INFO - [mozharness: 2016-08-30 11:47:20.180065Z] Finished run-tests step (success) 04:47:20 INFO - Running post-run listener: _resource_record_post_run 04:47:20 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 12288; Write bytes: 419053568; Read time: 228; Write time: 438388 04:47:20 INFO - TinderboxPrint: CPU usage
13.1% 04:47:20 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 228 04:47:20 INFO - TinderboxPrint: I/O write bytes / time
419,053,568 / 438,388 04:47:20 INFO - TinderboxPrint: CPU idle
8,333.8 (86.9%) 04:47:20 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 04:47:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114487296; Read time: 0; Write time: 162728 04:47:20 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293179392; Read time: 216; Write time: 272336 04:47:20 INFO - Running post-run listener: _upload_blobber_files 04:47:20 INFO - Blob upload gear active. 04:47:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:20 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 04:47:20 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'] 04:47:20 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 04:47:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:25 INFO - (blobuploader) - INFO - Done attempting. 04:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:26 INFO - (blobuploader) - INFO - Done attempting. 04:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:27 INFO - (blobuploader) - INFO - Done attempting. 04:47:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:27 INFO - Return code: 0 04:47:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/522cfab4d042bbc80dd5e730a7660213f4526003f53c285efe06c7dbf44f405aac9b6e12b9e7d3aba2223bf90e10957791d32915d1865ad1b61067827d79ae42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b424cd7e6fa30d21270d65dad74c46417554adecd7cd4ebbea5dba89e5f574530a98ba410c4af0527d1be505dc02aebcfbb2146728c529f5f3c98098f4cad78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11c484d9b721a3507527c58091b9a019443edf39de56a182a85b22167789636be1825e101ab27e5ab6d5804a15c4710e421048959452e5dc0dc644cd7bcc5285"} 04:47:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:27 INFO - Contents: 04:47:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/522cfab4d042bbc80dd5e730a7660213f4526003f53c285efe06c7dbf44f405aac9b6e12b9e7d3aba2223bf90e10957791d32915d1865ad1b61067827d79ae42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b424cd7e6fa30d21270d65dad74c46417554adecd7cd4ebbea5dba89e5f574530a98ba410c4af0527d1be505dc02aebcfbb2146728c529f5f3c98098f4cad78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11c484d9b721a3507527c58091b9a019443edf39de56a182a85b22167789636be1825e101ab27e5ab6d5804a15c4710e421048959452e5dc0dc644cd7bcc5285"} 04:47:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:27 INFO - Copying logs to upload dir... 04:47:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.109351 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-30 04:47:27.606430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 04:47:27.609718) ========= 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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 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/522cfab4d042bbc80dd5e730a7660213f4526003f53c285efe06c7dbf44f405aac9b6e12b9e7d3aba2223bf90e10957791d32915d1865ad1b61067827d79ae42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b424cd7e6fa30d21270d65dad74c46417554adecd7cd4ebbea5dba89e5f574530a98ba410c4af0527d1be505dc02aebcfbb2146728c529f5f3c98098f4cad78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11c484d9b721a3507527c58091b9a019443edf39de56a182a85b22167789636be1825e101ab27e5ab6d5804a15c4710e421048959452e5dc0dc644cd7bcc5285"} build_url:https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/L1NbUeYdR6e1kRXAXcBh6Q/artifacts/public/build/firefox-51.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/522cfab4d042bbc80dd5e730a7660213f4526003f53c285efe06c7dbf44f405aac9b6e12b9e7d3aba2223bf90e10957791d32915d1865ad1b61067827d79ae42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b424cd7e6fa30d21270d65dad74c46417554adecd7cd4ebbea5dba89e5f574530a98ba410c4af0527d1be505dc02aebcfbb2146728c529f5f3c98098f4cad78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11c484d9b721a3507527c58091b9a019443edf39de56a182a85b22167789636be1825e101ab27e5ab6d5804a15c4710e421048959452e5dc0dc644cd7bcc5285"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 04:47:27.635394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:47:27.635726) ========= 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=32c5991c409366f7fec8a718000001d2-1472556036.409272-1991619708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 04:47:27.718014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 04:47:27.718322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 04:47:27.718621) ========= ========= Total master_lag: 0.43 =========