builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1472324150.76 results: success (0) buildid: 20160827105213 builduid: 856d608892144123b0d518d75e509696 revision: 125b052639cb1879d4a593c715d244c551129118 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.756887) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.757411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.757678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.793369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.793625) ========= 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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 11:55:51-- 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% 70.5M=0s 2016-08-27 11:55:51 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.919959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.920282) ========= 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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015683 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.971388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:50.971705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 125b052639cb1879d4a593c715d244c551129118 --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 125b052639cb1879d4a593c715d244c551129118 --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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 11:55:51,222 truncating revision to first 12 chars 2016-08-27 11:55:51,222 Setting DEBUG logging. 2016-08-27 11:55:51,222 attempt 1/10 2016-08-27 11:55:51,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/125b052639cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 11:55:51,762 unpacking tar archive at: fx-team-125b052639cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.805898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:51.790796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:51.791099) ========= script_repo_revision: 125b052639cb1879d4a593c715d244c551129118 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:51.791486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:51.791747) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:55:51.801162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-27 11:55:51.801512) ========= /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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:55:52 INFO - MultiFileLogger online at 20160827 11:55:52 in /builds/slave/test 11:55:52 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 11:55:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:52 INFO - {'append_to_log': False, 11:55:52 INFO - 'base_work_dir': '/builds/slave/test', 11:55:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:55:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:52 INFO - 'branch': 'Fx-Team-Non-PGO', 11:55:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:52 INFO - 'config_files': ('talos/linux_config.py',), 11:55:52 INFO - 'default_actions': ('clobber', 11:55:52 INFO - 'read-buildbot-config', 11:55:52 INFO - 'download-and-extract', 11:55:52 INFO - 'populate-webroot', 11:55:52 INFO - 'create-virtualenv', 11:55:52 INFO - 'install', 11:55:52 INFO - 'run-tests'), 11:55:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:52 INFO - 'download_minidump_stackwalk': True, 11:55:52 INFO - 'download_symbols': 'ondemand', 11:55:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:52 INFO - 'installer_path': 'installer.exe', 11:55:52 INFO - 'log_level': 'info', 11:55:52 INFO - 'log_name': 'talos', 11:55:52 INFO - 'log_to_console': True, 11:55:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:55:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:55:52 INFO - 'opt_config_files': (), 11:55:52 INFO - 'pip_index': False, 11:55:52 INFO - 'sps_profile': False, 11:55:52 INFO - 'sps_profile_interval': 0, 11:55:52 INFO - 'suite': 'dromaeojs', 11:55:52 INFO - 'system_bits': '32', 11:55:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:52 INFO - 'title': 'talos-linux64-ix-025', 11:55:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:52 INFO - 'use_talos_json': True, 11:55:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:52 INFO - 'work_dir': 'build'} 11:55:52 INFO - [mozharness: 2016-08-27 18:55:52.143812Z] Running clobber step. 11:55:52 INFO - Running pre-action listener: _resource_record_pre_action 11:55:52 INFO - Running main action method: clobber 11:55:52 INFO - rmtree: /builds/slave/test/build 11:55:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:52 INFO - Running post-action listener: _resource_record_post_action 11:55:52 INFO - [mozharness: 2016-08-27 18:55:52.596220Z] Finished clobber step (success) 11:55:52 INFO - [mozharness: 2016-08-27 18:55:52.596323Z] Running read-buildbot-config step. 11:55:52 INFO - Running pre-action listener: _resource_record_pre_action 11:55:52 INFO - Running main action method: read_buildbot_config 11:55:52 INFO - Using buildbot properties: 11:55:52 INFO - { 11:55:52 INFO - "project": "", 11:55:52 INFO - "product": "firefox", 11:55:52 INFO - "script_repo_revision": "production", 11:55:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:55:52 INFO - "repository": "", 11:55:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:55:52 INFO - "buildid": "20160827105213", 11:55:52 INFO - "pgo_build": "False", 11:55:52 INFO - "basedir": "/builds/slave/test", 11:55:52 INFO - "buildnumber": 1896, 11:55:52 INFO - "slavename": "talos-linux64-ix-025", 11:55:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:55:52 INFO - "platform": "ubuntu64_hw", 11:55:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:55:52 INFO - "branch": "fx-team", 11:55:52 INFO - "repo_path": "integration/fx-team", 11:55:52 INFO - "revision": "125b052639cb1879d4a593c715d244c551129118", 11:55:52 INFO - "stage_platform": "linux64", 11:55:52 INFO - "builduid": "856d608892144123b0d518d75e509696", 11:55:52 INFO - "slavebuilddir": "test" 11:55:52 INFO - } 11:55:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:55:52 INFO - Running post-action listener: _resource_record_post_action 11:55:52 INFO - [mozharness: 2016-08-27 18:55:52.598781Z] Finished read-buildbot-config step (success) 11:55:52 INFO - [mozharness: 2016-08-27 18:55:52.598869Z] Running download-and-extract step. 11:55:52 INFO - Running pre-action listener: _resource_record_pre_action 11:55:52 INFO - Running main action method: download_and_extract 11:55:52 INFO - mkdir: /builds/slave/test/build/tests 11:55: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')]} 11:55:52 INFO - trying https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:55:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:53 INFO - Downloaded 1361 bytes. 11:55:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:55:53 INFO - Using the following test package requirements: 11:55:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:55:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:55:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:55:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'jsshell-linux-x86_64.zip'], 11:55:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:55:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:55:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:55:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:55:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:55:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:55:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:55:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:55:53 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')]} 11:55:53 INFO - trying https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:54 INFO - Downloaded 20304670 bytes. 11:55:54 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 11:55:58 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 11:55: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')]} 11:55:58 INFO - trying https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:55:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:55:59 INFO - Downloaded 20304670 bytes. 11:55:59 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 11:56: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')]} 11:56:03 INFO - trying https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:56:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:56:05 INFO - Downloaded 14413998 bytes. 11:56:05 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 11:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:05 INFO - trying https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:56:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/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 11:56:07 INFO - Downloaded 55866334 bytes. 11:56:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:56:07 INFO - mkdir: /builds/slave/test/properties 11:56:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:56:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:56:07 INFO - Contents: 11:56:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:56:08 INFO - Running post-action listener: _resource_record_post_action 11:56:08 INFO - Running post-action listener: set_extra_try_arguments 11:56:08 INFO - [mozharness: 2016-08-27 18:56:08.621299Z] Finished download-and-extract step (success) 11:56:08 INFO - [mozharness: 2016-08-27 18:56:08.621527Z] Running populate-webroot step. 11:56:08 INFO - Running pre-action listener: _resource_record_pre_action 11:56:08 INFO - Running main action method: populate_webroot 11:56:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:56:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:56:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:56:08 INFO - '--tppagecycles', 11:56:08 INFO - '7'], 11:56:08 INFO - 'tests': ['tsvgm']}}, 11:56:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:56:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:56:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:56:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:56:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['damp', 'tps']}, 11:56:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'tests': ['damp', 'tps']}, 11:56:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['dromaeo_dom']}, 11:56:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:56:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['basic_compositor_video']}, 11:56:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:56:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['a11yr', 11:56:08 INFO - 'ts_paint', 11:56:08 INFO - 'tpaint', 11:56:08 INFO - 'sessionrestore', 11:56:08 INFO - 'sessionrestore_no_auto_restore', 11:56:08 INFO - 'tabpaint']}, 11:56:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['tsvgx', 11:56:08 INFO - 'tsvgr_opacity', 11:56:08 INFO - 'tart', 11:56:08 INFO - 'tscrollx', 11:56:08 INFO - 'cart']}, 11:56:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:56:08 INFO - 'tsvgr_opacity', 11:56:08 INFO - 'tart', 11:56:08 INFO - 'tscrollx', 11:56:08 INFO - 'cart']}, 11:56:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'talos_options': ['--disable-e10s'], 11:56:08 INFO - 'tests': ['tp5o']}, 11:56:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'tests': ['tp5o']}, 11:56:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'talos_options': ['--disable-e10s', 11:56:08 INFO - '--xperf_path', 11:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:08 INFO - 'tests': ['tp5n']}, 11:56:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:56:08 INFO - 'talos_options': ['--xperf_path', 11:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:08 INFO - 'tests': ['tp5n']}}, 11:56:08 INFO - 'talos.zip': {'path': '', 11:56:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:56:08 INFO - Running post-action listener: _resource_record_post_action 11:56:08 INFO - [mozharness: 2016-08-27 18:56:08.643999Z] Finished populate-webroot step (success) 11:56:08 INFO - [mozharness: 2016-08-27 18:56:08.644089Z] Running create-virtualenv step. 11:56:08 INFO - Running pre-action listener: _resource_record_pre_action 11:56:08 INFO - Running main action method: create_virtualenv 11:56:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:56:08 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 11:56:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:56:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:56:08 INFO - Using real prefix '/usr' 11:56:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:56:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:56:11 INFO - Installing pip.................done. 11:56:11 INFO - Return code: 0 11:56:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:11 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:11 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 11:56:11 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 11:56:11 INFO - Using env: {'DISPLAY': ':0', 11:56:11 INFO - 'HOME': '/home/cltbld', 11:56:11 INFO - 'LANG': 'en_US.UTF-8', 11:56:11 INFO - 'LANGUAGE': 'en_US:en', 11:56:11 INFO - 'LOGNAME': 'cltbld', 11:56:11 INFO - 'MAIL': '/var/mail/cltbld', 11:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:11 INFO - 'MOZ_NO_REMOTE': '1', 11:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:11 INFO - 'NO_EM_RESTART': '1', 11:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:11 INFO - 'PWD': '/builds/slave/test', 11:56:11 INFO - 'SHELL': '/bin/bash', 11:56:11 INFO - 'SHLVL': '1', 11:56:11 INFO - 'TERM': 'linux', 11:56:11 INFO - 'TMOUT': '86400', 11:56:11 INFO - 'USER': 'cltbld', 11:56:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:11 INFO - '_': '/tools/buildbot/bin/python'} 11:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:11 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 11:56:11 INFO - Cleaning up... 11:56:11 INFO - Return code: 0 11:56:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:11 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:11 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 11:56:11 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 11:56:11 INFO - Using env: {'DISPLAY': ':0', 11:56:11 INFO - 'HOME': '/home/cltbld', 11:56:11 INFO - 'LANG': 'en_US.UTF-8', 11:56:11 INFO - 'LANGUAGE': 'en_US:en', 11:56:11 INFO - 'LOGNAME': 'cltbld', 11:56:11 INFO - 'MAIL': '/var/mail/cltbld', 11:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:11 INFO - 'MOZ_NO_REMOTE': '1', 11:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:11 INFO - 'NO_EM_RESTART': '1', 11:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:11 INFO - 'PWD': '/builds/slave/test', 11:56:11 INFO - 'SHELL': '/bin/bash', 11:56:11 INFO - 'SHLVL': '1', 11:56:11 INFO - 'TERM': 'linux', 11:56:11 INFO - 'TMOUT': '86400', 11:56:11 INFO - 'USER': 'cltbld', 11:56:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:11 INFO - '_': '/tools/buildbot/bin/python'} 11:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:11 INFO - Downloading/unpacking psutil>=3.1.1 11:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:13 INFO - Installing collected packages: psutil 11:56:13 INFO - Running setup.py install for psutil 11:56:13 INFO - building 'psutil._psutil_linux' extension 11:56:13 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 11:56:13 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 11:56:13 INFO - building 'psutil._psutil_posix' extension 11:56:13 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 11:56:13 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 11:56:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:14 INFO - Successfully installed psutil 11:56:14 INFO - Cleaning up... 11:56:14 INFO - Return code: 0 11:56:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:56:14 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')]} 11:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:14 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')]} 11:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:14 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:14 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 11:56:14 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 11:56:14 INFO - Using env: {'DISPLAY': ':0', 11:56:14 INFO - 'HOME': '/home/cltbld', 11:56:14 INFO - 'LANG': 'en_US.UTF-8', 11:56:14 INFO - 'LANGUAGE': 'en_US:en', 11:56:14 INFO - 'LOGNAME': 'cltbld', 11:56:14 INFO - 'MAIL': '/var/mail/cltbld', 11:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:14 INFO - 'MOZ_NO_REMOTE': '1', 11:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:14 INFO - 'NO_EM_RESTART': '1', 11:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:14 INFO - 'PWD': '/builds/slave/test', 11:56:14 INFO - 'SHELL': '/bin/bash', 11:56:14 INFO - 'SHLVL': '1', 11:56:14 INFO - 'TERM': 'linux', 11:56:14 INFO - 'TMOUT': '86400', 11:56:14 INFO - 'USER': 'cltbld', 11:56:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:14 INFO - '_': '/tools/buildbot/bin/python'} 11:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:56:16 INFO - Installing collected packages: mozsystemmonitor 11:56:16 INFO - Running setup.py install for mozsystemmonitor 11:56:16 INFO - Successfully installed mozsystemmonitor 11:56:16 INFO - Cleaning up... 11:56:16 INFO - Return code: 0 11:56:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:56: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')]} 11:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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')]} 11:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:16 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:16 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 11:56:16 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 11:56:16 INFO - Using env: {'DISPLAY': ':0', 11:56:16 INFO - 'HOME': '/home/cltbld', 11:56:16 INFO - 'LANG': 'en_US.UTF-8', 11:56:16 INFO - 'LANGUAGE': 'en_US:en', 11:56:16 INFO - 'LOGNAME': 'cltbld', 11:56:16 INFO - 'MAIL': '/var/mail/cltbld', 11:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:16 INFO - 'MOZ_NO_REMOTE': '1', 11:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:16 INFO - 'NO_EM_RESTART': '1', 11:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:16 INFO - 'PWD': '/builds/slave/test', 11:56:16 INFO - 'SHELL': '/bin/bash', 11:56:16 INFO - 'SHLVL': '1', 11:56:16 INFO - 'TERM': 'linux', 11:56:16 INFO - 'TMOUT': '86400', 11:56:16 INFO - 'USER': 'cltbld', 11:56:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:16 INFO - '_': '/tools/buildbot/bin/python'} 11:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:56:16 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 11:56:16 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 11:56:16 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 11:56:16 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 11:56:16 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 11:56:16 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 11:56:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:56:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:56:18 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 11:56:18 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 11:56:18 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 11:56:18 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 11:56:18 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 11:56:18 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 11:56:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:56:18 INFO - warning: no files found matching '*.txt' 11:56:18 INFO - no previously-included directories found matching 'build' 11:56:18 INFO - no previously-included directories found matching 'dist' 11:56:18 INFO - no previously-included directories found matching '.git*' 11:56:18 INFO - Installing collected packages: jsonschema, functools32 11:56:18 INFO - Running setup.py install for functools32 11:56:18 INFO - warning: no files found matching '*.txt' 11:56:18 INFO - no previously-included directories found matching 'build' 11:56:18 INFO - no previously-included directories found matching 'dist' 11:56:18 INFO - no previously-included directories found matching '.git*' 11:56:18 INFO - Successfully installed jsonschema functools32 11:56:18 INFO - Cleaning up... 11:56:18 INFO - Return code: 0 11:56:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:18 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:18 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 11:56:18 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 11:56:19 INFO - Using env: {'DISPLAY': ':0', 11:56:19 INFO - 'HOME': '/home/cltbld', 11:56:19 INFO - 'LANG': 'en_US.UTF-8', 11:56:19 INFO - 'LANGUAGE': 'en_US:en', 11:56:19 INFO - 'LOGNAME': 'cltbld', 11:56:19 INFO - 'MAIL': '/var/mail/cltbld', 11:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:19 INFO - 'MOZ_NO_REMOTE': '1', 11:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:19 INFO - 'NO_EM_RESTART': '1', 11:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:19 INFO - 'PWD': '/builds/slave/test', 11:56:19 INFO - 'SHELL': '/bin/bash', 11:56:19 INFO - 'SHLVL': '1', 11:56:19 INFO - 'TERM': 'linux', 11:56:19 INFO - 'TMOUT': '86400', 11:56:19 INFO - 'USER': 'cltbld', 11:56:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:19 INFO - '_': '/tools/buildbot/bin/python'} 11:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:56:19 INFO - Cleaning up... 11:56:19 INFO - Return code: 0 11:56:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:19 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:19 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 11:56:19 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 11:56:19 INFO - Using env: {'DISPLAY': ':0', 11:56:19 INFO - 'HOME': '/home/cltbld', 11:56:19 INFO - 'LANG': 'en_US.UTF-8', 11:56:19 INFO - 'LANGUAGE': 'en_US:en', 11:56:19 INFO - 'LOGNAME': 'cltbld', 11:56:19 INFO - 'MAIL': '/var/mail/cltbld', 11:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:19 INFO - 'MOZ_NO_REMOTE': '1', 11:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:19 INFO - 'NO_EM_RESTART': '1', 11:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:19 INFO - 'PWD': '/builds/slave/test', 11:56:19 INFO - 'SHELL': '/bin/bash', 11:56:19 INFO - 'SHLVL': '1', 11:56:19 INFO - 'TERM': 'linux', 11:56:19 INFO - 'TMOUT': '86400', 11:56:19 INFO - 'USER': 'cltbld', 11:56:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:19 INFO - '_': '/tools/buildbot/bin/python'} 11:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:56:19 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 11:56:19 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 11:56:19 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 11:56:19 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 11:56:19 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 11:56:19 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 11:56:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:56:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:56:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 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 11:56:21 INFO - Downloading docopt-0.6.1.tar.gz 11:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:56:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:56:22 INFO - Running setup.py install for blobuploader 11:56:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:56:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:56:22 INFO - Running setup.py install for requests 11:56:22 INFO - Running setup.py install for docopt 11:56:22 INFO - Successfully installed blobuploader requests docopt 11:56:22 INFO - Cleaning up... 11:56:22 INFO - Return code: 0 11:56:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:22 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:22 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 11:56:22 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 11:56:22 INFO - Using env: {'DISPLAY': ':0', 11:56:22 INFO - 'HOME': '/home/cltbld', 11:56:22 INFO - 'LANG': 'en_US.UTF-8', 11:56:22 INFO - 'LANGUAGE': 'en_US:en', 11:56:22 INFO - 'LOGNAME': 'cltbld', 11:56:22 INFO - 'MAIL': '/var/mail/cltbld', 11:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:22 INFO - 'MOZ_NO_REMOTE': '1', 11:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:22 INFO - 'NO_EM_RESTART': '1', 11:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:22 INFO - 'PWD': '/builds/slave/test', 11:56:22 INFO - 'SHELL': '/bin/bash', 11:56:22 INFO - 'SHLVL': '1', 11:56:22 INFO - 'TERM': 'linux', 11:56:22 INFO - 'TMOUT': '86400', 11:56:22 INFO - 'USER': 'cltbld', 11:56:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:22 INFO - '_': '/tools/buildbot/bin/python'} 11:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:22 INFO - Running setup.py (path:/tmp/pip-gRXUw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:22 INFO - Running setup.py (path:/tmp/pip-Mp1sOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:23 INFO - Running setup.py (path:/tmp/pip-IK6qTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:23 INFO - Running setup.py (path:/tmp/pip-PNwX5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:23 INFO - Running setup.py (path:/tmp/pip-jiLZBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:23 INFO - Running setup.py (path:/tmp/pip-AnSkB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:23 INFO - Running setup.py (path:/tmp/pip-eBrVe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:23 INFO - Running setup.py (path:/tmp/pip-THrCKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:23 INFO - Running setup.py (path:/tmp/pip-acGCAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:23 INFO - Running setup.py (path:/tmp/pip-ot2_KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:23 INFO - Running setup.py (path:/tmp/pip-wWOUmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:23 INFO - Running setup.py (path:/tmp/pip-6UIpA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:23 INFO - Running setup.py (path:/tmp/pip-nRo0sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:23 INFO - Running setup.py (path:/tmp/pip-oEF8Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:23 INFO - Running setup.py (path:/tmp/pip-zhlKvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:23 INFO - Running setup.py (path:/tmp/pip-56XeqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:24 INFO - Running setup.py (path:/tmp/pip-DdOg5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:56:24 INFO - Running setup.py install for manifestparser 11:56:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Running setup.py install for mozcrash 11:56:24 INFO - Running setup.py install for mozdebug 11:56:24 INFO - Running setup.py install for mozdevice 11:56:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Running setup.py install for mozfile 11:56:24 INFO - Running setup.py install for mozhttpd 11:56:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Running setup.py install for mozinfo 11:56:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Running setup.py install for mozInstall 11:56:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:56:24 INFO - Running setup.py install for mozleak 11:56:24 INFO - Running setup.py install for mozlog 11:56:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Running setup.py install for moznetwork 11:56:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Running setup.py install for mozprocess 11:56:25 INFO - Running setup.py install for mozprofile 11:56:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Running setup.py install for mozrunner 11:56:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Running setup.py install for mozscreenshot 11:56:25 INFO - Running setup.py install for moztest 11:56:25 INFO - Running setup.py install for mozversion 11:56:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:56:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:56:25 INFO - Cleaning up... 11:56:25 INFO - Return code: 0 11:56:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:25 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:25 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 11:56:25 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 11:56:25 INFO - Using env: {'DISPLAY': ':0', 11:56:25 INFO - 'HOME': '/home/cltbld', 11:56:25 INFO - 'LANG': 'en_US.UTF-8', 11:56:25 INFO - 'LANGUAGE': 'en_US:en', 11:56:25 INFO - 'LOGNAME': 'cltbld', 11:56:25 INFO - 'MAIL': '/var/mail/cltbld', 11:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:25 INFO - 'MOZ_NO_REMOTE': '1', 11:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:25 INFO - 'NO_EM_RESTART': '1', 11:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:25 INFO - 'PWD': '/builds/slave/test', 11:56:25 INFO - 'SHELL': '/bin/bash', 11:56:25 INFO - 'SHLVL': '1', 11:56:25 INFO - 'TERM': 'linux', 11:56:25 INFO - 'TMOUT': '86400', 11:56:25 INFO - 'USER': 'cltbld', 11:56:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:25 INFO - '_': '/tools/buildbot/bin/python'} 11:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:56:26 INFO - Running setup.py (path:/tmp/pip-emq5iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:56:26 INFO - Running setup.py (path:/tmp/pip-3F6_vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:56:26 INFO - Running setup.py (path:/tmp/pip-giM9Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:56:26 INFO - Running setup.py (path:/tmp/pip-rycYhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:56:26 INFO - Running setup.py (path:/tmp/pip-ZxN0Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:56:26 INFO - Running setup.py (path:/tmp/pip-NQS6oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:56:26 INFO - Running setup.py (path:/tmp/pip-i7pXH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:56:26 INFO - Running setup.py (path:/tmp/pip-lnpvoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:56:26 INFO - Running setup.py (path:/tmp/pip-w_0Is8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:56:26 INFO - Running setup.py (path:/tmp/pip-xYz2kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:56:26 INFO - Running setup.py (path:/tmp/pip-XNXGSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:56:26 INFO - Running setup.py (path:/tmp/pip-8MuJGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:56:26 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)) 11:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:56:26 INFO - Running setup.py (path:/tmp/pip-WlK6z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:56:27 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)) 11:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:56:27 INFO - Running setup.py (path:/tmp/pip-Uixle_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:56:27 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)) 11:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:27 INFO - Running setup.py (path:/tmp/pip-QbufDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:56:27 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)) 11:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:56:27 INFO - Running setup.py (path:/tmp/pip-WllSY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:56:27 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)) 11:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:56:27 INFO - Running setup.py (path:/tmp/pip-PPEPWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:56:27 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)) 11:56:27 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)) 11:56:27 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)) 11:56:27 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)) 11:56:27 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)) 11:56:27 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)) 11:56:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:29 INFO - Downloading blessings-1.6.tar.gz 11:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:56:29 INFO - Installing collected packages: blessings 11:56:29 INFO - Running setup.py install for blessings 11:56:29 INFO - Successfully installed blessings 11:56:29 INFO - Cleaning up... 11:56:29 INFO - Return code: 0 11:56:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:29 INFO - Reading from file tmpfile_stdout 11:56:29 INFO - Current package versions: 11:56:29 INFO - argparse == 1.2.1 11:56:29 INFO - blessings == 1.6 11:56:29 INFO - blobuploader == 1.2.4 11:56:29 INFO - docopt == 0.6.1 11:56:29 INFO - functools32 == 3.2.3-2 11:56:29 INFO - jsonschema == 2.5.1 11:56:29 INFO - manifestparser == 1.1 11:56:29 INFO - mozInstall == 1.12 11:56:29 INFO - mozcrash == 0.17 11:56:29 INFO - mozdebug == 0.1 11:56:29 INFO - mozdevice == 0.48 11:56:29 INFO - mozfile == 1.2 11:56:29 INFO - mozhttpd == 0.7 11:56:29 INFO - mozinfo == 0.9 11:56:29 INFO - mozleak == 0.1 11:56:29 INFO - mozlog == 3.3 11:56:29 INFO - moznetwork == 0.27 11:56:29 INFO - mozprocess == 0.23 11:56:29 INFO - mozprofile == 0.28 11:56:29 INFO - mozrunner == 6.12 11:56:29 INFO - mozscreenshot == 0.1 11:56:29 INFO - mozsystemmonitor == 0.3 11:56:29 INFO - moztest == 0.7 11:56:29 INFO - mozversion == 1.4 11:56:29 INFO - psutil == 3.1.1 11:56:29 INFO - requests == 1.2.3 11:56:29 INFO - wsgiref == 0.1.2 11:56:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:29 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 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:29 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 11:56:29 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 11:56:29 INFO - Using env: {'DISPLAY': ':0', 11:56:29 INFO - 'HOME': '/home/cltbld', 11:56:29 INFO - 'LANG': 'en_US.UTF-8', 11:56:29 INFO - 'LANGUAGE': 'en_US:en', 11:56:29 INFO - 'LOGNAME': 'cltbld', 11:56:29 INFO - 'MAIL': '/var/mail/cltbld', 11:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:29 INFO - 'MOZ_NO_REMOTE': '1', 11:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:29 INFO - 'NO_EM_RESTART': '1', 11:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:29 INFO - 'PWD': '/builds/slave/test', 11:56:29 INFO - 'SHELL': '/bin/bash', 11:56:29 INFO - 'SHLVL': '1', 11:56:29 INFO - 'TERM': 'linux', 11:56:29 INFO - 'TMOUT': '86400', 11:56:29 INFO - 'USER': 'cltbld', 11:56:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:29 INFO - '_': '/tools/buildbot/bin/python'} 11:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 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)) 11:56:30 INFO - Cleaning up... 11:56:30 INFO - Return code: 0 11:56:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d43045f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x226d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, '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': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', '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 11:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:56:30 INFO - Using env: {'DISPLAY': ':0', 11:56:30 INFO - 'HOME': '/home/cltbld', 11:56:30 INFO - 'LANG': 'en_US.UTF-8', 11:56:30 INFO - 'LANGUAGE': 'en_US:en', 11:56:30 INFO - 'LOGNAME': 'cltbld', 11:56:30 INFO - 'MAIL': '/var/mail/cltbld', 11:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:30 INFO - 'MOZ_NO_REMOTE': '1', 11:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:30 INFO - 'NO_EM_RESTART': '1', 11:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:30 INFO - 'PWD': '/builds/slave/test', 11:56:30 INFO - 'SHELL': '/bin/bash', 11:56:30 INFO - 'SHLVL': '1', 11:56:30 INFO - 'TERM': 'linux', 11:56:30 INFO - 'TMOUT': '86400', 11:56:30 INFO - 'USER': 'cltbld', 11:56:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:30 INFO - '_': '/tools/buildbot/bin/python'} 11:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:56:30 INFO - Cleaning up... 11:56:30 INFO - Return code: 0 11:56:30 INFO - Running post-action listener: _resource_record_post_action 11:56:30 INFO - Running post-action listener: _start_resource_monitoring 11:56:30 INFO - Starting resource monitoring. 11:56:30 INFO - [mozharness: 2016-08-27 18:56:30.328922Z] Finished create-virtualenv step (success) 11:56:30 INFO - [mozharness: 2016-08-27 18:56:30.329429Z] Running install step. 11:56:30 INFO - Running pre-action listener: _resource_record_pre_action 11:56:30 INFO - Running main action method: install 11:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:56:30 INFO - Reading from file tmpfile_stdout 11:56:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:56:30 INFO - Reading from file tmpfile_stdout 11:56:30 INFO - Output received: 11:56:30 INFO - Usage: mozinstall [options] installer 11:56:30 INFO - Options: 11:56:30 INFO - -h, --help show this help message and exit 11:56:30 INFO - -d DEST, --destination=DEST 11:56:30 INFO - Directory to install application into. [default: 11:56:30 INFO - "/builds/slave/test"] 11:56:30 INFO - --app=APP Application being installed. [default: firefox] 11:56:30 INFO - mkdir: /builds/slave/test/build/application 11:56:30 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'] 11:56:30 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 11:56:46 INFO - Reading from file tmpfile_stdout 11:56:46 INFO - Output received: 11:56:46 INFO - /builds/slave/test/build/application/firefox/firefox 11:56:46 INFO - Running post-action listener: _resource_record_post_action 11:56:46 INFO - [mozharness: 2016-08-27 18:56:46.735201Z] Finished install step (success) 11:56:46 INFO - [mozharness: 2016-08-27 18:56:46.735480Z] Running run-tests step. 11:56:46 INFO - Running pre-action listener: _resource_record_pre_action 11:56:46 INFO - Running main action method: run_tests 11:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:46 INFO - Python 2.7.3 11:56:46 INFO - Return code: 0 11:56:46 INFO - grabbing minidump binary from tooltool 11:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:46 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 0x2267090>, '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 0x226a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:46 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 11:56:46 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 11:56:46 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 11:56:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:46 INFO - Return code: 0 11:56:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:56:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:56:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:46 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/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:56:46 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/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 11:56:46 INFO - Using env: {'DISPLAY': ':0', 11:56:46 INFO - 'HOME': '/home/cltbld', 11:56:46 INFO - 'LANG': 'en_US.UTF-8', 11:56:46 INFO - 'LANGUAGE': 'en_US:en', 11:56:46 INFO - 'LOGNAME': 'cltbld', 11:56:46 INFO - 'MAIL': '/var/mail/cltbld', 11:56:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:46 INFO - 'MOZ_NO_REMOTE': '1', 11:56:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:46 INFO - 'NO_EM_RESTART': '1', 11:56:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:46 INFO - 'PWD': '/builds/slave/test', 11:56:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:46 INFO - 'SHELL': '/bin/bash', 11:56:46 INFO - 'SHLVL': '1', 11:56:46 INFO - 'TERM': 'linux', 11:56:46 INFO - 'TMOUT': '86400', 11:56:46 INFO - 'USER': 'cltbld', 11:56:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615', 11:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:46 INFO - '_': '/tools/buildbot/bin/python'} 11:56:46 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/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:56:47 INFO - mozversion application_buildid: 20160827105213 11:56:47 INFO - mozversion application_changeset: 125b052639cb1879d4a593c715d244c551129118 11:56:47 INFO - mozversion application_display_name: Nightly 11:56:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:47 INFO - mozversion application_name: Firefox 11:56:47 INFO - mozversion application_remotingname: firefox 11:56:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:56:47 INFO - mozversion application_vendor: Mozilla 11:56:47 INFO - mozversion application_version: 51.0a1 11:56:47 INFO - mozversion platform_buildid: 20160827105213 11:56:47 INFO - mozversion platform_changeset: 125b052639cb1879d4a593c715d244c551129118 11:56:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:56:47 INFO - mozversion platform_version: 51.0a1 11:56:47 INFO - using testdate: 1472324207 11:56:47 INFO - actual date: 1472324207 11:56:47 INFO - starting webserver on 'localhost:42475' 11:56:47 INFO - SUITE-START | Running 2 tests 11:56:47 INFO - TEST-START | dromaeo_css 11:56:47 INFO - operating with platform_type : linux_ 11:56:47 INFO - Initialising browser for dromaeo_css test... 11:56:47 INFO - TEST-INFO | started process 7187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqmyvZ/profile http://localhost:42475/getInfo.html) 11:56:51 INFO - PROCESS | 7187 | __metrics Screen width/height:1600/1200 11:56:51 INFO - PROCESS | 7187 | colorDepth:24 11:56:51 INFO - PROCESS | 7187 | Browser inner width/height: 1024/697 11:56:51 INFO - PROCESS | 7187 | __metrics 11:56:52 INFO - PROCESS | 7187 | 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" 11:56:52 INFO - PROCESS | 7187 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:52 INFO - PROCESS | 7187 | console.error: PushService: 11:56:52 INFO - PROCESS | 7187 | stateChangeProcessEnqueue: Error transitioning state 11:56:52 INFO - PROCESS | 7187 | UnknownError 11:56:53 INFO - TEST-INFO | 7187: exit 0 11:56:53 INFO - Browser initialized. 11:56:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:53 INFO - TEST-INFO | started process 7270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWqmyvZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:05 INFO - PROCESS | 7270 | RSS: Main: 182198272 11:57:05 INFO - PROCESS | 7270 | 11:57:56 INFO - PROCESS | 7270 | 1472324276805 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] 12:00:10 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42475/tests/dromaeo/cssquery-ext.html) 12:00:11 INFO - PROCESS | 7270 | RSS: Main: 313036800 12:00:11 INFO - PROCESS | 7270 | 12:03:14 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-ext.html (next: http://localhost:42475/tests/dromaeo/cssquery-jquery.html) 12:03:15 INFO - PROCESS | 7270 | RSS: Main: 273309696 12:03:15 INFO - PROCESS | 7270 | 12:06:17 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42475/tests/dromaeo/cssquery-mootools.html) 12:06:17 INFO - PROCESS | 7270 | RSS: Main: 230895616 12:06:17 INFO - PROCESS | 7270 | 12:09:20 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42475/tests/dromaeo/cssquery-prototype.html) 12:09:20 INFO - PROCESS | 7270 | RSS: Main: 235024384 12:09:20 INFO - PROCESS | 7270 | 12:12:23 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42475/tests/dromaeo/cssquery-yui.html) 12:12:24 INFO - PROCESS | 7270 | RSS: Main: 220008448 12:12:24 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | Cycle 1(1): loaded http://localhost:42475/tests/dromaeo/cssquery-yui.html (next: http://localhost:42475/tests/dromaeo/cssquery-dojo.html) 12:15:27 INFO - PROCESS | 7270 | RSS: Main: 308883456 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | __start_tp_report 12:15:27 INFO - PROCESS | 7270 | _x_x_mozilla_page_load 12:15:27 INFO - PROCESS | 7270 | _x_x_mozilla_page_load_details 12:15:27 INFO - PROCESS | 7270 | |i|pagename|runs| 12:15:27 INFO - PROCESS | 7270 | |0;dojo.html;2624.7768939640127;2625.291171383725;2629.395239095008;2669.7730692891114;2690.582959641255;4614.400127983366;4691.765411729417;4707.152712511746;4745.122152401808;4874.829380971667;4724.7401392923375;4732.90534189316;4752.287156926463;4765.380500534934;4788.880277993052;4348.717333373336;4378.233809083397;4418.270985287424;4419.602235798778;4465.933011004838;4428.136513379892;4431;4455.042165934324;4465.799039043251;4466.776661166945;4368.49762277339;4421.9336709949375;4425.203463376591;4425.291953287475;4461.130079634472;4222.408862759216;4253.29820579604;4254.0641058967285;4312.482502099737;4399.912001759979;4266.338717498793;4297.4413326267695;4367.58507941745;4387.714798538085;4416.050549131952;4654.976725116387;4659.6505262105475;4679.953200467986;4682.578567928903;4719.103370359655;5093.337866077386;5094.566961808251;5104.081265372231;5106.770195341219;5106.821261255838;4996.875078123039;5098.643094983353;5156.097682905476;5189.506996835333;5197.272381866504;4776.8566942991765;4812.422509298836;4818.903621927542;4821.63837712173;4824.059308434892;5293.57651387888;5302.098643230583;5309.7170193628945;5319.707416092152;5375.75809088592;4925.655204135748;5010.048090862724;5062.696238225718;5066.493350664978;5096.184610462383;5090.694558326512;5119.846404607868;5122.641415100981;5126.410462796752;5131.384233891882;5077.289179514871;5080.796768129233;5083.313752643346;5089.720065396365;5123.385193776696;4874.7562621868765;4916.5575098240615;5004.574611158019;5045.091883460939;5054.848354549369;4310.6335961443;4316.913661726748;4324.3513472978675;4367.912641747147;4370.235208838504;3752.9249415011545;3758.4550240215017;3774.0564858785306;3810.657040866335;3813.161104556993;4248.4477017987465;4370.584794444522;4386.188555117314;4424.181526417623;4433.82264709408;5136.691798492103;5164.741762911839;5171.043356978971;5173.715445650525;5223.52988231061;4418.381426600278;4420.447444069491;4423.933640995323;4464.620507256919;4480.798364073625;4516.728996260234;4518.615917646971;4535.229011068126;4556.29377446503;4620.399348084795;4769.809207631656;4788.066327066189;4794.089123066607;4835.105505481497;4843.927341089816;5093.414257360451;5101.158308878993;5102;5104.923426148685;5110.97444512775;4598.172328980681;4683.812647494062;4711.293306004127;4822.300766388784;4838.951610483991;4977.054359671651;5002.324686167321;5011.148104822116;5027.597792176544;5080.7205603692155;5058.595312375075;5060.645754797276;5062.569681577107;5066.290719299227;5118.078745825787;4791.544803243686;4910.361652985089;4936.308916751729;4974.452810190948;4977.502249775139;4991.226359914219;4992.326035985096;4992.475790042138;4993.126202914548;5021.096202683552;4963.503649635008;4963.900721985612;4964.081644895706;4966.304717339648;4980.277859710394;4908.631852610997;4943.826966056171;4967.577755890789;5017.2724954880605;5020.874478138076;4837.830675926326;4856.490068542894;4886.364772579542;4897.804087836446;4901.044296362175 12:15:27 INFO - PROCESS | 7270 | |1;ext.html;559.353946192148;563.0962305499673;573.9655620662761;579.9072148456247;587.955903307252;27323.863380683095;38620.806895965514;40011.59988400119;40090.398644020366;43683.78158109213;40606.18787624253;40969.59030409695;41107;41144;41217.17565648693;7640.274173953466;7792;7793.415493837956;7793.844123117534;7797.454178207528;7586.810329741746;7661.885071723928;7672.424568157383;7673.769786906401;7677.884831727529;7665.233476652346;7705.922940770604;7710.306072453478;7711.961440192819;7712.614369281541;7593.468457207998;7629.084509858797;7634.618269086552;7662.808429789272;7680.615969201517;7664.73173438927;7720.806979825549;7726.845463090763;7728.845423091563;7731.381489480828;37462.25075498502;37855.432168517495;37910.62089379126;37919.431208531896;37942;2951.4834903891733;2971.762259019273;2976.419598178356;2979.344544200294;3011.111722042003;28013.159605211877;28080.85959570189;28083;28182.436351273063;28837.855810720812;3211.5556438002486;3291.7202037826814;3301.7523685723427;3328.284418849959;3359.1434184283094;173731;173870;173886;173903;173941.130294349;49119.26321105186;49449;49459.50540494621;49545;49561;31796;32867.83566082154;32991.175220619196;51902;51932.74033629883;12226.694332641755;12243.387830608433;12245.448954797055;12247.387630618612;12259.325737084368;10077.647282345082;10119.747006324753;10135.797284054424;10143.695689129338;10147.238957078249;17547.912260438872;17602.559936001704;17625.206865691074;17767.644647107245;17809.376671816422;6693.431058360094;6841.692123854438;6861.378769487369;6883.414909732729;6887.7244910203035;762.8588711088355;819.2626636027504;856.3876828067837;875.6497401039635;919.6551293265026;25489.362765931;25567.488650226893;26712.93148274086;26808.195754127406;27030.729692703215;938.7653086728318;947.2800671489717;947.3415975896686;964.8986856380119;971.5627967414691;14113.506027288995;14349;14362.85637143636;14493.130412175304;14498.275086245856;365313;369718;371163;371328;371623;48396.51603483991;49041.509584903695;49048.509514905105;49050;49069.75465122652;1169.6081812592877;1205.3310412720848;1212.5998420521207;1219.3781171602548;1219.536576101076;25268.368290792878;26138.215853524423;26415.339616508973;27329.453410932067;27487.45025099527;41647.37528937008;41928.790356048026;41983.580164199186;42022.78988605038;42113.57886421097;321902;322876;323588;323718;324154;24870.875645621658;25183.496330073664;25200.243992680247;25224.24327270185;25238.621420678337;40924.38613420861;41052;41867;41873;42017.369739454545;34317.48523772095;34493.65506344904;34624.82687586546;34647.82676086603;34825.12937176591;34385;34431.65568344285;34506;34603;35106.29787404186;34244.48633270453;35037.47443788396;35138.648613513535;35242.29515409626;35298.47052294269;28631.713682862905;31495.84252078725;31727.682723173395;31750;32065.67934320627;24421.75578244266;24602.630960535247;24640.2095507552;24741.50516989614;25245.873770631028 12:15:27 INFO - PROCESS | 7270 | |2;jquery.html;338.66810525684815;363.95086663300447;364.4897143998403;365.31685747651886;377.93197224499596;12489.313087780169;16044.031854106985;16260.349586016575;17524.21141048653;17673.469795906112;13971.301434928264;14179.43282268708;16024.43914462994;16320.183990800471;16405.753913691275;5685;5693.459121383472;5815.651060936336;5881.088431293157;5970.6119102258435;3906.2187562487475;4119.196756632457;5828.2131912191735;5859.9414005860035;5873.70631468427;4038.232735780207;4162.646175075107;4170.97914510427;6978.581285122909;6991.881298992163;6751.122354093985;7073.328033836778;7075.929240707578;7080.433565314763;7080.893786593179;6699.229588597325;6722.798316050526;6726.697298621574;6731.12495375603;6731.192256929151;21945.231916882993;22709.659355109685;22743;23587.41031474227;23692;1794.7397627344092;1906.8760530565607;1915.808419158087;1947.0848701110456;2372.8694921779297;13781.724365512733;14183.78724319136;14343.497977570734;15211.467598633995;15327.463538776201;1862.5064357945155;1865.2911893480525;1878.7181922711702;1894.7536820213284;1922.9807701922941;64729.67635161794;67783.66108169477;72557;77528;86056;16005.439809606607;16320.510384688478;16399;16489.257983390777;16921.915390422968;28854.27864303367;28932.27669308284;29004.41991160165;29008.12975610735;29143.85428072846;8744.562771861381;8799.956000220085;8851.291896648381;9056.411333263317;9141.131592498701;7029.507934444539;7143.749968751173;7324.816879577947;7325.633718314063;7394.7781566553085;8254.8349033019;8309.335253179852;8392.622331995075;8435.95782021086;8598.828023439497;3180.6183258009187;3190.170555655546;3230.2247460609283;3284.638689744126;3312.585926759155;731.9926800731924;798.1738900238341;826.6404114210337;866.1295398124844;875.5753459572103;15909.499910019777;16147;16492.505224843273;16638.75041874373;17280.740788888175;803.3091541274499;817.3297895725567;817.9059408168137;821.34292565947;856.1395797223751;7610.657520411595;9163.108709282595;9416.482093484925;9434.858477122849;9448.574814133242;373556;379253;379467;383167;390574;76874;77696.61151694205;78260;78435.8987115078;80740.59629701814;868.1275318305063;874.3791907745444;879.4371602174741;899.3389858454032;916.6654171227588;14259.64350891236;14624.122552646875;14746.410143594136;15015.988785400858;15133.770120199431;38192.42711359276;38330.23339533249;38715.80642096772;39604.60395396009;39907.2018559633;51015;52667.473325266255;52720.209196862845;52788.736056319474;54686.17970730363;7472;7773.572453515111;7791.220877912164;7945.682172713026;8291.502509849428;11402.885971140182;11724.648260552198;11836.76326473483;12194.451249693962;12316.876831231573;10026.298159128792;10226.795464090825;10271.435071071162;10680.252382333472;10742.409167495864;9890;10340.689779306633;10364.170866330825;10635.308704934154;10706.250562460553;9893.50532473359;10110.646127385506;10137.239707021856;10465.738356541147;10625.840612390975;7505.174430812715;7709.421793365408;7767.456278060482;7772.7668169954995;7918.326942209977;8819.955900220459;9198.632054717737;9749.415035097632;10327.225458090523;10516.842247366449 12:15:27 INFO - PROCESS | 7270 | |3;mootools.html;1200.3698058519271;1348.6695759538914;1375.8486566477686;1445.299029970464;1690.5097521718703;6799;7149.857002859946;7200.459965502589;7208.747693830717;7324.853502929938;6980.162380514345;7109.182444018939;7179.174394944583;7255.238199989004;7258.455615828808;2150.817180539652;2211.3365990202956;2212.1151539384214;2214.767449417804;2219.5671843990426;2127.4574983379293;2171.522265101675;2172.7935846094597;2177.074743234119;2177.3032629558547;2150.129197674936;2161.8810965396897;2171.9348419547437;2174.423777698911;2188.4966457714654;2111.68324751287;2114.524232047777;2115.2279418012313;2129.9254526091668;2132.040581738216;2040.8775473471492;2107.030765847697;2125.787421257877;2132.2430537159394;2139.368886178581;7095.8226044348785;7241.348278654894;7316.341529262339;7333.083364579427;7340.26597340267;4361.323994780814;4464.910701785946;4482.775861206959;4486.573775491323;4490.932636010462;2630.4476060027228;2771.8198317109322;2794.3014246438393;2794.9161525154277;2816.830990140578;921.9262459003263;937.236152535688;950.2682934140742;952.5189779161549;953.5565961827783;10358.896411035868;10548.05067543917;10558.1025612823;10570.154387649047;10588.78822423555;3884.2231553689376;3984.2429938312207;4173.7078404512;4183.916321673611;4272.6795490338345;8987.370884038186;8999.505027223435;9000.8649870252;9007.594658240396;9013.684521041732;4628.143793398165;4637.373954516097;4639.559241872017;4648.651351148677;4650;3647.6717095461536;3891.552471465761;4000.8999775005277;4239.3429018501565;4239.851605193803;3543.94684079739;3544.627814079536;3658.1951970566433;3684.7420680552104;3692.3353796316383;1186.9762604747857;1201.4533387308754;1211.3943028485758;1216.4890745886748;1226.1294480918468;778.8208711996273;785.8271180340316;800.4356928365488;801.8035581282624;812.3947658994088;4670.322803193518;4702.15361234981;4781.354517140142;4866.270059491105;5151.639385242997;412.5606229365716;413.3015204304775;414.84235990323486;418.7403809637983;419.7208856110713;3417.2482053948092;3441.4149594568985;3523.9119022024656;3524.84138213781;3645.708343332527;8720.912790872137;9251.028641992629;9336.626534938663;9358.344915855825;9381.718548443558;9019.549022548847;9043.32175086871;9043.68347107848;9061.954690226507;9296.39573427725;7080.822979425556;7140.357367836816;7144.499885008104;7173.569585824867;7177.712891484387;4869.391326084239;4869.902601947871;4874.147024270809;4916.164252077084;5176.663516871391;8311.584420778816;8373.246407823324;8477.61850716707;8547.102554231717;8601.655933762579;8549.829003420022;8605.397622166389;8611.913880861362;8801.647934082821;8819.426737262058;5904.498117660047;6510.47916166715;6551.672416379067;6584.50616203777;6855.4172895304455;6853.760118395832;7170.1754298256365;7179.569225846466;7180.210176880643;7182.8563428730085;6254.186955695731;6337.112804207322;6361.61830290184;6369.7452101915405;6399.296077431386;6196.597221180609;6325.525585581007;6350.714217860115;6400.359964003563;6418.518611104092;5591.30108736408;5711.600187986967;5737.196792448977;5754.539636829128;5764.0201165802755;4232.32282834745;4233.301505251722;4241.87274381769;4260.573942605714;4450.46594408673;4301.397804307462;4351.673624478113;4409.404730361489;4506.278995360726;4573.474050484237 12:15:27 INFO - PROCESS | 7270 | |4;prototype.html;285.1644681084422;293.3751110135412;296.86047557647925;300.6962967402923;300.9984950075249;4680.391549098621;4742.312364707115;4774.498677638841;4820.084184005041;4848.539388758067;4705.552972467619;4749.430068391789;4753.239481682931;4754.6434017448655;4812.5321776858045;3806.619338066199;3833.5591406988133;3838.1747924196293;3843.961560384402;3859.2281543691233;3579.5704515458183;3799.1072098056934;3813.199228162089;3814.2180852925085;3856.768593884362;3613.7109031277437;3738.8130593470355;3772.547294324685;3775.62243775623;3776.111274874723;3725.2549490102087;3751.174741556853;3769.6984241260634;3771.4537039813545;3777.7922214278206;3314.4696848504122;3326.866925322984;3334.0164651427885;3336.7497437692027;3337.916552086193;4552.704074235197;4677.251639737626;4687.343771871941;4719.5044520325555;4726.929096063562;4279.700420970534;4283.1433713257165;4285.5071666758095;4289.806958686867;4296;4959.256111583255;5009.323741294951;5011.824586139504;5013.674111182761;5016.347874776292;3368.562086928708;3619.113317237294;3629.727770417203;3635.72732045095;3638.490611314418;5214.713190774506;5215.843524694227;5232.607554433433;5235.633505654606;5286.894262114774;3642.1987162824134;3647.2887786881834;3672.137047793766;3674.3018826422895;3675.209829886587;3715.3498137825773;3723.9813800930824;3726.6459686329754;3737.3272810893754;3753.793541355252;4156.958430415718;4198.6221240088535;4217.683673724483;4231.915361692749;4280.978595107004;4985.8005679772405;4997.000599880039;5004.371830422914;5008.248762685554;5015.27278544609;1208.6917835951776;1246.5512415530402;1272.408330126477;1283.1980012492193;1288.903332250085;865.9783505412415;879.5426378283257;881.4579033894237;885.9955700221586;887.7469921072463;4454.710443821141;4471.686981911235;4477.328400739915;4481.417415735934;4498.955010449919;5193.169092945111;5201.817936372285;5201.921971170435;5209;5218.947810521922;4340.739555626673;4447.310666846644;4448.7108337957925;4461.754603496839;4466.173757854807;2434.403571125086;2441.8901149448316;2451.3626457121277;2452.8160387970975;2465.3343597229004;4341.261985462479;4367.410399596078;4370.934435983463;4376.8182590700335;4383.7588932609015;4364.541723119027;4682.391289132459;4689.038747056913;4696.342512048316;4703.600193983481;4315.223259813264;4320.567943205654;4330.751936047964;4334.4798624165305;4344.174606824757;4517.819287228474;4555.954440455553;4559.17934771731;4587.288970209623;4590.196715574828;4224.55642157569;4421.712588681726;4467.240569103195;4472.239719247801;4476.358948220565;4295.539516564383;4304.311310190355;4308.956910430856;4334.674899382496;4347.847825326098;3322.9667703322657;3353.312570923004;3373.8313084345195;3379.7157080309325;3385.356782211372;4412;4588.449386073693;4588.839390621446;4589.816407343669;4623.398958135421;4272.87181384559;4370.956290437182;4371.115064057707;4383.583559561836;4406.625436837905;4374.693771435969;4376.096398066851;4388.956110438855;4390.758508282075;4419.823207071681;4319;4330.350447432785;4346.456692913386;4578.88552786183;4658.627309815139;4995.276629562795;5026.673266237683;5027.667668068038;5035.345405097314;5045.520675535819;4857.392825896763;4877.146684259958;4931.482194369683;4937.01259748059;4939.876503087452 12:15:27 INFO - PROCESS | 7270 | |5;yui.html;571.9056355701309;649.3441623959801;674.4941294029478;718.3427164144808;730.1603156370173;13984.440622375105;14712.411503539859;14761.114333139993;14779.556613301591;14790.038647487905;14062.507812226575;14190.43238270468;14194.36125374358;14195.574132776008;14197.645058873508;616.7563812294142;736.3667246168291;751.7519218657843;761.7828918758155;779.8908152858604;762.0208032678009;770.5299767142039;770.9074911010687;771.032354395236;771.1786946901532;814.42989907065;815.5269943432795;815.824597711492;815.8613035783931;815.9877601835977;641.1920979565734;772.5905270206799;792.2829838995718;808.4785313472806;808.7533302342783;579.5218944370911;580.6196941003649;580.6574121268471;580.9564282678774;581.5986968991425;13122.803157952543;13154.079214454992;13169.604911852659;13173.275469849155;13176.604701858863;12078.69803254917;12249.203801752858;12346.38268086601;12753.426095825711;12982.41579128932;9417.90582094177;9484.857727134098;11660.183787134903;11751.764964700744;11897.82153267693;3282.655321191264;3312.0726196664973;3415.64135765746;3481.547398838135;3485.0590340608146;59288.40711592872;59326.40673593252;59649.403505964816;60151.69924150395;60278;9053.954730226307;9193.264538836876;9629;10221.977802219719;10242.385456872462;18522.81477185238;18882.055897205086;18885.43343699691;18894.149763260688;18896.90551547261;6967.407770339477;7057.36483716468;7109.573425594481;7224.422046236288;7313.853722925512;3655.287218992271;3686.5391826021746;3733.2160246348026;3751.0622344413896;3868.1296708240984;2805.761510271609;2903.593496910434;2911.0539074800777;2937.9412411751646;2946.9410611787644;486.41630043946697;489.3907085678282;489.49337435753824;494.8416506717888;495.22002845518455;384.6787932076691;425.58080290913426;433.47332990416794;494.92823540586414;514.7503460821498;6964;7014.684339204748;7561.508501947355;7600.3539699126195;7841.647125879349;498.36209651645953;528.2709860392633;541.9729013549306;542.1380005790811;547.3869266421553;3379.729621630264;3394.575678040245;3419.076849250688;3469.080693616194;3527.4356103023392;101246.49376753217;101247.49376253072;103734;108313;108730;67730.3226967734;69883;70057;82159.58920205361;86283.13716862751;67454.32545674579;70407;71488.99999999897;73658.89752127262;73815.63092184505;6734.259231484435;7595.468317217963;7664.923350766421;7962.203779621991;8034.276915077671;43435.34846977361;43466.34800477932;44531.55468445274;45555.77222113868;45801.770991146164;38290.23419531538;38571.2285754289;39655.206895862495;54900.72549637226;56249;10027.498625068863;10169.440680762333;10225.539850706884;10388.480575971322;10428.58285668595;9963.352382095141;10135.189184865341;10291.897081029094;10445.164386848883;11835.46740396667;10174;10272.691819245434;10303.124234440156;10575.576976920836;11186.440677965906;10508.632197873038;10772.299800512941;10783.676489705322;10823.296485728402;11117.610883619034;10350.792984140426;10409;10959.799866247118;11004.944975275072;11150.219484635998;9039;9379.390339627902;9414.15272625467;9491.715248542554;9501.57242924084;8203.671853126047;8455.154484551496;9200.539973001189;9205.815883682422;9256.583453744463 12:15:27 INFO - PROCESS | 7270 | __end_tp_report 12:15:27 INFO - PROCESS | 7270 | __start_cc_report 12:15:27 INFO - PROCESS | 7270 | _x_x_mozilla_cycle_collect,1140 12:15:27 INFO - PROCESS | 7270 | __end_cc_report 12:15:27 INFO - PROCESS | 7270 | __startTimestamp1472325327970__endTimestamp 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | ------- Summary: start ------- 12:15:27 INFO - PROCESS | 7270 | Number of tests: 6 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#0] dojo.html Cycles:165 Average:4709.69 Median:4835.11 stddev:499.23 (10.3%) stddev-sans-first:473.21 12:15:27 INFO - PROCESS | 7270 | Values: 2624.8 2625.3 2629.4 2669.8 2690.6 4614.4 4691.8 4707.2 4745.1 4874.8 4724.7 4732.9 4752.3 4765.4 4788.9 4348.7 4378.2 4418.3 4419.6 4465.9 4428.1 4431.0 4455.0 4465.8 4466.8 4368.5 4421.9 4425.2 4425.3 4461.1 4222.4 4253.3 4254.1 4312.5 4399.9 4266.3 4297.4 4367.6 4387.7 4416.1 4655.0 4659.7 4680.0 4682.6 4719.1 5093.3 5094.6 5104.1 5106.8 5106.8 4996.9 5098.6 5156.1 5189.5 5197.3 4776.9 4812.4 4818.9 4821.6 4824.1 5293.6 5302.1 5309.7 5319.7 5375.8 4925.7 5010.0 5062.7 5066.5 5096.2 5090.7 5119.8 5122.6 5126.4 5131.4 5077.3 5080.8 5083.3 5089.7 5123.4 4874.8 4916.6 5004.6 5045.1 5054.8 4310.6 4316.9 4324.4 4367.9 4370.2 3752.9 3758.5 3774.1 3810.7 3813.2 4248.4 4370.6 4386.2 4424.2 4433.8 5136.7 5164.7 5171.0 5173.7 5223.5 4418.4 4420.4 4423.9 4464.6 4480.8 4516.7 4518.6 4535.2 4556.3 4620.4 4769.8 4788.1 4794.1 4835.1 4843.9 5093.4 5101.2 5102.0 5104.9 5111.0 4598.2 4683.8 4711.3 4822.3 4839.0 4977.1 5002.3 5011.1 5027.6 5080.7 5058.6 5060.6 5062.6 5066.3 5118.1 4791.5 4910.4 4936.3 4974.5 4977.5 4991.2 4992.3 4992.5 4993.1 5021.1 4963.5 4963.9 4964.1 4966.3 4980.3 4908.6 4943.8 4967.6 5017.3 5020.9 4837.8 4856.5 4886.4 4897.8 4901.0 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#1] ext.html Cycles:180 Average:43935.86 Median:35122.47 stddev:79416.35 (226.1%) stddev-sans-first:79572.35 12:15:27 INFO - PROCESS | 7270 | Values: 559.4 563.1 574.0 579.9 588.0 27323.9 38620.8 40011.6 40090.4 43683.8 40606.2 40969.6 41107.0 41144.0 41217.2 7640.3 7792.0 7793.4 7793.8 7797.5 7586.8 7661.9 7672.4 7673.8 7677.9 7665.2 7705.9 7710.3 7712.0 7712.6 7593.5 7629.1 7634.6 7662.8 7680.6 7664.7 7720.8 7726.8 7728.8 7731.4 37462.3 37855.4 37910.6 37919.4 37942.0 2951.5 2971.8 2976.4 2979.3 3011.1 28013.2 28080.9 28083.0 28182.4 28837.9 3211.6 3291.7 3301.8 3328.3 3359.1 173731.0 173870.0 173886.0 173903.0 173941.1 49119.3 49449.0 49459.5 49545.0 49561.0 31796.0 32867.8 32991.2 51902.0 51932.7 12226.7 12243.4 12245.4 12247.4 12259.3 10077.6 10119.7 10135.8 10143.7 10147.2 17547.9 17602.6 17625.2 17767.6 17809.4 6693.4 6841.7 6861.4 6883.4 6887.7 762.9 819.3 856.4 875.6 919.7 25489.4 25567.5 26712.9 26808.2 27030.7 938.8 947.3 947.3 964.9 971.6 14113.5 14349.0 14362.9 14493.1 14498.3 365313.0 369718.0 371163.0 371328.0 371623.0 48396.5 49041.5 49048.5 49050.0 49069.8 1169.6 1205.3 1212.6 1219.4 1219.5 25268.4 26138.2 26415.3 27329.5 27487.5 41647.4 41928.8 41983.6 42022.8 42113.6 321902.0 322876.0 323588.0 323718.0 324154.0 24870.9 25183.5 25200.2 25224.2 25238.6 40924.4 41052.0 41867.0 41873.0 42017.4 34317.5 34493.7 34624.8 34647.8 34825.1 34385.0 34431.7 34506.0 34603.0 35106.3 34244.5 35037.5 35138.6 35242.3 35298.5 28631.7 31495.8 31727.7 31750.0 32065.7 24421.8 24602.6 24640.2 24741.5 25245.9 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#2] jquery.html Cycles:180 Average:25343.06 Median:21972.72 stddev:63019.19 (286.8%) stddev-sans-first:63168.01 12:15:27 INFO - PROCESS | 7270 | Values: 338.7 364.0 364.5 365.3 377.9 12489.3 16044.0 16260.3 17524.2 17673.5 13971.3 14179.4 16024.4 16320.2 16405.8 5685.0 5693.5 5815.7 5881.1 5970.6 3906.2 4119.2 5828.2 5859.9 5873.7 4038.2 4162.6 4171.0 6978.6 6991.9 6751.1 7073.3 7075.9 7080.4 7080.9 6699.2 6722.8 6726.7 6731.1 6731.2 21945.2 22709.7 22743.0 23587.4 23692.0 1794.7 1906.9 1915.8 1947.1 2372.9 13781.7 14183.8 14343.5 15211.5 15327.5 1862.5 1865.3 1878.7 1894.8 1923.0 64729.7 67783.7 72557.0 77528.0 86056.0 16005.4 16320.5 16399.0 16489.3 16921.9 28854.3 28932.3 29004.4 29008.1 29143.9 8744.6 8800.0 8851.3 9056.4 9141.1 7029.5 7143.7 7324.8 7325.6 7394.8 8254.8 8309.3 8392.6 8436.0 8598.8 3180.6 3190.2 3230.2 3284.6 3312.6 732.0 798.2 826.6 866.1 875.6 15909.5 16147.0 16492.5 16638.8 17280.7 803.3 817.3 817.9 821.3 856.1 7610.7 9163.1 9416.5 9434.9 9448.6 373556.0 379253.0 379467.0 383167.0 390574.0 76874.0 77696.6 78260.0 78435.9 80740.6 868.1 874.4 879.4 899.3 916.7 14259.6 14624.1 14746.4 15016.0 15133.8 38192.4 38330.2 38715.8 39604.6 39907.2 51015.0 52667.5 52720.2 52788.7 54686.2 7472.0 7773.6 7791.2 7945.7 8291.5 11402.9 11724.6 11836.8 12194.5 12316.9 10026.3 10226.8 10271.4 10680.3 10742.4 9890.0 10340.7 10364.2 10635.3 10706.3 9893.5 10110.6 10137.2 10465.7 10625.8 7505.2 7709.4 7767.5 7772.8 7918.3 8820.0 9198.6 9749.4 10327.2 10516.8 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#3] mootools.html Cycles:180 Average:4910.78 Median:4686.24 stddev:2754.10 (58.8%) stddev-sans-first:2747.70 12:15:27 INFO - PROCESS | 7270 | Values: 1200.4 1348.7 1375.8 1445.3 1690.5 6799.0 7149.9 7200.5 7208.7 7324.9 6980.2 7109.2 7179.2 7255.2 7258.5 2150.8 2211.3 2212.1 2214.8 2219.6 2127.5 2171.5 2172.8 2177.1 2177.3 2150.1 2161.9 2171.9 2174.4 2188.5 2111.7 2114.5 2115.2 2129.9 2132.0 2040.9 2107.0 2125.8 2132.2 2139.4 7095.8 7241.3 7316.3 7333.1 7340.3 4361.3 4464.9 4482.8 4486.6 4490.9 2630.4 2771.8 2794.3 2794.9 2816.8 921.9 937.2 950.3 952.5 953.6 10358.9 10548.1 10558.1 10570.2 10588.8 3884.2 3984.2 4173.7 4183.9 4272.7 8987.4 8999.5 9000.9 9007.6 9013.7 4628.1 4637.4 4639.6 4648.7 4650.0 3647.7 3891.6 4000.9 4239.3 4239.9 3543.9 3544.6 3658.2 3684.7 3692.3 1187.0 1201.5 1211.4 1216.5 1226.1 778.8 785.8 800.4 801.8 812.4 4670.3 4702.2 4781.4 4866.3 5151.6 412.6 413.3 414.8 418.7 419.7 3417.2 3441.4 3523.9 3524.8 3645.7 8720.9 9251.0 9336.6 9358.3 9381.7 9019.5 9043.3 9043.7 9062.0 9296.4 7080.8 7140.4 7144.5 7173.6 7177.7 4869.4 4869.9 4874.1 4916.2 5176.7 8311.6 8373.2 8477.6 8547.1 8601.7 8549.8 8605.4 8611.9 8801.6 8819.4 5904.5 6510.5 6551.7 6584.5 6855.4 6853.8 7170.2 7179.6 7180.2 7182.9 6254.2 6337.1 6361.6 6369.7 6399.3 6196.6 6325.5 6350.7 6400.4 6418.5 5591.3 5711.6 5737.2 5754.5 5764.0 4232.3 4233.3 4241.9 4260.6 4450.5 4301.4 4351.7 4409.4 4506.3 4573.5 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#4] prototype.html Cycles:180 Average:4000.67 Median:4371.04 stddev:1132.92 (25.9%) stddev-sans-first:1101.24 12:15:27 INFO - PROCESS | 7270 | Values: 285.2 293.4 296.9 300.7 301.0 4680.4 4742.3 4774.5 4820.1 4848.5 4705.6 4749.4 4753.2 4754.6 4812.5 3806.6 3833.6 3838.2 3844.0 3859.2 3579.6 3799.1 3813.2 3814.2 3856.8 3613.7 3738.8 3772.5 3775.6 3776.1 3725.3 3751.2 3769.7 3771.5 3777.8 3314.5 3326.9 3334.0 3336.7 3337.9 4552.7 4677.3 4687.3 4719.5 4726.9 4279.7 4283.1 4285.5 4289.8 4296.0 4959.3 5009.3 5011.8 5013.7 5016.3 3368.6 3619.1 3629.7 3635.7 3638.5 5214.7 5215.8 5232.6 5235.6 5286.9 3642.2 3647.3 3672.1 3674.3 3675.2 3715.3 3724.0 3726.6 3737.3 3753.8 4157.0 4198.6 4217.7 4231.9 4281.0 4985.8 4997.0 5004.4 5008.2 5015.3 1208.7 1246.6 1272.4 1283.2 1288.9 866.0 879.5 881.5 886.0 887.7 4454.7 4471.7 4477.3 4481.4 4499.0 5193.2 5201.8 5201.9 5209.0 5218.9 4340.7 4447.3 4448.7 4461.8 4466.2 2434.4 2441.9 2451.4 2452.8 2465.3 4341.3 4367.4 4370.9 4376.8 4383.8 4364.5 4682.4 4689.0 4696.3 4703.6 4315.2 4320.6 4330.8 4334.5 4344.2 4517.8 4556.0 4559.2 4587.3 4590.2 4224.6 4421.7 4467.2 4472.2 4476.4 4295.5 4304.3 4309.0 4334.7 4347.8 3323.0 3353.3 3373.8 3379.7 3385.4 4412.0 4588.4 4588.8 4589.8 4623.4 4272.9 4371.0 4371.1 4383.6 4406.6 4374.7 4376.1 4389.0 4390.8 4419.8 4319.0 4330.4 4346.5 4578.9 4658.6 4995.3 5026.7 5027.7 5035.3 5045.5 4857.4 4877.1 4931.5 4937.0 4939.9 12:15:27 INFO - PROCESS | 7270 | 12:15:27 INFO - PROCESS | 7270 | [#5] yui.html Cycles:180 Average:16869.66 Median:487.90 stddev:24493.33 (5020.1%) stddev-sans-first:24531.47 12:15:27 INFO - PROCESS | 7270 | Values: 571.9 649.3 674.5 718.3 730.2 13984.4 14712.4 14761.1 14779.6 14790.0 14062.5 14190.4 14194.4 14195.6 14197.6 616.8 736.4 751.8 761.8 779.9 762.0 770.5 770.9 771.0 771.2 814.4 815.5 815.8 815.9 816.0 641.2 772.6 792.3 808.5 808.8 579.5 580.6 580.7 581.0 581.6 13122.8 13154.1 13169.6 13173.3 13176.6 12078.7 12249.2 12346.4 12753.4 12982.4 9417.9 9484.9 11660.2 11751.8 11897.8 3282.7 3312.1 3415.6 3481.5 3485.1 59288.4 59326.4 59649.4 60151.7 60278.0 9054.0 9193.3 9629.0 10222.0 10242.4 18522.8 18882.1 18885.4 18894.1 18896.9 6967.4 7057.4 7109.6 7224.4 7313.9 3655.3 3686.5 3733.2 3751.1 3868.1 2805.8 2903.6 2911.1 2937.9 2946.9 486.4 489.4 489.5 494.8 495.2 384.7 425.6 433.5 494.9 514.8 6964.0 7014.7 7561.5 7600.4 7841.6 498.4 528.3 542.0 542.1 547.4 3379.7 3394.6 3419.1 3469.1 3527.4 101246.5 101247.5 103734.0 108313.0 108730.0 67730.3 69883.0 70057.0 82159.6 86283.1 67454.3 70407.0 71489.0 73658.9 73815.6 6734.3 7595.5 7664.9 7962.2 8034.3 43435.3 43466.3 44531.6 45555.8 45801.8 38290.2 38571.2 39655.2 54900.7 56249.0 10027.5 10169.4 10225.5 10388.5 10428.6 9963.4 10135.2 10291.9 10445.2 11835.5 10174.0 10272.7 10303.1 10575.6 11186.4 10508.6 10772.3 10783.7 10823.3 11117.6 10350.8 10409.0 10959.8 11004.9 11150.2 9039.0 9379.4 9414.2 9491.7 9501.6 8203.7 8455.2 9200.5 9205.8 9256.6 12:15:27 INFO - PROCESS | 7270 | -------- Summary: end -------- 12:15:27 INFO - PROCESS | 7270 | 12:15:28 INFO - TEST-INFO | 7270: exit 0 12:15:28 INFO - TEST-OK | dromaeo_css | took 1121982ms 12:15:28 INFO - TEST-START | kraken 12:15:28 INFO - operating with platform_type : linux_ 12:15:28 INFO - Initialising browser for kraken test... 12:15:29 INFO - TEST-INFO | started process 7575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfW00vn/profile http://localhost:42475/getInfo.html) 12:15:33 INFO - PROCESS | 7575 | __metrics Screen width/height:1600/1200 12:15:33 INFO - PROCESS | 7575 | colorDepth:24 12:15:33 INFO - PROCESS | 7575 | Browser inner width/height: 1024/697 12:15:33 INFO - PROCESS | 7575 | __metrics 12:15:33 INFO - PROCESS | 7575 | 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" 12:15:33 INFO - PROCESS | 7575 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:34 INFO - PROCESS | 7575 | console.error: PushService: 12:15:34 INFO - PROCESS | 7575 | stateChangeProcessEnqueue: Error transitioning state 12:15:34 INFO - PROCESS | 7575 | UnknownError 12:15:35 INFO - TEST-INFO | 7575: exit 0 12:15:35 INFO - Browser initialized. 12:15:35 INFO - Running cycle 1/1 for kraken test... 12:15:35 INFO - TEST-INFO | started process 7653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfW00vn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:47 INFO - PROCESS | 7653 | RSS: Main: 181690368 12:15:47 INFO - PROCESS | 7653 | 12:15:50 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42475/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:51 INFO - PROCESS | 7653 | RSS: Main: 235175936 12:15:51 INFO - PROCESS | 7653 | 12:15:53 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42475/tests/kraken/driver.html?testName=audio-dft) 12:15:54 INFO - PROCESS | 7653 | RSS: Main: 225570816 12:15:54 INFO - PROCESS | 7653 | 12:15:57 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42475/tests/kraken/driver.html?testName=audio-fft) 12:15:58 INFO - PROCESS | 7653 | RSS: Main: 304070656 12:15:58 INFO - PROCESS | 7653 | 12:16:00 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42475/tests/kraken/driver.html?testName=audio-oscillator) 12:16:01 INFO - PROCESS | 7653 | RSS: Main: 213737472 12:16:01 INFO - PROCESS | 7653 | 12:16:03 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:16:03 INFO - PROCESS | 7653 | RSS: Main: 214700032 12:16:03 INFO - PROCESS | 7653 | 12:16:07 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42475/tests/kraken/driver.html?testName=imaging-darkroom) 12:16:07 INFO - PROCESS | 7653 | RSS: Main: 253100032 12:16:07 INFO - PROCESS | 7653 | 12:16:11 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42475/tests/kraken/driver.html?testName=imaging-desaturate) 12:16:11 INFO - PROCESS | 7653 | RSS: Main: 252645376 12:16:11 INFO - PROCESS | 7653 | 12:16:14 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42475/tests/kraken/driver.html?testName=json-parse-financial) 12:16:15 INFO - PROCESS | 7653 | RSS: Main: 252350464 12:16:15 INFO - PROCESS | 7653 | 12:16:17 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:16:17 INFO - PROCESS | 7653 | RSS: Main: 215445504 12:16:17 INFO - PROCESS | 7653 | 12:16:19 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:16:20 INFO - PROCESS | 7653 | RSS: Main: 221945856 12:16:20 INFO - PROCESS | 7653 | 12:16:22 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:16:23 INFO - PROCESS | 7653 | RSS: Main: 223195136 12:16:23 INFO - PROCESS | 7653 | 12:16:25 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:16:26 INFO - PROCESS | 7653 | RSS: Main: 225058816 12:16:26 INFO - PROCESS | 7653 | 12:16:29 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:16:30 INFO - PROCESS | 7653 | RSS: Main: 222986240 12:16:30 INFO - PROCESS | 7653 | 12:16:31 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:42475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42475/tests/kraken/driver.html?testName=ai-astar) 12:16:32 INFO - PROCESS | 7653 | RSS: Main: 273829888 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | __start_tp_report 12:16:32 INFO - PROCESS | 7653 | _x_x_mozilla_page_load 12:16:32 INFO - PROCESS | 7653 | _x_x_mozilla_page_load_details 12:16:32 INFO - PROCESS | 7653 | |i|pagename|runs| 12:16:32 INFO - PROCESS | 7653 | |0;ai-astar;115;115;134;117;117;117;114;114;114;115 12:16:32 INFO - PROCESS | 7653 | |1;audio-beat-detection;147;122;151;181;123;152;145;124;177;123 12:16:32 INFO - PROCESS | 7653 | |2;audio-dft;161;161;162;161;162;161;160;161;159;160 12:16:32 INFO - PROCESS | 7653 | |3;audio-fft;76;76;77;169;79;76;78;77;169;77 12:16:32 INFO - PROCESS | 7653 | |4;audio-oscillator;84;85;140;82;84;82;137;84;83;144 12:16:32 INFO - PROCESS | 7653 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;118;117;117 12:16:32 INFO - PROCESS | 7653 | |6;imaging-darkroom;147;148;146;146;145;147;146;145;146;147 12:16:32 INFO - PROCESS | 7653 | |7;imaging-desaturate;95;95;96;97;96;96;95;96;95;96 12:16:32 INFO - PROCESS | 7653 | |8;json-parse-financial;63;64;66;65;64;66;66;67;66;65 12:16:32 INFO - PROCESS | 7653 | |9;json-stringify-tinderbox;65;65;64;64;65;65;64;65;69;64 12:16:32 INFO - PROCESS | 7653 | |10;stanford-crypto-aes;83;83;81;82;82;82;81;82;82;83 12:16:32 INFO - PROCESS | 7653 | |11;stanford-crypto-ccm;139;134;132;135;132;135;137;138;172;134 12:16:32 INFO - PROCESS | 7653 | |12;stanford-crypto-pbkdf2;175;171;171;173;183;174;174;171;174;177 12:16:32 INFO - PROCESS | 7653 | |13;stanford-crypto-sha256-iterative;71;68;68;69;68;69;67;69;67;67 12:16:32 INFO - PROCESS | 7653 | __end_tp_report 12:16:32 INFO - PROCESS | 7653 | __start_cc_report 12:16:32 INFO - PROCESS | 7653 | _x_x_mozilla_cycle_collect,2011 12:16:32 INFO - PROCESS | 7653 | __end_cc_report 12:16:32 INFO - PROCESS | 7653 | __startTimestamp1472325392128__endTimestamp 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | ------- Summary: start ------- 12:16:32 INFO - PROCESS | 7653 | Number of tests: 14 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#0] ai-astar Cycles:10 Average:117.20 Median:116.00 stddev:6.03 (5.2%) stddev-sans-first:6.35 12:16:32 INFO - PROCESS | 7653 | Values: 115.0 115.0 134.0 117.0 117.0 117.0 114.0 114.0 114.0 115.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:149.00 stddev:21.97 (14.7%) stddev-sans-first:23.29 12:16:32 INFO - PROCESS | 7653 | Values: 147.0 122.0 151.0 181.0 123.0 152.0 145.0 124.0 177.0 123.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:16:32 INFO - PROCESS | 7653 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 160.0 161.0 159.0 160.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:38.80 (50.4%) stddev-sans-first:40.52 12:16:32 INFO - PROCESS | 7653 | Values: 76.0 76.0 77.0 169.0 79.0 76.0 78.0 77.0 169.0 77.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:83.50 stddev:27.55 (33.0%) stddev-sans-first:28.57 12:16:32 INFO - PROCESS | 7653 | Values: 84.0 85.0 140.0 82.0 84.0 82.0 137.0 84.0 83.0 144.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:16:32 INFO - PROCESS | 7653 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 12:16:32 INFO - PROCESS | 7653 | Values: 147.0 148.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 147.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 12:16:32 INFO - PROCESS | 7653 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 95.0 96.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.01 12:16:32 INFO - PROCESS | 7653 | Values: 63.0 64.0 66.0 65.0 64.0 66.0 66.0 67.0 66.0 65.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.58 12:16:32 INFO - PROCESS | 7653 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 69.0 64.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 12:16:32 INFO - PROCESS | 7653 | Values: 83.0 83.0 81.0 82.0 82.0 82.0 81.0 82.0 82.0 83.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:136.00 stddev:11.90 (8.7%) stddev-sans-first:12.62 12:16:32 INFO - PROCESS | 7653 | Values: 139.0 134.0 132.0 135.0 132.0 135.0 137.0 138.0 172.0 134.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.00 stddev:3.62 (2.1%) stddev-sans-first:3.83 12:16:32 INFO - PROCESS | 7653 | Values: 175.0 171.0 171.0 173.0 183.0 174.0 174.0 171.0 174.0 177.0 12:16:32 INFO - PROCESS | 7653 | 12:16:32 INFO - PROCESS | 7653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:0.87 12:16:32 INFO - PROCESS | 7653 | Values: 71.0 68.0 68.0 69.0 68.0 69.0 67.0 69.0 67.0 67.0 12:16:32 INFO - PROCESS | 7653 | -------- Summary: end -------- 12:16:32 INFO - PROCESS | 7653 | 12:16:33 INFO - TEST-INFO | 7653: exit 0 12:16:33 INFO - TEST-OK | kraken | took 64342ms 12:16:33 INFO - SUITE-END | took 1186s 12:16:33 INFO - Completed test suite (00:19:46) 12:16:33 INFO - javascript benchmark 12:16:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.7768939640127, 2625.291171383725, 2629.395239095008, 2669.7730692891114, 2690.582959641255, 4614.400127983366, 4691.765411729417, 4707.152712511746, 4745.122152401808, 4874.829380971667, 4724.7401392923375, 4732.90534189316, 4752.287156926463, 4765.380500534934, 4788.880277993052, 4348.717333373336, 4378.233809083397, 4418.270985287424, 4419.602235798778, 4465.933011004838, 4428.136513379892, 4431.0, 4455.042165934324, 4465.799039043251, 4466.776661166945, 4368.49762277339, 4421.9336709949375, 4425.203463376591, 4425.291953287475, 4461.130079634472, 4222.408862759216, 4253.29820579604, 4254.0641058967285, 4312.482502099737, 4399.912001759979, 4266.338717498793, 4297.4413326267695, 4367.58507941745, 4387.714798538085, 4416.050549131952, 4654.976725116387, 4659.6505262105475, 4679.953200467986, 4682.578567928903, 4719.103370359655, 5093.337866077386, 5094.566961808251, 5104.081265372231, 5106.770195341219, 5106.821261255838, 4996.875078123039, 5098.643094983353, 5156.097682905476, 5189.506996835333, 5197.272381866504, 4776.8566942991765, 4812.422509298836, 4818.903621927542, 4821.63837712173, 4824.059308434892, 5293.57651387888, 5302.098643230583, 5309.7170193628945, 5319.707416092152, 5375.75809088592, 4925.655204135748, 5010.048090862724, 5062.696238225718, 5066.493350664978, 5096.184610462383, 5090.694558326512, 5119.846404607868, 5122.641415100981, 5126.410462796752, 5131.384233891882, 5077.289179514871, 5080.796768129233, 5083.313752643346, 5089.720065396365, 5123.385193776696, 4874.7562621868765, 4916.5575098240615, 5004.574611158019, 5045.091883460939, 5054.848354549369, 4310.6335961443, 4316.913661726748, 4324.3513472978675, 4367.912641747147, 4370.235208838504, 3752.9249415011545, 3758.4550240215017, 3774.0564858785306, 3810.657040866335, 3813.161104556993, 4248.4477017987465, 4370.584794444522, 4386.188555117314, 4424.181526417623, 4433.82264709408, 5136.691798492103, 5164.741762911839, 5171.043356978971, 5173.715445650525, 5223.52988231061, 4418.381426600278, 4420.447444069491, 4423.933640995323, 4464.620507256919, 4480.798364073625, 4516.728996260234, 4518.615917646971, 4535.229011068126, 4556.29377446503, 4620.399348084795, 4769.809207631656, 4788.066327066189, 4794.089123066607, 4835.105505481497, 4843.927341089816, 5093.414257360451, 5101.158308878993, 5102.0, 5104.923426148685, 5110.97444512775, 4598.172328980681, 4683.812647494062, 4711.293306004127, 4822.300766388784, 4838.951610483991, 4977.054359671651, 5002.324686167321, 5011.148104822116, 5027.597792176544, 5080.7205603692155, 5058.595312375075, 5060.645754797276, 5062.569681577107, 5066.290719299227, 5118.078745825787, 4791.544803243686, 4910.361652985089, 4936.308916751729, 4974.452810190948, 4977.502249775139, 4991.226359914219, 4992.326035985096, 4992.475790042138, 4993.126202914548, 5021.096202683552, 4963.503649635008, 4963.900721985612, 4964.081644895706, 4966.304717339648, 4980.277859710394, 4908.631852610997, 4943.826966056171, 4967.577755890789, 5017.2724954880605, 5020.874478138076, 4837.830675926326, 4856.490068542894, 4886.364772579542, 4897.804087836446, 4901.044296362175], "value": 4677.4628443711335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.353946192148, 563.0962305499673, 573.9655620662761, 579.9072148456247, 587.955903307252, 27323.863380683095, 38620.806895965514, 40011.59988400119, 40090.398644020366, 43683.78158109213, 40606.18787624253, 40969.59030409695, 41107.0, 41144.0, 41217.17565648693, 7640.274173953466, 7792.0, 7793.415493837956, 7793.844123117534, 7797.454178207528, 7586.810329741746, 7661.885071723928, 7672.424568157383, 7673.769786906401, 7677.884831727529, 7665.233476652346, 7705.922940770604, 7710.306072453478, 7711.961440192819, 7712.614369281541, 7593.468457207998, 7629.084509858797, 7634.618269086552, 7662.808429789272, 7680.615969201517, 7664.73173438927, 7720.806979825549, 7726.845463090763, 7728.845423091563, 7731.381489480828, 37462.25075498502, 37855.432168517495, 37910.62089379126, 37919.431208531896, 37942.0, 2951.4834903891733, 2971.762259019273, 2976.419598178356, 2979.344544200294, 3011.111722042003, 28013.159605211877, 28080.85959570189, 28083.0, 28182.436351273063, 28837.855810720812, 3211.5556438002486, 3291.7202037826814, 3301.7523685723427, 3328.284418849959, 3359.1434184283094, 173731.0, 173870.0, 173886.0, 173903.0, 173941.130294349, 49119.26321105186, 49449.0, 49459.50540494621, 49545.0, 49561.0, 31796.0, 32867.83566082154, 32991.175220619196, 51902.0, 51932.74033629883, 12226.694332641755, 12243.387830608433, 12245.448954797055, 12247.387630618612, 12259.325737084368, 10077.647282345082, 10119.747006324753, 10135.797284054424, 10143.695689129338, 10147.238957078249, 17547.912260438872, 17602.559936001704, 17625.206865691074, 17767.644647107245, 17809.376671816422, 6693.431058360094, 6841.692123854438, 6861.378769487369, 6883.414909732729, 6887.7244910203035, 762.8588711088355, 819.2626636027504, 856.3876828067837, 875.6497401039635, 919.6551293265026, 25489.362765931, 25567.488650226893, 26712.93148274086, 26808.195754127406, 27030.729692703215, 938.7653086728318, 947.2800671489717, 947.3415975896686, 964.8986856380119, 971.5627967414691, 14113.506027288995, 14349.0, 14362.85637143636, 14493.130412175304, 14498.275086245856, 365313.0, 369718.0, 371163.0, 371328.0, 371623.0, 48396.51603483991, 49041.509584903695, 49048.509514905105, 49050.0, 49069.75465122652, 1169.6081812592877, 1205.3310412720848, 1212.5998420521207, 1219.3781171602548, 1219.536576101076, 25268.368290792878, 26138.215853524423, 26415.339616508973, 27329.453410932067, 27487.45025099527, 41647.37528937008, 41928.790356048026, 41983.580164199186, 42022.78988605038, 42113.57886421097, 321902.0, 322876.0, 323588.0, 323718.0, 324154.0, 24870.875645621658, 25183.496330073664, 25200.243992680247, 25224.24327270185, 25238.621420678337, 40924.38613420861, 41052.0, 41867.0, 41873.0, 42017.369739454545, 34317.48523772095, 34493.65506344904, 34624.82687586546, 34647.82676086603, 34825.12937176591, 34385.0, 34431.65568344285, 34506.0, 34603.0, 35106.29787404186, 34244.48633270453, 35037.47443788396, 35138.648613513535, 35242.29515409626, 35298.47052294269, 28631.713682862905, 31495.84252078725, 31727.682723173395, 31750.0, 32065.67934320627, 24421.75578244266, 24602.630960535247, 24640.2095507552, 24741.50516989614, 25245.873770631028], "value": 16708.08232093616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.66810525684815, 363.95086663300447, 364.4897143998403, 365.31685747651886, 377.93197224499596, 12489.313087780169, 16044.031854106985, 16260.349586016575, 17524.21141048653, 17673.469795906112, 13971.301434928264, 14179.43282268708, 16024.43914462994, 16320.183990800471, 16405.753913691275, 5685.0, 5693.459121383472, 5815.651060936336, 5881.088431293157, 5970.6119102258435, 3906.2187562487475, 4119.196756632457, 5828.2131912191735, 5859.9414005860035, 5873.70631468427, 4038.232735780207, 4162.646175075107, 4170.97914510427, 6978.581285122909, 6991.881298992163, 6751.122354093985, 7073.328033836778, 7075.929240707578, 7080.433565314763, 7080.893786593179, 6699.229588597325, 6722.798316050526, 6726.697298621574, 6731.12495375603, 6731.192256929151, 21945.231916882993, 22709.659355109685, 22743.0, 23587.41031474227, 23692.0, 1794.7397627344092, 1906.8760530565607, 1915.808419158087, 1947.0848701110456, 2372.8694921779297, 13781.724365512733, 14183.78724319136, 14343.497977570734, 15211.467598633995, 15327.463538776201, 1862.5064357945155, 1865.2911893480525, 1878.7181922711702, 1894.7536820213284, 1922.9807701922941, 64729.67635161794, 67783.66108169477, 72557.0, 77528.0, 86056.0, 16005.439809606607, 16320.510384688478, 16399.0, 16489.257983390777, 16921.915390422968, 28854.27864303367, 28932.27669308284, 29004.41991160165, 29008.12975610735, 29143.85428072846, 8744.562771861381, 8799.956000220085, 8851.291896648381, 9056.411333263317, 9141.131592498701, 7029.507934444539, 7143.749968751173, 7324.816879577947, 7325.633718314063, 7394.7781566553085, 8254.8349033019, 8309.335253179852, 8392.622331995075, 8435.95782021086, 8598.828023439497, 3180.6183258009187, 3190.170555655546, 3230.2247460609283, 3284.638689744126, 3312.585926759155, 731.9926800731924, 798.1738900238341, 826.6404114210337, 866.1295398124844, 875.5753459572103, 15909.499910019777, 16147.0, 16492.505224843273, 16638.75041874373, 17280.740788888175, 803.3091541274499, 817.3297895725567, 817.9059408168137, 821.34292565947, 856.1395797223751, 7610.657520411595, 9163.108709282595, 9416.482093484925, 9434.858477122849, 9448.574814133242, 373556.0, 379253.0, 379467.0, 383167.0, 390574.0, 76874.0, 77696.61151694205, 78260.0, 78435.8987115078, 80740.59629701814, 868.1275318305063, 874.3791907745444, 879.4371602174741, 899.3389858454032, 916.6654171227588, 14259.64350891236, 14624.122552646875, 14746.410143594136, 15015.988785400858, 15133.770120199431, 38192.42711359276, 38330.23339533249, 38715.80642096772, 39604.60395396009, 39907.2018559633, 51015.0, 52667.473325266255, 52720.209196862845, 52788.736056319474, 54686.17970730363, 7472.0, 7773.572453515111, 7791.220877912164, 7945.682172713026, 8291.502509849428, 11402.885971140182, 11724.648260552198, 11836.76326473483, 12194.451249693962, 12316.876831231573, 10026.298159128792, 10226.795464090825, 10271.435071071162, 10680.252382333472, 10742.409167495864, 9890.0, 10340.689779306633, 10364.170866330825, 10635.308704934154, 10706.250562460553, 9893.50532473359, 10110.646127385506, 10137.239707021856, 10465.738356541147, 10625.840612390975, 7505.174430812715, 7709.421793365408, 7767.456278060482, 7772.7668169954995, 7918.326942209977, 8819.955900220459, 9198.632054717737, 9749.415035097632, 10327.225458090523, 10516.842247366449], "value": 9088.74719702986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.3698058519271, 1348.6695759538914, 1375.8486566477686, 1445.299029970464, 1690.5097521718703, 6799.0, 7149.857002859946, 7200.459965502589, 7208.747693830717, 7324.853502929938, 6980.162380514345, 7109.182444018939, 7179.174394944583, 7255.238199989004, 7258.455615828808, 2150.817180539652, 2211.3365990202956, 2212.1151539384214, 2214.767449417804, 2219.5671843990426, 2127.4574983379293, 2171.522265101675, 2172.7935846094597, 2177.074743234119, 2177.3032629558547, 2150.129197674936, 2161.8810965396897, 2171.9348419547437, 2174.423777698911, 2188.4966457714654, 2111.68324751287, 2114.524232047777, 2115.2279418012313, 2129.9254526091668, 2132.040581738216, 2040.8775473471492, 2107.030765847697, 2125.787421257877, 2132.2430537159394, 2139.368886178581, 7095.8226044348785, 7241.348278654894, 7316.341529262339, 7333.083364579427, 7340.26597340267, 4361.323994780814, 4464.910701785946, 4482.775861206959, 4486.573775491323, 4490.932636010462, 2630.4476060027228, 2771.8198317109322, 2794.3014246438393, 2794.9161525154277, 2816.830990140578, 921.9262459003263, 937.236152535688, 950.2682934140742, 952.5189779161549, 953.5565961827783, 10358.896411035868, 10548.05067543917, 10558.1025612823, 10570.154387649047, 10588.78822423555, 3884.2231553689376, 3984.2429938312207, 4173.7078404512, 4183.916321673611, 4272.6795490338345, 8987.370884038186, 8999.505027223435, 9000.8649870252, 9007.594658240396, 9013.684521041732, 4628.143793398165, 4637.373954516097, 4639.559241872017, 4648.651351148677, 4650.0, 3647.6717095461536, 3891.552471465761, 4000.8999775005277, 4239.3429018501565, 4239.851605193803, 3543.94684079739, 3544.627814079536, 3658.1951970566433, 3684.7420680552104, 3692.3353796316383, 1186.9762604747857, 1201.4533387308754, 1211.3943028485758, 1216.4890745886748, 1226.1294480918468, 778.8208711996273, 785.8271180340316, 800.4356928365488, 801.8035581282624, 812.3947658994088, 4670.322803193518, 4702.15361234981, 4781.354517140142, 4866.270059491105, 5151.639385242997, 412.5606229365716, 413.3015204304775, 414.84235990323486, 418.7403809637983, 419.7208856110713, 3417.2482053948092, 3441.4149594568985, 3523.9119022024656, 3524.84138213781, 3645.708343332527, 8720.912790872137, 9251.028641992629, 9336.626534938663, 9358.344915855825, 9381.718548443558, 9019.549022548847, 9043.32175086871, 9043.68347107848, 9061.954690226507, 9296.39573427725, 7080.822979425556, 7140.357367836816, 7144.499885008104, 7173.569585824867, 7177.712891484387, 4869.391326084239, 4869.902601947871, 4874.147024270809, 4916.164252077084, 5176.663516871391, 8311.584420778816, 8373.246407823324, 8477.61850716707, 8547.102554231717, 8601.655933762579, 8549.829003420022, 8605.397622166389, 8611.913880861362, 8801.647934082821, 8819.426737262058, 5904.498117660047, 6510.47916166715, 6551.672416379067, 6584.50616203777, 6855.4172895304455, 6853.760118395832, 7170.1754298256365, 7179.569225846466, 7180.210176880643, 7182.8563428730085, 6254.186955695731, 6337.112804207322, 6361.61830290184, 6369.7452101915405, 6399.296077431386, 6196.597221180609, 6325.525585581007, 6350.714217860115, 6400.359964003563, 6418.518611104092, 5591.30108736408, 5711.600187986967, 5737.196792448977, 5754.539636829128, 5764.0201165802755, 4232.32282834745, 4233.301505251722, 4241.87274381769, 4260.573942605714, 4450.46594408673, 4301.397804307462, 4351.673624478113, 4409.404730361489, 4506.278995360726, 4573.474050484237], "value": 3915.4051852910807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.1644681084422, 293.3751110135412, 296.86047557647925, 300.6962967402923, 300.9984950075249, 4680.391549098621, 4742.312364707115, 4774.498677638841, 4820.084184005041, 4848.539388758067, 4705.552972467619, 4749.430068391789, 4753.239481682931, 4754.6434017448655, 4812.5321776858045, 3806.619338066199, 3833.5591406988133, 3838.1747924196293, 3843.961560384402, 3859.2281543691233, 3579.5704515458183, 3799.1072098056934, 3813.199228162089, 3814.2180852925085, 3856.768593884362, 3613.7109031277437, 3738.8130593470355, 3772.547294324685, 3775.62243775623, 3776.111274874723, 3725.2549490102087, 3751.174741556853, 3769.6984241260634, 3771.4537039813545, 3777.7922214278206, 3314.4696848504122, 3326.866925322984, 3334.0164651427885, 3336.7497437692027, 3337.916552086193, 4552.704074235197, 4677.251639737626, 4687.343771871941, 4719.5044520325555, 4726.929096063562, 4279.700420970534, 4283.1433713257165, 4285.5071666758095, 4289.806958686867, 4296.0, 4959.256111583255, 5009.323741294951, 5011.824586139504, 5013.674111182761, 5016.347874776292, 3368.562086928708, 3619.113317237294, 3629.727770417203, 3635.72732045095, 3638.490611314418, 5214.713190774506, 5215.843524694227, 5232.607554433433, 5235.633505654606, 5286.894262114774, 3642.1987162824134, 3647.2887786881834, 3672.137047793766, 3674.3018826422895, 3675.209829886587, 3715.3498137825773, 3723.9813800930824, 3726.6459686329754, 3737.3272810893754, 3753.793541355252, 4156.958430415718, 4198.6221240088535, 4217.683673724483, 4231.915361692749, 4280.978595107004, 4985.8005679772405, 4997.000599880039, 5004.371830422914, 5008.248762685554, 5015.27278544609, 1208.6917835951776, 1246.5512415530402, 1272.408330126477, 1283.1980012492193, 1288.903332250085, 865.9783505412415, 879.5426378283257, 881.4579033894237, 885.9955700221586, 887.7469921072463, 4454.710443821141, 4471.686981911235, 4477.328400739915, 4481.417415735934, 4498.955010449919, 5193.169092945111, 5201.817936372285, 5201.921971170435, 5209.0, 5218.947810521922, 4340.739555626673, 4447.310666846644, 4448.7108337957925, 4461.754603496839, 4466.173757854807, 2434.403571125086, 2441.8901149448316, 2451.3626457121277, 2452.8160387970975, 2465.3343597229004, 4341.261985462479, 4367.410399596078, 4370.934435983463, 4376.8182590700335, 4383.7588932609015, 4364.541723119027, 4682.391289132459, 4689.038747056913, 4696.342512048316, 4703.600193983481, 4315.223259813264, 4320.567943205654, 4330.751936047964, 4334.4798624165305, 4344.174606824757, 4517.819287228474, 4555.954440455553, 4559.17934771731, 4587.288970209623, 4590.196715574828, 4224.55642157569, 4421.712588681726, 4467.240569103195, 4472.239719247801, 4476.358948220565, 4295.539516564383, 4304.311310190355, 4308.956910430856, 4334.674899382496, 4347.847825326098, 3322.9667703322657, 3353.312570923004, 3373.8313084345195, 3379.7157080309325, 3385.356782211372, 4412.0, 4588.449386073693, 4588.839390621446, 4589.816407343669, 4623.398958135421, 4272.87181384559, 4370.956290437182, 4371.115064057707, 4383.583559561836, 4406.625436837905, 4374.693771435969, 4376.096398066851, 4388.956110438855, 4390.758508282075, 4419.823207071681, 4319.0, 4330.350447432785, 4346.456692913386, 4578.88552786183, 4658.627309815139, 4995.276629562795, 5026.673266237683, 5027.667668068038, 5035.345405097314, 5045.520675535819, 4857.392825896763, 4877.146684259958, 4931.482194369683, 4937.01259748059, 4939.876503087452], "value": 3646.8076374219095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9056355701309, 649.3441623959801, 674.4941294029478, 718.3427164144808, 730.1603156370173, 13984.440622375105, 14712.411503539859, 14761.114333139993, 14779.556613301591, 14790.038647487905, 14062.507812226575, 14190.43238270468, 14194.36125374358, 14195.574132776008, 14197.645058873508, 616.7563812294142, 736.3667246168291, 751.7519218657843, 761.7828918758155, 779.8908152858604, 762.0208032678009, 770.5299767142039, 770.9074911010687, 771.032354395236, 771.1786946901532, 814.42989907065, 815.5269943432795, 815.824597711492, 815.8613035783931, 815.9877601835977, 641.1920979565734, 772.5905270206799, 792.2829838995718, 808.4785313472806, 808.7533302342783, 579.5218944370911, 580.6196941003649, 580.6574121268471, 580.9564282678774, 581.5986968991425, 13122.803157952543, 13154.079214454992, 13169.604911852659, 13173.275469849155, 13176.604701858863, 12078.69803254917, 12249.203801752858, 12346.38268086601, 12753.426095825711, 12982.41579128932, 9417.90582094177, 9484.857727134098, 11660.183787134903, 11751.764964700744, 11897.82153267693, 3282.655321191264, 3312.0726196664973, 3415.64135765746, 3481.547398838135, 3485.0590340608146, 59288.40711592872, 59326.40673593252, 59649.403505964816, 60151.69924150395, 60278.0, 9053.954730226307, 9193.264538836876, 9629.0, 10221.977802219719, 10242.385456872462, 18522.81477185238, 18882.055897205086, 18885.43343699691, 18894.149763260688, 18896.90551547261, 6967.407770339477, 7057.36483716468, 7109.573425594481, 7224.422046236288, 7313.853722925512, 3655.287218992271, 3686.5391826021746, 3733.2160246348026, 3751.0622344413896, 3868.1296708240984, 2805.761510271609, 2903.593496910434, 2911.0539074800777, 2937.9412411751646, 2946.9410611787644, 486.41630043946697, 489.3907085678282, 489.49337435753824, 494.8416506717888, 495.22002845518455, 384.6787932076691, 425.58080290913426, 433.47332990416794, 494.92823540586414, 514.7503460821498, 6964.0, 7014.684339204748, 7561.508501947355, 7600.3539699126195, 7841.647125879349, 498.36209651645953, 528.2709860392633, 541.9729013549306, 542.1380005790811, 547.3869266421553, 3379.729621630264, 3394.575678040245, 3419.076849250688, 3469.080693616194, 3527.4356103023392, 101246.49376753217, 101247.49376253072, 103734.0, 108313.0, 108730.0, 67730.3226967734, 69883.0, 70057.0, 82159.58920205361, 86283.13716862751, 67454.32545674579, 70407.0, 71488.99999999897, 73658.89752127262, 73815.63092184505, 6734.259231484435, 7595.468317217963, 7664.923350766421, 7962.203779621991, 8034.276915077671, 43435.34846977361, 43466.34800477932, 44531.55468445274, 45555.77222113868, 45801.770991146164, 38290.23419531538, 38571.2285754289, 39655.206895862495, 54900.72549637226, 56249.0, 10027.498625068863, 10169.440680762333, 10225.539850706884, 10388.480575971322, 10428.58285668595, 9963.352382095141, 10135.189184865341, 10291.897081029094, 10445.164386848883, 11835.46740396667, 10174.0, 10272.691819245434, 10303.124234440156, 10575.576976920836, 11186.440677965906, 10508.632197873038, 10772.299800512941, 10783.676489705322, 10823.296485728402, 11117.610883619034, 10350.792984140426, 10409.0, 10959.799866247118, 11004.944975275072, 11150.219484635998, 9039.0, 9379.390339627902, 9414.15272625467, 9491.715248542554, 9501.57242924084, 8203.671853126047, 8455.154484551496, 9200.539973001189, 9205.815883682422, 9256.583453744463], "value": 6234.715298808554, "unit": "score"}], "name": "dromaeo_css", "value": 6311.99679245356, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 134.0, 117.0, 117.0, 117.0, 114.0, 114.0, 114.0, 115.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 151.0, 181.0, 123.0, 152.0, 145.0, 124.0, 177.0, 123.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 159.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 169.0, 79.0, 76.0, 78.0, 77.0, 169.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 140.0, 82.0, 84.0, 82.0, 137.0, 84.0, 83.0, 144.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 65.0, 64.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 69.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 82.0, 82.0, 82.0, 81.0, 82.0, 82.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 134.0, 132.0, 135.0, 132.0, 135.0, 137.0, 138.0, 172.0, 134.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 171.0, 173.0, 183.0, 174.0, 174.0, 171.0, 174.0, 177.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 69.0, 68.0, 69.0, 67.0, 69.0, 67.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1571.8, "alertThreshold": 2.0}]} 12:16:33 INFO - Return code: 0 12:16:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:33 INFO - # TBPL SUCCESS # 12:16:33 INFO - Running post-action listener: _resource_record_post_action 12:16:33 INFO - [mozharness: 2016-08-27 19:16:33.927682Z] Finished run-tests step (success) 12:16:33 INFO - Running post-run listener: _resource_record_post_run 12:16:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 418111488; Read time: 560; Write time: 300072 12:16:33 INFO - TinderboxPrint: CPU usage
13.1% 12:16:33 INFO - TinderboxPrint: I/O read bytes / time
3,309,568 / 560 12:16:33 INFO - TinderboxPrint: I/O write bytes / time
418,111,488 / 300,072 12:16:33 INFO - TinderboxPrint: CPU idle
8,339.4 (86.9%) 12:16:33 INFO - TinderboxPrint: CPU user
1,208.6 (12.6%) 12:16:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:16:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114491392; Read time: 0; Write time: 90684 12:16:34 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 3309568; Write bytes: 292306944; Read time: 560; Write time: 206632 12:16:34 INFO - Running post-run listener: _upload_blobber_files 12:16:34 INFO - Blob upload gear active. 12:16:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:34 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 12:16:34 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'] 12:16:34 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 12:16:34 INFO - Traceback (most recent call last): 12:16:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 12:16:34 INFO - main() 12:16:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 12:16:34 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 12:16:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 12:16:34 INFO - return set(response.json().get('whitelist', [])) 12:16:34 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 12:16:34 INFO - return json.loads(self.text or self.content, **kwargs) 12:16:34 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 12:16:34 INFO - return _default_decoder.decode(s) 12:16:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 12:16:34 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 12:16:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 12:16:34 INFO - raise ValueError("No JSON object could be decoded") 12:16:34 INFO - ValueError: No JSON object could be decoded 12:16:34 ERROR - Return code: 1 12:16:34 INFO - Setting buildbot property blobber_files to {} 12:16:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:34 INFO - Contents: 12:16:34 INFO - blobber_files:{} 12:16:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:34 INFO - Copying logs to upload dir... 12:16:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.987487 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-27 12:16:34.790933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:16:34.794374) ========= 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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/ZbSTDS8vQO2Aup7lIf9r5A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:16:34.845283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:16:34.845611) ========= 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=232498196343f89f466a4a9a000001c8-1472319530.213124-1517448615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:16:34.894838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:16:34.895158) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:16:34.895454) ========= ========= Total master_lag: 0.15 =========