builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1472197058.66 results: success (0) buildid: 20160825232117 builduid: 0f100a1f36fe43868e8fdfe3f4de2310 revision: 25037d50766284467cca32e3e1ffe739a6767bee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.658033) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.658486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.658761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.704529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.705016) ========= 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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 00:37:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-26 00:37:39 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.854208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.854525) ========= 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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:38.903781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 00:37:38.904137) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 25037d50766284467cca32e3e1ffe739a6767bee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 25037d50766284467cca32e3e1ffe739a6767bee --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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 00:37:39,208 truncating revision to first 12 chars 2016-08-26 00:37:39,208 Setting DEBUG logging. 2016-08-26 00:37:39,208 attempt 1/10 2016-08-26 00:37:39,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/25037d507662?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 00:37:40,235 unpacking tar archive at: autoland-25037d507662/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 00:37:40.249019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:40.249298) ========= script_repo_revision: 25037d50766284467cca32e3e1ffe739a6767bee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:40.249754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:40.250017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 00:37:40.260794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-26 00:37:40.261076) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:37:40 INFO - MultiFileLogger online at 20160826 00:37:40 in /builds/slave/test 00:37:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 00:37:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:37:40 INFO - {'append_to_log': False, 00:37:40 INFO - 'base_work_dir': '/builds/slave/test', 00:37:40 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:37:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:37:40 INFO - 'branch': 'Autoland-Non-PGO', 00:37:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:37:40 INFO - 'config_files': ('talos/linux_config.py',), 00:37:40 INFO - 'default_actions': ('clobber', 00:37:40 INFO - 'read-buildbot-config', 00:37:40 INFO - 'download-and-extract', 00:37:40 INFO - 'populate-webroot', 00:37:40 INFO - 'create-virtualenv', 00:37:40 INFO - 'install', 00:37:40 INFO - 'run-tests'), 00:37:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:37:40 INFO - 'download_minidump_stackwalk': True, 00:37:40 INFO - 'download_symbols': 'ondemand', 00:37:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:37:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:37:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:37:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:37:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:37:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:37:40 INFO - 'installer_path': 'installer.exe', 00:37:40 INFO - 'log_level': 'info', 00:37:40 INFO - 'log_name': 'talos', 00:37:40 INFO - 'log_to_console': True, 00:37:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:37:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:37:40 INFO - 'opt_config_files': (), 00:37:40 INFO - 'pip_index': False, 00:37:40 INFO - 'sps_profile': False, 00:37:40 INFO - 'sps_profile_interval': 0, 00:37:40 INFO - 'suite': 'dromaeojs', 00:37:40 INFO - 'system_bits': '32', 00:37:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:37:40 INFO - 'title': 'talos-linux64-ix-003', 00:37:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:37:40 INFO - 'use_talos_json': True, 00:37:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:37:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:37:40 INFO - 'work_dir': 'build'} 00:37:40 INFO - [mozharness: 2016-08-26 07:37:40.654682Z] Running clobber step. 00:37:40 INFO - Running pre-action listener: _resource_record_pre_action 00:37:40 INFO - Running main action method: clobber 00:37:40 INFO - rmtree: /builds/slave/test/build 00:37:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:37:41 INFO - Running post-action listener: _resource_record_post_action 00:37:41 INFO - [mozharness: 2016-08-26 07:37:41.110189Z] Finished clobber step (success) 00:37:41 INFO - [mozharness: 2016-08-26 07:37:41.110289Z] Running read-buildbot-config step. 00:37:41 INFO - Running pre-action listener: _resource_record_pre_action 00:37:41 INFO - Running main action method: read_buildbot_config 00:37:41 INFO - Using buildbot properties: 00:37:41 INFO - { 00:37:41 INFO - "project": "", 00:37:41 INFO - "product": "firefox", 00:37:41 INFO - "script_repo_revision": "production", 00:37:41 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:37:41 INFO - "repository": "", 00:37:41 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:37:41 INFO - "buildid": "20160825232117", 00:37:41 INFO - "pgo_build": "False", 00:37:41 INFO - "basedir": "/builds/slave/test", 00:37:41 INFO - "buildnumber": 328, 00:37:41 INFO - "slavename": "talos-linux64-ix-003", 00:37:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:37:41 INFO - "platform": "ubuntu64_hw", 00:37:41 INFO - "scheduler": "tests-autoland-linux64-talos", 00:37:41 INFO - "branch": "autoland", 00:37:41 INFO - "repo_path": "integration/autoland", 00:37:41 INFO - "revision": "25037d50766284467cca32e3e1ffe739a6767bee", 00:37:41 INFO - "stage_platform": "linux64", 00:37:41 INFO - "builduid": "0f100a1f36fe43868e8fdfe3f4de2310", 00:37:41 INFO - "slavebuilddir": "test" 00:37:41 INFO - } 00:37:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 00:37:41 INFO - Running post-action listener: _resource_record_post_action 00:37:41 INFO - [mozharness: 2016-08-26 07:37:41.112688Z] Finished read-buildbot-config step (success) 00:37:41 INFO - [mozharness: 2016-08-26 07:37:41.112778Z] Running download-and-extract step. 00:37:41 INFO - Running pre-action listener: _resource_record_pre_action 00:37:41 INFO - Running main action method: download_and_extract 00:37:41 INFO - mkdir: /builds/slave/test/build/tests 00:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:41 INFO - trying https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:37:41 INFO - Downloading https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:41 INFO - Downloaded 1361 bytes. 00:37:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 00:37:41 INFO - Using the following test package requirements: 00:37:41 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:37:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:37:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:37:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'jsshell-linux-x86_64.zip'], 00:37:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:37:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 00:37:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:37:41 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:37:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:37:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 00:37:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:37:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:41 INFO - trying https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:37:41 INFO - Downloading https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:42 INFO - Downloaded 20302935 bytes. 00:37:42 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 00:37:47 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 00:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:47 INFO - trying https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 00:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:47 INFO - Downloaded 20302935 bytes. 00:37:47 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 00:37: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')]} 00:37:53 INFO - trying https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 00:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:53 INFO - Downloaded 14413998 bytes. 00:37:53 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 00:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:54 INFO - trying https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:37:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/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 00:37:56 INFO - Downloaded 55899238 bytes. 00:37:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:37:56 INFO - mkdir: /builds/slave/test/properties 00:37:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:37:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:37:56 INFO - Contents: 00:37:56 INFO - build_url:https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 00:37:57 INFO - Running post-action listener: _resource_record_post_action 00:37:57 INFO - Running post-action listener: set_extra_try_arguments 00:37:57 INFO - [mozharness: 2016-08-26 07:37:57.005814Z] Finished download-and-extract step (success) 00:37:57 INFO - [mozharness: 2016-08-26 07:37:57.006040Z] Running populate-webroot step. 00:37:57 INFO - Running pre-action listener: _resource_record_pre_action 00:37:57 INFO - Running main action method: populate_webroot 00:37:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:37:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:37:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:37:57 INFO - '--tppagecycles', 00:37:57 INFO - '7'], 00:37:57 INFO - 'tests': ['tsvgm']}}, 00:37:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:37:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:37:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:37:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:37:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['damp', 'tps']}, 00:37:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'tests': ['damp', 'tps']}, 00:37:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['dromaeo_dom']}, 00:37:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:37:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['basic_compositor_video']}, 00:37:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:37:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['a11yr', 00:37:57 INFO - 'ts_paint', 00:37:57 INFO - 'tpaint', 00:37:57 INFO - 'sessionrestore', 00:37:57 INFO - 'sessionrestore_no_auto_restore', 00:37:57 INFO - 'tabpaint']}, 00:37:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['tsvgx', 00:37:57 INFO - 'tsvgr_opacity', 00:37:57 INFO - 'tart', 00:37:57 INFO - 'tscrollx', 00:37:57 INFO - 'cart']}, 00:37:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:37:57 INFO - 'tsvgr_opacity', 00:37:57 INFO - 'tart', 00:37:57 INFO - 'tscrollx', 00:37:57 INFO - 'cart']}, 00:37:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'talos_options': ['--disable-e10s'], 00:37:57 INFO - 'tests': ['tp5o']}, 00:37:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'tests': ['tp5o']}, 00:37:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'talos_options': ['--disable-e10s', 00:37:57 INFO - '--xperf_path', 00:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:57 INFO - 'tests': ['tp5n']}, 00:37:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:57 INFO - 'talos_options': ['--xperf_path', 00:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:57 INFO - 'tests': ['tp5n']}}, 00:37:57 INFO - 'talos.zip': {'path': '', 00:37:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:37:57 INFO - Running post-action listener: _resource_record_post_action 00:37:57 INFO - [mozharness: 2016-08-26 07:37:57.021417Z] Finished populate-webroot step (success) 00:37:57 INFO - [mozharness: 2016-08-26 07:37:57.021506Z] Running create-virtualenv step. 00:37:57 INFO - Running pre-action listener: _resource_record_pre_action 00:37:57 INFO - Running main action method: create_virtualenv 00:37:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:37:57 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 00:37:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:37:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:37:57 INFO - Using real prefix '/usr' 00:37:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:37:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:37:59 INFO - Installing pip.................done. 00:37:59 INFO - Return code: 0 00:37:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:37:59 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')]} 00:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:59 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')]} 00:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:59 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:37:59 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 00:37:59 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 00:37:59 INFO - Using env: {'DISPLAY': ':0', 00:37:59 INFO - 'HOME': '/home/cltbld', 00:37:59 INFO - 'LANG': 'en_US.UTF-8', 00:37:59 INFO - 'LANGUAGE': 'en_US:en', 00:37:59 INFO - 'LOGNAME': 'cltbld', 00:37:59 INFO - 'MAIL': '/var/mail/cltbld', 00:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:59 INFO - 'MOZ_NO_REMOTE': '1', 00:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:59 INFO - 'NO_EM_RESTART': '1', 00:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:59 INFO - 'PWD': '/builds/slave/test', 00:37:59 INFO - 'SHELL': '/bin/bash', 00:37:59 INFO - 'SHLVL': '1', 00:37:59 INFO - 'TERM': 'linux', 00:37:59 INFO - 'TMOUT': '86400', 00:37:59 INFO - 'USER': 'cltbld', 00:37:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:59 INFO - '_': '/tools/buildbot/bin/python'} 00:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:59 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 00:37:59 INFO - Cleaning up... 00:37:59 INFO - Return code: 0 00:37:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:37:59 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')]} 00:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:59 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')]} 00:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:59 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:37:59 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 00:37:59 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 00:37:59 INFO - Using env: {'DISPLAY': ':0', 00:37:59 INFO - 'HOME': '/home/cltbld', 00:37:59 INFO - 'LANG': 'en_US.UTF-8', 00:37:59 INFO - 'LANGUAGE': 'en_US:en', 00:37:59 INFO - 'LOGNAME': 'cltbld', 00:37:59 INFO - 'MAIL': '/var/mail/cltbld', 00:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:59 INFO - 'MOZ_NO_REMOTE': '1', 00:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:59 INFO - 'NO_EM_RESTART': '1', 00:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:59 INFO - 'PWD': '/builds/slave/test', 00:37:59 INFO - 'SHELL': '/bin/bash', 00:37:59 INFO - 'SHLVL': '1', 00:37:59 INFO - 'TERM': 'linux', 00:37:59 INFO - 'TMOUT': '86400', 00:37:59 INFO - 'USER': 'cltbld', 00:37:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:59 INFO - '_': '/tools/buildbot/bin/python'} 00:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:00 INFO - Downloading/unpacking psutil>=3.1.1 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:38:02 INFO - Installing collected packages: psutil 00:38:02 INFO - Running setup.py install for psutil 00:38:02 INFO - building 'psutil._psutil_linux' extension 00:38:02 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 00:38:02 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 00:38:02 INFO - building 'psutil._psutil_posix' extension 00:38:02 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 00:38:02 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 00:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:38:02 INFO - Successfully installed psutil 00:38:02 INFO - Cleaning up... 00:38:02 INFO - Return code: 0 00:38:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:02 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:02 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 00:38:02 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 00:38:02 INFO - Using env: {'DISPLAY': ':0', 00:38:02 INFO - 'HOME': '/home/cltbld', 00:38:02 INFO - 'LANG': 'en_US.UTF-8', 00:38:02 INFO - 'LANGUAGE': 'en_US:en', 00:38:02 INFO - 'LOGNAME': 'cltbld', 00:38:02 INFO - 'MAIL': '/var/mail/cltbld', 00:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:02 INFO - 'MOZ_NO_REMOTE': '1', 00:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:02 INFO - 'NO_EM_RESTART': '1', 00:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:02 INFO - 'PWD': '/builds/slave/test', 00:38:02 INFO - 'SHELL': '/bin/bash', 00:38:02 INFO - 'SHLVL': '1', 00:38:02 INFO - 'TERM': 'linux', 00:38:02 INFO - 'TMOUT': '86400', 00:38:02 INFO - 'USER': 'cltbld', 00:38:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:02 INFO - '_': '/tools/buildbot/bin/python'} 00:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:38:02 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 00:38:02 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 00:38:02 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 00:38:02 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 00:38:02 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 00:38:02 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 00:38:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:38:04 INFO - Installing collected packages: mozsystemmonitor 00:38:04 INFO - Running setup.py install for mozsystemmonitor 00:38:04 INFO - Successfully installed mozsystemmonitor 00:38:04 INFO - Cleaning up... 00:38:04 INFO - Return code: 0 00:38:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:38:04 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')]} 00:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:04 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')]} 00:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:04 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:04 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 00:38:04 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 00:38:04 INFO - Using env: {'DISPLAY': ':0', 00:38:04 INFO - 'HOME': '/home/cltbld', 00:38:04 INFO - 'LANG': 'en_US.UTF-8', 00:38:04 INFO - 'LANGUAGE': 'en_US:en', 00:38:04 INFO - 'LOGNAME': 'cltbld', 00:38:04 INFO - 'MAIL': '/var/mail/cltbld', 00:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:04 INFO - 'MOZ_NO_REMOTE': '1', 00:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:04 INFO - 'NO_EM_RESTART': '1', 00:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:04 INFO - 'PWD': '/builds/slave/test', 00:38:04 INFO - 'SHELL': '/bin/bash', 00:38:04 INFO - 'SHLVL': '1', 00:38:04 INFO - 'TERM': 'linux', 00:38:04 INFO - 'TMOUT': '86400', 00:38:04 INFO - 'USER': 'cltbld', 00:38:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:04 INFO - '_': '/tools/buildbot/bin/python'} 00:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:05 INFO - Downloading/unpacking jsonschema==2.5.1 00:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:38:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:38:07 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 00:38:07 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 00:38:07 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 00:38:07 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 00:38:07 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 00:38:07 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 00:38:08 INFO - Downloading functools32-3.2.3-2.tar.gz 00:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:38:08 INFO - warning: no files found matching '*.txt' 00:38:08 INFO - no previously-included directories found matching 'build' 00:38:08 INFO - no previously-included directories found matching 'dist' 00:38:08 INFO - no previously-included directories found matching '.git*' 00:38:08 INFO - Installing collected packages: jsonschema, functools32 00:38:08 INFO - Running setup.py install for functools32 00:38:08 INFO - warning: no files found matching '*.txt' 00:38:08 INFO - no previously-included directories found matching 'build' 00:38:08 INFO - no previously-included directories found matching 'dist' 00:38:08 INFO - no previously-included directories found matching '.git*' 00:38:08 INFO - Successfully installed jsonschema functools32 00:38:08 INFO - Cleaning up... 00:38:08 INFO - Return code: 0 00:38:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:08 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:08 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 00:38:08 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 00:38:08 INFO - Using env: {'DISPLAY': ':0', 00:38:08 INFO - 'HOME': '/home/cltbld', 00:38:08 INFO - 'LANG': 'en_US.UTF-8', 00:38:08 INFO - 'LANGUAGE': 'en_US:en', 00:38:08 INFO - 'LOGNAME': 'cltbld', 00:38:08 INFO - 'MAIL': '/var/mail/cltbld', 00:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:08 INFO - 'MOZ_NO_REMOTE': '1', 00:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:08 INFO - 'NO_EM_RESTART': '1', 00:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:08 INFO - 'PWD': '/builds/slave/test', 00:38:08 INFO - 'SHELL': '/bin/bash', 00:38:08 INFO - 'SHLVL': '1', 00:38:08 INFO - 'TERM': 'linux', 00:38:08 INFO - 'TMOUT': '86400', 00:38:08 INFO - 'USER': 'cltbld', 00:38:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:08 INFO - '_': '/tools/buildbot/bin/python'} 00:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:38:08 INFO - Cleaning up... 00:38:08 INFO - Return code: 0 00:38:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:08 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:08 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 00:38:08 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 00:38:08 INFO - Using env: {'DISPLAY': ':0', 00:38:08 INFO - 'HOME': '/home/cltbld', 00:38:08 INFO - 'LANG': 'en_US.UTF-8', 00:38:08 INFO - 'LANGUAGE': 'en_US:en', 00:38:08 INFO - 'LOGNAME': 'cltbld', 00:38:08 INFO - 'MAIL': '/var/mail/cltbld', 00:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:08 INFO - 'MOZ_NO_REMOTE': '1', 00:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:08 INFO - 'NO_EM_RESTART': '1', 00:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:08 INFO - 'PWD': '/builds/slave/test', 00:38:08 INFO - 'SHELL': '/bin/bash', 00:38:08 INFO - 'SHLVL': '1', 00:38:08 INFO - 'TERM': 'linux', 00:38:08 INFO - 'TMOUT': '86400', 00:38:08 INFO - 'USER': 'cltbld', 00:38:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:08 INFO - '_': '/tools/buildbot/bin/python'} 00:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:08 INFO - Downloading/unpacking blobuploader==1.2.4 00:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:10 INFO - Downloading blobuploader-1.2.4.tar.gz 00:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:38:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:38:10 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 00:38:10 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 00:38:10 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 00:38:10 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 00:38:10 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 00:38:10 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 00:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:38:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38:11 INFO - Downloading docopt-0.6.1.tar.gz 00:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:38:11 INFO - Installing collected packages: blobuploader, requests, docopt 00:38:11 INFO - Running setup.py install for blobuploader 00:38:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:38:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:38:11 INFO - Running setup.py install for requests 00:38:12 INFO - Running setup.py install for docopt 00:38:12 INFO - Successfully installed blobuploader requests docopt 00:38:12 INFO - Cleaning up... 00:38:12 INFO - Return code: 0 00:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:12 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')]} 00:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:12 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')]} 00:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:12 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:12 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 00:38:12 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 00:38:12 INFO - Using env: {'DISPLAY': ':0', 00:38:12 INFO - 'HOME': '/home/cltbld', 00:38:12 INFO - 'LANG': 'en_US.UTF-8', 00:38:12 INFO - 'LANGUAGE': 'en_US:en', 00:38:12 INFO - 'LOGNAME': 'cltbld', 00:38:12 INFO - 'MAIL': '/var/mail/cltbld', 00:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:12 INFO - 'MOZ_NO_REMOTE': '1', 00:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:12 INFO - 'NO_EM_RESTART': '1', 00:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:12 INFO - 'PWD': '/builds/slave/test', 00:38:12 INFO - 'SHELL': '/bin/bash', 00:38:12 INFO - 'SHLVL': '1', 00:38:12 INFO - 'TERM': 'linux', 00:38:12 INFO - 'TMOUT': '86400', 00:38:12 INFO - 'USER': 'cltbld', 00:38:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:12 INFO - '_': '/tools/buildbot/bin/python'} 00:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:12 INFO - Running setup.py (path:/tmp/pip-8owUWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:12 INFO - Running setup.py (path:/tmp/pip-SiHOJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:12 INFO - Running setup.py (path:/tmp/pip-MAktzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:12 INFO - Running setup.py (path:/tmp/pip-ZvpIbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:12 INFO - Running setup.py (path:/tmp/pip-q_MBms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:12 INFO - Running setup.py (path:/tmp/pip-CROQPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:12 INFO - Running setup.py (path:/tmp/pip-FPW_wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:12 INFO - Running setup.py (path:/tmp/pip-Gqi0zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:12 INFO - Running setup.py (path:/tmp/pip-9pXKAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:13 INFO - Running setup.py (path:/tmp/pip-mpHnW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:13 INFO - Running setup.py (path:/tmp/pip-ukgDO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:13 INFO - Running setup.py (path:/tmp/pip-ZBOAYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:13 INFO - Running setup.py (path:/tmp/pip-oS2tlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:13 INFO - Running setup.py (path:/tmp/pip-Ur7brp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:13 INFO - Running setup.py (path:/tmp/pip-ZndDMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:13 INFO - Running setup.py (path:/tmp/pip-U1QYiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:13 INFO - Running setup.py (path:/tmp/pip-LKVrew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:38:13 INFO - Running setup.py install for manifestparser 00:38:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:38:13 INFO - Running setup.py install for mozcrash 00:38:13 INFO - Running setup.py install for mozdebug 00:38:13 INFO - Running setup.py install for mozdevice 00:38:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozfile 00:38:14 INFO - Running setup.py install for mozhttpd 00:38:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozinfo 00:38:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozInstall 00:38:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozleak 00:38:14 INFO - Running setup.py install for mozlog 00:38:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for moznetwork 00:38:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozprocess 00:38:14 INFO - Running setup.py install for mozprofile 00:38:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:38:14 INFO - Running setup.py install for mozrunner 00:38:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:38:15 INFO - Running setup.py install for mozscreenshot 00:38:15 INFO - Running setup.py install for moztest 00:38:15 INFO - Running setup.py install for mozversion 00:38:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:38:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:38:15 INFO - Cleaning up... 00:38:15 INFO - Return code: 0 00:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:15 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 00:38:15 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 00:38:15 INFO - Using env: {'DISPLAY': ':0', 00:38:15 INFO - 'HOME': '/home/cltbld', 00:38:15 INFO - 'LANG': 'en_US.UTF-8', 00:38:15 INFO - 'LANGUAGE': 'en_US:en', 00:38:15 INFO - 'LOGNAME': 'cltbld', 00:38:15 INFO - 'MAIL': '/var/mail/cltbld', 00:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:15 INFO - 'MOZ_NO_REMOTE': '1', 00:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:15 INFO - 'NO_EM_RESTART': '1', 00:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:15 INFO - 'PWD': '/builds/slave/test', 00:38:15 INFO - 'SHELL': '/bin/bash', 00:38:15 INFO - 'SHLVL': '1', 00:38:15 INFO - 'TERM': 'linux', 00:38:15 INFO - 'TMOUT': '86400', 00:38:15 INFO - 'USER': 'cltbld', 00:38:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:15 INFO - '_': '/tools/buildbot/bin/python'} 00:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:15 INFO - Running setup.py (path:/tmp/pip-QCK2py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:15 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)) 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:15 INFO - Running setup.py (path:/tmp/pip-TZJWnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:15 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)) 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:15 INFO - Running setup.py (path:/tmp/pip-MMScjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:15 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)) 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:15 INFO - Running setup.py (path:/tmp/pip-PMpbkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:15 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)) 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:15 INFO - Running setup.py (path:/tmp/pip-Un4Rbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:15 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)) 00:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:15 INFO - Running setup.py (path:/tmp/pip-YwS1eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:16 INFO - Running setup.py (path:/tmp/pip-zXPosX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:16 INFO - Running setup.py (path:/tmp/pip-QCGz6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:16 INFO - Running setup.py (path:/tmp/pip-LXbqCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:16 INFO - Running setup.py (path:/tmp/pip-oUIQd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:16 INFO - Running setup.py (path:/tmp/pip-ptv3F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:16 INFO - Running setup.py (path:/tmp/pip-xk0yay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:16 INFO - Running setup.py (path:/tmp/pip-dOFymW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:16 INFO - Running setup.py (path:/tmp/pip-6qOwYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:16 INFO - Running setup.py (path:/tmp/pip-x7zT5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:16 INFO - Running setup.py (path:/tmp/pip-f_M3iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:16 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)) 00:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:16 INFO - Running setup.py (path:/tmp/pip-chdP1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38:18 INFO - Downloading blessings-1.6.tar.gz 00:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:38:18 INFO - Installing collected packages: blessings 00:38:18 INFO - Running setup.py install for blessings 00:38:18 INFO - Successfully installed blessings 00:38:18 INFO - Cleaning up... 00:38:19 INFO - Return code: 0 00:38:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:19 INFO - Reading from file tmpfile_stdout 00:38:19 INFO - Current package versions: 00:38:19 INFO - argparse == 1.2.1 00:38:19 INFO - blessings == 1.6 00:38:19 INFO - blobuploader == 1.2.4 00:38:19 INFO - docopt == 0.6.1 00:38:19 INFO - functools32 == 3.2.3-2 00:38:19 INFO - jsonschema == 2.5.1 00:38:19 INFO - manifestparser == 1.1 00:38:19 INFO - mozInstall == 1.12 00:38:19 INFO - mozcrash == 0.17 00:38:19 INFO - mozdebug == 0.1 00:38:19 INFO - mozdevice == 0.48 00:38:19 INFO - mozfile == 1.2 00:38:19 INFO - mozhttpd == 0.7 00:38:19 INFO - mozinfo == 0.9 00:38:19 INFO - mozleak == 0.1 00:38:19 INFO - mozlog == 3.3 00:38:19 INFO - moznetwork == 0.27 00:38:19 INFO - mozprocess == 0.23 00:38:19 INFO - mozprofile == 0.28 00:38:19 INFO - mozrunner == 6.12 00:38:19 INFO - mozscreenshot == 0.1 00:38:19 INFO - mozsystemmonitor == 0.3 00:38:19 INFO - moztest == 0.7 00:38:19 INFO - mozversion == 1.4 00:38:19 INFO - psutil == 3.1.1 00:38:19 INFO - requests == 1.2.3 00:38:19 INFO - wsgiref == 0.1.2 00:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38: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')]} 00:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38: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')]} 00:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:19 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 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38:19 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 00:38:19 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 00:38:19 INFO - Using env: {'DISPLAY': ':0', 00:38:19 INFO - 'HOME': '/home/cltbld', 00:38:19 INFO - 'LANG': 'en_US.UTF-8', 00:38:19 INFO - 'LANGUAGE': 'en_US:en', 00:38:19 INFO - 'LOGNAME': 'cltbld', 00:38:19 INFO - 'MAIL': '/var/mail/cltbld', 00:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:19 INFO - 'MOZ_NO_REMOTE': '1', 00:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:19 INFO - 'NO_EM_RESTART': '1', 00:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:19 INFO - 'PWD': '/builds/slave/test', 00:38:19 INFO - 'SHELL': '/bin/bash', 00:38:19 INFO - 'SHLVL': '1', 00:38:19 INFO - 'TERM': 'linux', 00:38:19 INFO - 'TMOUT': '86400', 00:38:19 INFO - 'USER': 'cltbld', 00:38:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:19 INFO - '_': '/tools/buildbot/bin/python'} 00:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 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)) 00:38:19 INFO - Cleaning up... 00:38:19 INFO - Return code: 0 00:38:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:38: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')]} 00:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38: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')]} 00:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51640dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ab230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, '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': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', '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 00:38: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', 'jsonschema'] in /builds/slave/test/build 00:38: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 jsonschema 00:38:19 INFO - Using env: {'DISPLAY': ':0', 00:38:19 INFO - 'HOME': '/home/cltbld', 00:38:19 INFO - 'LANG': 'en_US.UTF-8', 00:38:19 INFO - 'LANGUAGE': 'en_US:en', 00:38:19 INFO - 'LOGNAME': 'cltbld', 00:38:19 INFO - 'MAIL': '/var/mail/cltbld', 00:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:19 INFO - 'MOZ_NO_REMOTE': '1', 00:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:19 INFO - 'NO_EM_RESTART': '1', 00:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:19 INFO - 'PWD': '/builds/slave/test', 00:38:19 INFO - 'SHELL': '/bin/bash', 00:38:19 INFO - 'SHLVL': '1', 00:38:19 INFO - 'TERM': 'linux', 00:38:19 INFO - 'TMOUT': '86400', 00:38:19 INFO - 'USER': 'cltbld', 00:38:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:19 INFO - '_': '/tools/buildbot/bin/python'} 00:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:38:19 INFO - Cleaning up... 00:38:19 INFO - Return code: 0 00:38:19 INFO - Running post-action listener: _resource_record_post_action 00:38:19 INFO - Running post-action listener: _start_resource_monitoring 00:38:19 INFO - Starting resource monitoring. 00:38:19 INFO - [mozharness: 2016-08-26 07:38:19.706209Z] Finished create-virtualenv step (success) 00:38:19 INFO - [mozharness: 2016-08-26 07:38:19.706718Z] Running install step. 00:38:19 INFO - Running pre-action listener: _resource_record_pre_action 00:38:19 INFO - Running main action method: install 00:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:19 INFO - Reading from file tmpfile_stdout 00:38:19 INFO - Detecting whether we're running mozinstall >=1.0... 00:38:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:38:19 INFO - Reading from file tmpfile_stdout 00:38:19 INFO - Output received: 00:38:19 INFO - Usage: mozinstall [options] installer 00:38:19 INFO - Options: 00:38:19 INFO - -h, --help show this help message and exit 00:38:19 INFO - -d DEST, --destination=DEST 00:38:19 INFO - Directory to install application into. [default: 00:38:19 INFO - "/builds/slave/test"] 00:38:19 INFO - --app=APP Application being installed. [default: firefox] 00:38:19 INFO - mkdir: /builds/slave/test/build/application 00:38:19 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'] 00:38:19 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 00:38:36 INFO - Reading from file tmpfile_stdout 00:38:36 INFO - Output received: 00:38:36 INFO - /builds/slave/test/build/application/firefox/firefox 00:38:36 INFO - Running post-action listener: _resource_record_post_action 00:38:36 INFO - [mozharness: 2016-08-26 07:38:36.239508Z] Finished install step (success) 00:38:36 INFO - [mozharness: 2016-08-26 07:38:36.239784Z] Running run-tests step. 00:38:36 INFO - Running pre-action listener: _resource_record_pre_action 00:38:36 INFO - Running main action method: run_tests 00:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:38:36 INFO - Python 2.7.3 00:38:36 INFO - Return code: 0 00:38:36 INFO - grabbing minidump binary from tooltool 00:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:36 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 0x28a5090>, '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 0x28a89b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a8e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:38:36 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 00:38:36 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 00:38:36 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 00:38:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:38:36 INFO - Return code: 0 00:38:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:38:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:38:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:38:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:38:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 00:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 00:38:36 INFO - Using env: {'DISPLAY': ':0', 00:38:36 INFO - 'HOME': '/home/cltbld', 00:38:36 INFO - 'LANG': 'en_US.UTF-8', 00:38:36 INFO - 'LANGUAGE': 'en_US:en', 00:38:36 INFO - 'LOGNAME': 'cltbld', 00:38:36 INFO - 'MAIL': '/var/mail/cltbld', 00:38:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:38:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:36 INFO - 'MOZ_NO_REMOTE': '1', 00:38:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:38:36 INFO - 'NO_EM_RESTART': '1', 00:38:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:36 INFO - 'PWD': '/builds/slave/test', 00:38:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:38:36 INFO - 'SHELL': '/bin/bash', 00:38:36 INFO - 'SHLVL': '1', 00:38:36 INFO - 'TERM': 'linux', 00:38:36 INFO - 'TMOUT': '86400', 00:38:36 INFO - 'USER': 'cltbld', 00:38:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472196383.759246-1603811790', 00:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:36 INFO - '_': '/tools/buildbot/bin/python'} 00:38:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 00:38:36 INFO - mozversion application_buildid: 20160825232117 00:38:36 INFO - mozversion application_changeset: 25037d50766284467cca32e3e1ffe739a6767bee 00:38:36 INFO - mozversion application_display_name: Nightly 00:38:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:38:36 INFO - mozversion application_name: Firefox 00:38:36 INFO - mozversion application_remotingname: firefox 00:38:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:38:36 INFO - mozversion application_vendor: Mozilla 00:38:36 INFO - mozversion application_version: 51.0a1 00:38:36 INFO - mozversion platform_buildid: 20160825232117 00:38:36 INFO - mozversion platform_changeset: 25037d50766284467cca32e3e1ffe739a6767bee 00:38:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:38:36 INFO - mozversion platform_version: 51.0a1 00:38:36 INFO - using testdate: 1472197116 00:38:36 INFO - actual date: 1472197116 00:38:36 INFO - starting webserver on 'localhost:41961' 00:38:36 INFO - SUITE-START | Running 2 tests 00:38:36 INFO - TEST-START | dromaeo_css 00:38:36 INFO - operating with platform_type : linux_ 00:38:36 INFO - Initialising browser for dromaeo_css test... 00:38:36 INFO - TEST-INFO | started process 29634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplg6epn/profile http://localhost:41961/getInfo.html) 00:38:41 INFO - PROCESS | 29634 | __metrics Screen width/height:1600/1200 00:38:41 INFO - PROCESS | 29634 | colorDepth:24 00:38:41 INFO - PROCESS | 29634 | Browser inner width/height: 1024/697 00:38:41 INFO - PROCESS | 29634 | __metrics 00:38:41 INFO - PROCESS | 29634 | 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" 00:38:41 INFO - PROCESS | 29634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:38:42 INFO - PROCESS | 29634 | console.error: PushService: 00:38:42 INFO - PROCESS | 29634 | stateChangeProcessEnqueue: Error transitioning state 00:38:42 INFO - PROCESS | 29634 | UnknownError 00:38:43 INFO - TEST-INFO | 29634: exit 0 00:38:43 INFO - Browser initialized. 00:38:43 INFO - Running cycle 1/1 for dromaeo_css test... 00:38:43 INFO - TEST-INFO | started process 29714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplg6epn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:55 INFO - PROCESS | 29714 | RSS: Main: 180637696 00:38:55 INFO - PROCESS | 29714 | 00:39:46 INFO - PROCESS | 29714 | 1472197186483 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] 00:41:59 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41961/tests/dromaeo/cssquery-ext.html) 00:42:01 INFO - PROCESS | 29714 | RSS: Main: 298008576 00:42:01 INFO - PROCESS | 29714 | 00:45:03 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-ext.html (next: http://localhost:41961/tests/dromaeo/cssquery-jquery.html) 00:45:04 INFO - PROCESS | 29714 | RSS: Main: 274378752 00:45:04 INFO - PROCESS | 29714 | 00:48:06 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41961/tests/dromaeo/cssquery-mootools.html) 00:48:07 INFO - PROCESS | 29714 | RSS: Main: 256790528 00:48:07 INFO - PROCESS | 29714 | 00:51:09 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41961/tests/dromaeo/cssquery-prototype.html) 00:51:10 INFO - PROCESS | 29714 | RSS: Main: 216551424 00:51:10 INFO - PROCESS | 29714 | 00:54:13 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41961/tests/dromaeo/cssquery-yui.html) 00:54:14 INFO - PROCESS | 29714 | RSS: Main: 219992064 00:54:14 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:41961/tests/dromaeo/cssquery-yui.html (next: http://localhost:41961/tests/dromaeo/cssquery-dojo.html) 00:57:17 INFO - PROCESS | 29714 | RSS: Main: 317190144 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | __start_tp_report 00:57:17 INFO - PROCESS | 29714 | _x_x_mozilla_page_load 00:57:17 INFO - PROCESS | 29714 | _x_x_mozilla_page_load_details 00:57:17 INFO - PROCESS | 29714 | |i|pagename|runs| 00:57:17 INFO - PROCESS | 29714 | |0;dojo.html;2613.490369377971;2621.9868900655492;2626.7373262673736;2631.0396705202593;2680.370113023439;4534.909301813962;4598.011427543078;4677.906441871165;4764.237721964487;4842.29786680931;4636.605888499482;4642.117997580466;4652.953470465294;4654.534546545344;4709.623230141589;4313.676474264435;4371.27873900806;4380;4404.2512772828695;4439.4672639283335;4408.933865992013;4424.336349547561;4430.335449682541;4440;4453.28747400416;4312.116016216668;4433.290673492242;4490.236659767847;4501.212287849629;4505.36924830524;4241.1941731071;4281.721688090264;4397.31841564558;4418.116376724652;4459.665525085599;4252.638525725286;4275.0594869128745;4317.633001194902;4329.350597410382;4360.193364227596;4664.55686709762;4738.384010078667;4744.833930812405;4749.073930583538;4752.477227505006;4858.416989961192;5040.092783299005;5042.823501177441;5053.671511351788;5090.185570308733;4998.175301075318;5005.749712514396;5036.6726162799305;5037.269595908573;5118.539331460186;4683.6721429500285;4689.929651055237;4693.694909830884;4703.082898834695;4757.595604373598;4965.35450391454;5125.589952803767;5136.948630513722;5143.897122057613;5185.429602743695;4975;5025.597952163818;5034.043531729033;5046.343975283263;5088.745562721849;5102.566281866083;5116.692998420107;5117.283580298761;5121.692698438105;5179.430262671103;4828.106800241966;5069.569086627678;5084.211947148124;5085.0338435697095;5088.6946783193125;4956.157453232959;5013.273075404046;5023.120953833065;5048.798048078109;5051.722155281494;4237.491501019897;4244.575542445731;4279.40088387626;4289.571042895748;4295.591918767712;3721.5162028936606;3724.8696295629525;3730.2539492101146;3763.172102137525;3771.340015497332;4250.638695710899;4333.674974376934;4365.934510982338;4366.672499562545;4418.248897687401;5045.596352291881;5083.983203359343;5084.3898732152375;5151.459096794782;5151.459096794858;4337.7180483268485;4370.868873933787;4372.540883207217;4373.781310934504;4426.623736982328;4389.297712366006;4478.910421791611;4535.206338890747;4545.431821022372;4600.401947746772;4701.03628756111;4717.127331443694;4765.35667684872;4768.451628062817;4771.498992605726;5092.821751238689;5105.923411148761;5111.05445492585;5115.64190506661;5137.8715532112;4748.952510474851;4754.904901902012;4759.119562880878;4761.16679581065;4817.253325734517;4833.275008748576;4966.478519755374;5018.096742586224;5032.6980381177245;5102.846914592568;5105.974470127626;5106.565941894981;5116.590672746246;5126.806112882968;5128.948710512847;4983.227599722049;4984.651074424755;4989.276554899447;4989.675671081368;5036.420811606712;4742.454617719007;4868.659193856396;4887.193613053806;4904.8773780655765;4996.975015124901;4834.395700537433;4841.661083724105;4852.344933433941;4854.0508339953185;4912.336834527293;4742.976285118552;4823.3729615149805;4917.385326834145;4940.7035577865445;4958.404991401055;4859.708417494961;4929.507049295042;4948.257761335828;4951.480094590016;5009.198528235464 00:57:17 INFO - PROCESS | 29714 | |1;ext.html;571.3201290464347;573.7590212110913;582.2983305117334;583.5506659871899;585.8008277185758;27592.17223483296;30309.545356819664;30655.38689226214;30704.232394190156;30752.38495230094;31174.688253117463;39587.80206098973;40609;40750.18499630006;44672.3299150513;7641.465097443182;7759.883601745978;7762.922370776305;7766.37868970481;7768.145503994584;7627.923720762805;7715.691372345127;7718.305352518272;7726.072871255429;7754.224577542257;7756.224377562226;7778.727744528943;7801.7907224380315;7828.099768526607;7838.098618658842;7727.497712648688;7770.494917830323;7776.105747839014;7776.844463110762;7778.338841198477;7614.086309642823;7675.3859691225125;7682.654280557333;7682.7311044113185;7687.961560192163;38459.615403845884;38803.611963880285;38889.41665875014;38932.22135557273;38960;3079.9230019249476;3110.875564977398;3121.750259979196;3181.984090079558;3434.6050204226585;27810.860945695345;28522.572161417596;28591.57112643312;28611.71388286132;28634.570481442588;3260.2012506935716;3288.6875746804017;3355.144438168276;3528.1356067763563;3529.3117842020815;267525;269389.6530517354;269653.55196720647;270091;270589;54509.72745136249;55169;55521;55540;55627.44372556303;32189.356212875613;33112.50331245033;58478.415215848145;58593.70703146542;58624.4137558619;14640.560783176521;14905.254737263094;14948.476803311833;14973.625659358386;14979.925100374647;11222.719432014102;11303.773924521627;11314.943425282985;11318.490667919963;11319.886801132048;17729.822701772817;17802.287908483773;17808.91095544514;17840.821591784177;17843.910780446015;6602.405783479414;6628.767993120314;6835.624040677811;6902.5150945659525;7060.470464715064;781.3280578702312;886.1537231943479;897.4794619121025;933.5892207428709;975.2441857560448;26591.20226393211;27140.728592714215;27383.041593544527;27618.8238352588;27804;944.15026476172;967.264878692199;979.1823827104448;986.3391527676474;1025.6717850287985;14494.927525362305;14635.707285854223;14668.853311466963;14884.330205140577;14970.101793892401;364584;366834;367278;367301;367392;48676;49171.75414122907;49315.753421233385;49320;49357.753211233714;1048.638219814163;1094.600470828158;1144.5021415684205;1188.1326631559011;1192.4097571702064;26935.191944241706;28005.29986750266;28241.57637635396;28594.857025714737;28834.27914302159;41364.586354136074;41836.3724544126;41893.79053104715;41968.580314196464;41999.58000419957;290047;290990;291705;291736;292601;21822.781772182076;23556.175533856233;24243.757562424857;25000;25028.374290642878;40080.59919400885;40706.59293407028;40787.38818917659;41171.58828411797;41621.167576648906;33031.66968330286;36017.819910900274;36145.81927090348;36589.26821463609;36684.082897927765;35481.11297217487;35532.289354212255;35842.28315433625;35967.460488093224;36387;34936.30127397489;35201.64798352086;35538.82230588831;35837;36263.81868090643;30964.535531966587;32984.34031319408;33316.500252495745;33483.66516334806;33707.831460842535;24794.25617231486;25029.249122526355;25236.24291271265;25403.13320619455;25808.870955645103 00:57:17 INFO - PROCESS | 29714 | |2;jquery.html;341.7334479106295;365.13463092470846;366.9541307336583;368.1201927393529;385.4488082042678;12467;16037.117958512277;16095.75856362154;16949.91525042373;17207;16414.261358238877;16567.91716041421;17350.305987760476;17490.125493725296;17530.561735956606;4993.75031248438;4994.825181118662;5148.613853960949;5183.585313174937;5195.974020129913;3596.2088340565033;5087.338645976018;5173.5861131109605;5175.146100893348;5587.804426845061;5857.150713146591;5891.734871930774;5967.134765459005;5967.134765459027;5968.01527747921;5750.252467179282;5960.7019649017375;6101.725422356005;6122.8775424491705;6149.938500614981;5409.891802163974;5410.675359478444;5412.648177868466;5414.675119492843;5415.83752487422;21087.8945605271;21333.67999480009;21866.23468178606;21963.780362196332;22145.889270553544;1944.9124789384512;2162.9223219723735;2357.1400167017823;2526.873656317177;2571.7338979495935;12746.936265318614;13100.148490348192;13273.203607783467;13385.933070334684;13666.453341866314;1766.832150945671;1772.237937686794;1773.423637317877;1788.5707430216655;1811.80975997521;71971.64014179895;72063.2793672067;73407.26592734057;73632.63183684101;74576;9405.71782846502;9562.18721408688;9651.951740241253;9809.607615695293;10024.348417352849;13486.93256533711;13522.729545409036;13550.796738048937;13562.254076025913;13568.321583920962;7119.181294151239;7363.300486453778;7405.333519983227;7578.4316176287;7596.430267729942;7005.229424763272;7025.367716905503;7274.090738657668;7281.490295679358;7294.8905766413545;6064.848378790565;6189.96905015472;6207.131001659771;6239.313675495692;6278.340774218641;1792.865535084874;1812.909354532268;1822.6536957977942;1831.560425497871;1868.9252429902651;740.9036825212688;850.5067061104545;853.4623187391903;891.3537685178323;948.990510094904;16044.358225670843;16422.589435263973;16546.751798723028;16571.337146514004;17396;818.9549574773445;849.5497386385226;853.8335024670254;877.1491653096487;883.5217215709995;8902.465852048897;8998;9032.064579011847;9772.95113524442;9885.25860560461;174993;394333;396665;397591;399791;81511;82360;84152;84604.57697711595;85037.57481212678;884.6815146547237;921.3090182363228;928.1831987850783;928.3872644054892;935.7239614313658;14927.328270227648;15663;15942.760858587362;15995.280212390238;16976.830231697524;35844.820775895954;37584;38947.415788763756;40593.797031014656;41201.1759764809;49869.75065124651;50722.746386267834;51136.74431627818;51980.480195199074;52662;7665.156832748282;7713.2286771322415;7812.140664527011;7886.250806173404;8002.239507308383;9407.294452915921;12252.448639811051;12371.938140309241;12401.441935112762;12577.748445031231;10285.125764310118;10498.947505262426;10604.734881628021;10729.785404292026;10778.407187604756;10638.946805265925;10703.411312377582;10751.6236931707;10759.569617215537;11129.610463633733;10748.247622666338;11000.834987475035;11023.338599684044;11141.72145696364;11187.552497899993;7904.486208396436;8058.274755272054;8099.757007289791;8155;8244.917550824415;10476.319039262424;10512.632057877938;10522.579096836042;10671.253012289066;11031.172662050218 00:57:17 INFO - PROCESS | 29714 | |3;mootools.html;1235.209465941797;1353.0393420671323;1392.7423426666066;1453.9418423263064;1668.3910372713956;7545.584992825392;7877.369810415167;7947.125816160218;8092.716754913579;8103.878441823377;7791.376689864811;7897.802554936129;7909.288164065233;7910.485818421798;7913.525188488695;1866.178881292227;2176.9020394082304;2212.4911270407815;2244.16965722682;2247.83141264405;2185.562887422514;2200.8459407841456;2204.8787316697576;2204.9669254961186;2207.4812419081504;2212.623853944833;2233.2630232023394;2247.4718441166315;2254.3349711834967;2255.9210427635035;2124.2352753008904;2168.8590241634242;2179.052112331125;2180.3349978256547;2214.1143542582936;2202.2402271216565;2222.0889435331437;2222.4554984029014;2222.7110475638065;2226.6214743493647;8145.877811832827;8173.060098088737;8197.221263979913;8200.876986845202;8205.466644668077;4560.498345182027;4704.200285951397;4707.670463067587;4712.198926182557;4716.221823399135;2867.211516832867;2874.5113330733825;3027.3339865229837;3035.3777475617444;3038.2100653829943;975.9414435133915;989.4706332112357;1000.1298869983161;1001.5993602559034;1006.4665727164614;10396.792064158675;10437.2693911427;10439.164866810637;10445.425501597409;10515.894841051568;3984.641382275609;4150.315197992358;4321.416608757778;4426.1369033038245;4433.534478879736;8623.611937462829;8701.390902636882;8710.869336959951;8721.869171962426;8738.126187381211;4574.176648203355;4574.245249533857;4574.679772415899;4575.702579332333;4576.405067341224;3568.892933211956;4028.91942161161;4119.114390406017;4273.67947403946;4279.422277992431;3415.1803567143706;3433;3543.6633519815578;3564.946525802115;3574.4102223133414;1039.9116075133547;1047.2930771729052;1053.6680945502142;1054.2409465185056;1056.9894301057045;704.5103652961143;772.6716145638081;841.3479553346083;853.8761879527434;880.3969281042379;5560.944390556124;5634.971825140848;5718.599698021182;5740.712964351849;5884.676342801187;859.9183077607618;868.7914900423852;878.543157558079;899.2446345070173;916.4134953629682;3633.255182687543;3713.8514459421863;3723.627637236309;3831.9616803832164;3909.139989202371;9685.661001865043;9857.802843943082;9957.900420995842;9962;10070.345427547187;9929.553170107363;9933.50332483373;9934.552945117342;9935.403875767477;9973.152282056106;7281.963590182015;7388.741394051182;7390.5196162249285;7405.7778266652085;7435.367993720486;5559.33288005442;5565.638233514808;5621.213030175697;5652.123920792284;5700.914486282792;9078.45529268246;9142.131497507726;9153.588088535898;9180;9241.075892410705;8413;8770.210681038738;8771.912280877365;9054;9238.676646317346;6141.662208578392;6721.092652491851;6942.201646810681;6954.652267386509;7125.75059872902;7642.273983971514;7765.262300081483;7769.92230077692;7777.105632852295;7781.494202876795;6850.725970961105;6952.965235173791;6971.930280697128;7004.754833581004;7108.324709152622;6718.428933540508;6841.281665425257;6912.93087069143;6915.273896240822;6969.16370035599;6500.772472963424;6572.277049524644;6598.152517295165;6664.200295964515;6707.3292670732535;4735.810567577259;4763.642726795573;4831.323614694016;4847.030593881308;4868.902621947612;4742.288656701522;4760.857174284777;4832.202686556679;4842;5019.623528235324 00:57:17 INFO - PROCESS | 29714 | |4;prototype.html;275.3776465188673;287.587312206983;290.49598945828984;291.85407296351826;297.1027496959183;4610.285405762103;4700.811967521295;4824.155772739769;4861.1492988727005;4895.902081958358;4761.619070474362;4768.690035147722;4773.427188737356;4776.665633405663;4806.231003039506;3772.9058573013863;3783.451399547064;3786.924261514768;3788.299164654534;3791.0901383667997;3564.786112833225;3583.623719509453;3775;3792.5259342582176;3813.733038687293;3717.516722826029;3729.4592284118785;3739.682127019193;3748.718846086541;3758.2793034895394;3739.2334571412794;3765.265773174232;3767.077066118805;3772.1701225730294;3779.7165212609166;3307.355065762177;3308.652591477908;3323.587475322978;3336.9833150834093;3345.46472564391;4648;4676.719396836201;4713.622910167179;4723.527647235283;4730.929036064462;4298.828046878121;4305.526392096866;4306.160298741746;4307.569243075699;4314.590113939171;5030.471800460936;5046.318746969149;5076.162433198518;5088.414832294259;5091.79632814687;3561.3767590671528;3564.8395822187804;3624.4925710400566;3655.744097913147;3658.3414985302634;5229.764660590283;5233.607479439019;5235.869103272411;5239.633225674204;5262.290085489721;3706.814659267026;3707.8331475083687;3712.5706602958057;3713.2387860488534;3716.572594151653;3765.7781908674015;3766.981165094212;3808.086059345737;3808.904777380588;3810.657040866335;4189.748615083044;4222.408862759216;4258.638015768633;4269.4449721536;4298.333758267474;4952.455229924705;4976.377952755905;4977.90044199114;4983.401991761012;4997.350344455198;1230.5508489401484;1243.042857000105;1273.5287943460978;1282.6344491819787;1289.0010242062476;867.7266661001764;870.5212133326645;887.0109827542244;892.5537231384308;894.4812009034745;4398.69209155356;4407.228734971367;4421.408293014512;4428.734275943454;4440.4671439427475;5112.258722485219;5128.461511541309;5133.563647089964;5145.742712864342;5147.3308469898675;4378.233809083397;4391.5827996340295;4403.625691816167;4407.669424793154;4419.558044195554;2312.231143175472;2442.242904699549;2442.9983706680177;2447.180194634782;2453.3562513116253;4289.549597292302;4304.5480224576595;4310.52584215736;4311.461067366579;4344.45694288214;4640.329481386698;4660.836870709509;4663.88066863957;4670.949036466768;4699.002923757389;4322.762248076323;4486.932696009562;4836.830710925171;4875.317455556154;4886.462489126265;5207.635465517377;5207.71357575337;5216.9739151304;5220.556252718561;5243.973780131075;5111.3355263815465;5113.181890897438;5131.153359695609;5132.897342053213;5137.458762371349;4686.89857883404;4822.348982887265;4845.830395936126;4851.563359297539;4863.610911127031;3619.8190090495896;3644.8359823808523;3648.908777280589;3649.927001459903;3662.8717994870053;4948.752562371939;5164.115097989282;5170.508801663836;5176.767045482887;5181.171012637959;4875.829800847842;4992.400911890596;4992.550670439678;5006.499350064964;5007.899842003212;5014.899702005867;5025.39695236574;5032.672876263031;5046.1673823818655;5049.899002020013;4892.877678058077;4967.677100988424;4998.2502624606595;5001.924971125509;5004.2493625956395;5067.442581316126;5085.567726743268;5122.282880396822;5122.359705036871;5127.2052831811125;5006.899862002667;5007.37407824022;5009.273655319886;5014.122528557415;5032.295478632921 00:57:17 INFO - PROCESS | 29714 | |5;yui.html;628.9528285378598;629.1443636654151;663.777634492445;666.1972323350363;749.1983577571997;13227.801582976252;14370.712585748279;14374.568762937102;14376.209308488029;14424.783628245585;13426;13567.45730170792;13602.455901763917;13618.182909025465;13632.591022269347;605.8152263559613;727.5380133615166;727.8617062758085;745.7837227204104;753.5742305597347;743.2753065760867;750.1710609776201;750.8047907544023;752.3266676324686;752.7440670172141;789.2265579731866;789.8617741895174;790.4466873188762;790.8734602463607;791.936645068396;624.0514418084532;762.6606160258688;782.3467404717068;783.8745800671894;788.3456730913385;581.1486172756931;581.5405829394773;581.869079457123;581.9272590926134;582.2925145947694;12410.503579856795;12429.192102513307;12432.316222607753;12434.067444941666;12437.253764774143;12324.81512777309;12349.135560510767;12827.486900523967;12842.165259258118;13138.540151094761;11580.768384632345;11954;12136.211146275464;12204.02367810573;12819.294938778457;4010.418489319062;4065.10567675111;4123.402106694542;4169.812358443877;4170.35359519275;62631.6868415655;62906.37093629051;63007;63363.683181583794;64122.358776412104;10096.394216346896;10230.079292863678;10556.894431055745;10632.149428045737;10640.521176547074;18872.905635471736;19001.14494847735;19093.522661933563;19181.80818191828;19498.902505487382;6649.867002659919;6744.224414192333;6820.897686534706;6855.348741869514;6987.231404545496;3686.170611612366;3706.6478684524927;3729.1236559408517;3730.2725968435893;3809.3524100902914;2844.928876778056;2915.8833646653898;2933.193371822766;2937.3390987027747;2937.4125174965093;538.5207165622598;541.3179393963555;549.5411331538211;550.6943646276355;555.88604336111;541.6939429222556;560.8962341966749;571.9113537401627;573.2404563952779;581.3459857660132;7674.57789821554;7711.768646940601;7827.452078354574;7836.529808211526;8152.592370381457;528.577138289367;529.5736931769962;542.1677724692578;577.9479846813807;580.7502773807304;3628.727845411605;3725.441183822394;3908.3160446921675;3956.1296514766705;4029.1135950090934;100464;104298;104415.4779226099;104582;106802.46598767112;66571.66714166399;71376;74255.25744742592;77591;81264;43492.782536087114;50129.24806127911;51707;68171.65914170397;69290;8179.427440079137;8518.74443766688;8530.189631984951;8543.231109200202;8626.568671566522;42172.367414488195;42930;43208.35187472253;43580;43908.78045609751;59399.40600593939;61507.38492615196;61589.384106158366;61662;62237;10104.64633737845;10201.897981020094;10543.789124217627;10570.8414373786;11002.229843910849;12656.517072782937;13390.129641573267;13435.12671676338;13540.255285959367;13938.860611393757;12044.156909016285;12410.81383779226;12575.308358040396;12678.936605316914;13186;12778.869177051682;12865.228086314477;13017.716153490066;13084.869151308365;13367.532136375181;11552.768944621228;11710.180287379802;12114.333711645591;12114.333711645944;12137.696557585778;9800.705978820646;10402.011808878144;10445.11216546602;10501.760694174278;10690.893091069302;9836.852447213441;10291;10357;10363.740906477398;10376.948115259376 00:57:17 INFO - PROCESS | 29714 | __end_tp_report 00:57:17 INFO - PROCESS | 29714 | __start_cc_report 00:57:17 INFO - PROCESS | 29714 | _x_x_mozilla_cycle_collect,1030 00:57:17 INFO - PROCESS | 29714 | __end_cc_report 00:57:17 INFO - PROCESS | 29714 | __startTimestamp1472198237661__endTimestamp 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | ------- Summary: start ------- 00:57:17 INFO - PROCESS | 29714 | Number of tests: 6 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#0] dojo.html Cycles:165 Average:4677.37 Median:4765.36 stddev:492.21 (10.3%) stddev-sans-first:466.33 00:57:17 INFO - PROCESS | 29714 | Values: 2613.5 2622.0 2626.7 2631.0 2680.4 4534.9 4598.0 4677.9 4764.2 4842.3 4636.6 4642.1 4653.0 4654.5 4709.6 4313.7 4371.3 4380.0 4404.3 4439.5 4408.9 4424.3 4430.3 4440.0 4453.3 4312.1 4433.3 4490.2 4501.2 4505.4 4241.2 4281.7 4397.3 4418.1 4459.7 4252.6 4275.1 4317.6 4329.4 4360.2 4664.6 4738.4 4744.8 4749.1 4752.5 4858.4 5040.1 5042.8 5053.7 5090.2 4998.2 5005.7 5036.7 5037.3 5118.5 4683.7 4689.9 4693.7 4703.1 4757.6 4965.4 5125.6 5136.9 5143.9 5185.4 4975.0 5025.6 5034.0 5046.3 5088.7 5102.6 5116.7 5117.3 5121.7 5179.4 4828.1 5069.6 5084.2 5085.0 5088.7 4956.2 5013.3 5023.1 5048.8 5051.7 4237.5 4244.6 4279.4 4289.6 4295.6 3721.5 3724.9 3730.3 3763.2 3771.3 4250.6 4333.7 4365.9 4366.7 4418.2 5045.6 5084.0 5084.4 5151.5 5151.5 4337.7 4370.9 4372.5 4373.8 4426.6 4389.3 4478.9 4535.2 4545.4 4600.4 4701.0 4717.1 4765.4 4768.5 4771.5 5092.8 5105.9 5111.1 5115.6 5137.9 4749.0 4754.9 4759.1 4761.2 4817.3 4833.3 4966.5 5018.1 5032.7 5102.8 5106.0 5106.6 5116.6 5126.8 5128.9 4983.2 4984.7 4989.3 4989.7 5036.4 4742.5 4868.7 4887.2 4904.9 4997.0 4834.4 4841.7 4852.3 4854.1 4912.3 4743.0 4823.4 4917.4 4940.7 4958.4 4859.7 4929.5 4948.3 4951.5 5009.2 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#1] ext.html Cycles:180 Average:46068.04 Median:35839.64 stddev:81988.78 (228.8%) stddev-sans-first:82147.62 00:57:17 INFO - PROCESS | 29714 | Values: 571.3 573.8 582.3 583.6 585.8 27592.2 30309.5 30655.4 30704.2 30752.4 31174.7 39587.8 40609.0 40750.2 44672.3 7641.5 7759.9 7762.9 7766.4 7768.1 7627.9 7715.7 7718.3 7726.1 7754.2 7756.2 7778.7 7801.8 7828.1 7838.1 7727.5 7770.5 7776.1 7776.8 7778.3 7614.1 7675.4 7682.7 7682.7 7688.0 38459.6 38803.6 38889.4 38932.2 38960.0 3079.9 3110.9 3121.8 3182.0 3434.6 27810.9 28522.6 28591.6 28611.7 28634.6 3260.2 3288.7 3355.1 3528.1 3529.3 267525.0 269389.7 269653.6 270091.0 270589.0 54509.7 55169.0 55521.0 55540.0 55627.4 32189.4 33112.5 58478.4 58593.7 58624.4 14640.6 14905.3 14948.5 14973.6 14979.9 11222.7 11303.8 11314.9 11318.5 11319.9 17729.8 17802.3 17808.9 17840.8 17843.9 6602.4 6628.8 6835.6 6902.5 7060.5 781.3 886.2 897.5 933.6 975.2 26591.2 27140.7 27383.0 27618.8 27804.0 944.2 967.3 979.2 986.3 1025.7 14494.9 14635.7 14668.9 14884.3 14970.1 364584.0 366834.0 367278.0 367301.0 367392.0 48676.0 49171.8 49315.8 49320.0 49357.8 1048.6 1094.6 1144.5 1188.1 1192.4 26935.2 28005.3 28241.6 28594.9 28834.3 41364.6 41836.4 41893.8 41968.6 41999.6 290047.0 290990.0 291705.0 291736.0 292601.0 21822.8 23556.2 24243.8 25000.0 25028.4 40080.6 40706.6 40787.4 41171.6 41621.2 33031.7 36017.8 36145.8 36589.3 36684.1 35481.1 35532.3 35842.3 35967.5 36387.0 34936.3 35201.6 35538.8 35837.0 36263.8 30964.5 32984.3 33316.5 33483.7 33707.8 24794.3 25029.2 25236.2 25403.1 25808.9 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#2] jquery.html Cycles:180 Average:23890.79 Median:45535.46 stddev:60565.44 (133.0%) stddev-sans-first:60709.53 00:57:17 INFO - PROCESS | 29714 | Values: 341.7 365.1 367.0 368.1 385.4 12467.0 16037.1 16095.8 16949.9 17207.0 16414.3 16567.9 17350.3 17490.1 17530.6 4993.8 4994.8 5148.6 5183.6 5196.0 3596.2 5087.3 5173.6 5175.1 5587.8 5857.2 5891.7 5967.1 5967.1 5968.0 5750.3 5960.7 6101.7 6122.9 6149.9 5409.9 5410.7 5412.6 5414.7 5415.8 21087.9 21333.7 21866.2 21963.8 22145.9 1944.9 2162.9 2357.1 2526.9 2571.7 12746.9 13100.1 13273.2 13385.9 13666.5 1766.8 1772.2 1773.4 1788.6 1811.8 71971.6 72063.3 73407.3 73632.6 74576.0 9405.7 9562.2 9652.0 9809.6 10024.3 13486.9 13522.7 13550.8 13562.3 13568.3 7119.2 7363.3 7405.3 7578.4 7596.4 7005.2 7025.4 7274.1 7281.5 7294.9 6064.8 6190.0 6207.1 6239.3 6278.3 1792.9 1812.9 1822.7 1831.6 1868.9 740.9 850.5 853.5 891.4 949.0 16044.4 16422.6 16546.8 16571.3 17396.0 819.0 849.5 853.8 877.1 883.5 8902.5 8998.0 9032.1 9773.0 9885.3 174993.0 394333.0 396665.0 397591.0 399791.0 81511.0 82360.0 84152.0 84604.6 85037.6 884.7 921.3 928.2 928.4 935.7 14927.3 15663.0 15942.8 15995.3 16976.8 35844.8 37584.0 38947.4 40593.8 41201.2 49869.8 50722.7 51136.7 51980.5 52662.0 7665.2 7713.2 7812.1 7886.3 8002.2 9407.3 12252.4 12371.9 12401.4 12577.7 10285.1 10498.9 10604.7 10729.8 10778.4 10638.9 10703.4 10751.6 10759.6 11129.6 10748.2 11000.8 11023.3 11141.7 11187.6 7904.5 8058.3 8099.8 8155.0 8244.9 10476.3 10512.6 10522.6 10671.3 11031.2 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#3] mootools.html Cycles:180 Average:5229.95 Median:5563.29 stddev:2917.20 (52.4%) stddev-sans-first:2909.94 00:57:17 INFO - PROCESS | 29714 | Values: 1235.2 1353.0 1392.7 1453.9 1668.4 7545.6 7877.4 7947.1 8092.7 8103.9 7791.4 7897.8 7909.3 7910.5 7913.5 1866.2 2176.9 2212.5 2244.2 2247.8 2185.6 2200.8 2204.9 2205.0 2207.5 2212.6 2233.3 2247.5 2254.3 2255.9 2124.2 2168.9 2179.1 2180.3 2214.1 2202.2 2222.1 2222.5 2222.7 2226.6 8145.9 8173.1 8197.2 8200.9 8205.5 4560.5 4704.2 4707.7 4712.2 4716.2 2867.2 2874.5 3027.3 3035.4 3038.2 975.9 989.5 1000.1 1001.6 1006.5 10396.8 10437.3 10439.2 10445.4 10515.9 3984.6 4150.3 4321.4 4426.1 4433.5 8623.6 8701.4 8710.9 8721.9 8738.1 4574.2 4574.2 4574.7 4575.7 4576.4 3568.9 4028.9 4119.1 4273.7 4279.4 3415.2 3433.0 3543.7 3564.9 3574.4 1039.9 1047.3 1053.7 1054.2 1057.0 704.5 772.7 841.3 853.9 880.4 5560.9 5635.0 5718.6 5740.7 5884.7 859.9 868.8 878.5 899.2 916.4 3633.3 3713.9 3723.6 3832.0 3909.1 9685.7 9857.8 9957.9 9962.0 10070.3 9929.6 9933.5 9934.6 9935.4 9973.2 7282.0 7388.7 7390.5 7405.8 7435.4 5559.3 5565.6 5621.2 5652.1 5700.9 9078.5 9142.1 9153.6 9180.0 9241.1 8413.0 8770.2 8771.9 9054.0 9238.7 6141.7 6721.1 6942.2 6954.7 7125.8 7642.3 7765.3 7769.9 7777.1 7781.5 6850.7 6953.0 6971.9 7004.8 7108.3 6718.4 6841.3 6912.9 6915.3 6969.2 6500.8 6572.3 6598.2 6664.2 6707.3 4735.8 4763.6 4831.3 4847.0 4868.9 4742.3 4760.9 4832.2 4842.0 5019.6 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#4] prototype.html Cycles:180 Average:4139.68 Median:4662.36 stddev:1205.37 (25.9%) stddev-sans-first:1173.34 00:57:17 INFO - PROCESS | 29714 | Values: 275.4 287.6 290.5 291.9 297.1 4610.3 4700.8 4824.2 4861.1 4895.9 4761.6 4768.7 4773.4 4776.7 4806.2 3772.9 3783.5 3786.9 3788.3 3791.1 3564.8 3583.6 3775.0 3792.5 3813.7 3717.5 3729.5 3739.7 3748.7 3758.3 3739.2 3765.3 3767.1 3772.2 3779.7 3307.4 3308.7 3323.6 3337.0 3345.5 4648.0 4676.7 4713.6 4723.5 4730.9 4298.8 4305.5 4306.2 4307.6 4314.6 5030.5 5046.3 5076.2 5088.4 5091.8 3561.4 3564.8 3624.5 3655.7 3658.3 5229.8 5233.6 5235.9 5239.6 5262.3 3706.8 3707.8 3712.6 3713.2 3716.6 3765.8 3767.0 3808.1 3808.9 3810.7 4189.7 4222.4 4258.6 4269.4 4298.3 4952.5 4976.4 4977.9 4983.4 4997.4 1230.6 1243.0 1273.5 1282.6 1289.0 867.7 870.5 887.0 892.6 894.5 4398.7 4407.2 4421.4 4428.7 4440.5 5112.3 5128.5 5133.6 5145.7 5147.3 4378.2 4391.6 4403.6 4407.7 4419.6 2312.2 2442.2 2443.0 2447.2 2453.4 4289.5 4304.5 4310.5 4311.5 4344.5 4640.3 4660.8 4663.9 4670.9 4699.0 4322.8 4486.9 4836.8 4875.3 4886.5 5207.6 5207.7 5217.0 5220.6 5244.0 5111.3 5113.2 5131.2 5132.9 5137.5 4686.9 4822.3 4845.8 4851.6 4863.6 3619.8 3644.8 3648.9 3649.9 3662.9 4948.8 5164.1 5170.5 5176.8 5181.2 4875.8 4992.4 4992.6 5006.5 5007.9 5014.9 5025.4 5032.7 5046.2 5049.9 4892.9 4967.7 4998.3 5001.9 5004.2 5067.4 5085.6 5122.3 5122.4 5127.2 5006.9 5007.4 5009.3 5014.1 5032.3 00:57:17 INFO - PROCESS | 29714 | 00:57:17 INFO - PROCESS | 29714 | [#5] yui.html Cycles:180 Average:17298.44 Median:4146.61 stddev:24252.51 (584.9%) stddev-sans-first:24288.24 00:57:17 INFO - PROCESS | 29714 | Values: 629.0 629.1 663.8 666.2 749.2 13227.8 14370.7 14374.6 14376.2 14424.8 13426.0 13567.5 13602.5 13618.2 13632.6 605.8 727.5 727.9 745.8 753.6 743.3 750.2 750.8 752.3 752.7 789.2 789.9 790.4 790.9 791.9 624.1 762.7 782.3 783.9 788.3 581.1 581.5 581.9 581.9 582.3 12410.5 12429.2 12432.3 12434.1 12437.3 12324.8 12349.1 12827.5 12842.2 13138.5 11580.8 11954.0 12136.2 12204.0 12819.3 4010.4 4065.1 4123.4 4169.8 4170.4 62631.7 62906.4 63007.0 63363.7 64122.4 10096.4 10230.1 10556.9 10632.1 10640.5 18872.9 19001.1 19093.5 19181.8 19498.9 6649.9 6744.2 6820.9 6855.3 6987.2 3686.2 3706.6 3729.1 3730.3 3809.4 2844.9 2915.9 2933.2 2937.3 2937.4 538.5 541.3 549.5 550.7 555.9 541.7 560.9 571.9 573.2 581.3 7674.6 7711.8 7827.5 7836.5 8152.6 528.6 529.6 542.2 577.9 580.8 3628.7 3725.4 3908.3 3956.1 4029.1 100464.0 104298.0 104415.5 104582.0 106802.5 66571.7 71376.0 74255.3 77591.0 81264.0 43492.8 50129.2 51707.0 68171.7 69290.0 8179.4 8518.7 8530.2 8543.2 8626.6 42172.4 42930.0 43208.4 43580.0 43908.8 59399.4 61507.4 61589.4 61662.0 62237.0 10104.6 10201.9 10543.8 10570.8 11002.2 12656.5 13390.1 13435.1 13540.3 13938.9 12044.2 12410.8 12575.3 12678.9 13186.0 12778.9 12865.2 13017.7 13084.9 13367.5 11552.8 11710.2 12114.3 12114.3 12137.7 9800.7 10402.0 10445.1 10501.8 10690.9 9836.9 10291.0 10357.0 10363.7 10376.9 00:57:17 INFO - PROCESS | 29714 | -------- Summary: end -------- 00:57:17 INFO - PROCESS | 29714 | 00:57:18 INFO - TEST-INFO | 29714: exit 0 00:57:18 INFO - TEST-OK | dromaeo_css | took 1122195ms 00:57:18 INFO - TEST-START | kraken 00:57:18 INFO - operating with platform_type : linux_ 00:57:18 INFO - Initialising browser for kraken test... 00:57:18 INFO - TEST-INFO | started process 30013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNXD8e/profile http://localhost:41961/getInfo.html) 00:57:23 INFO - PROCESS | 30013 | __metrics Screen width/height:1600/1200 00:57:23 INFO - PROCESS | 30013 | colorDepth:24 00:57:23 INFO - PROCESS | 30013 | Browser inner width/height: 1024/697 00:57:23 INFO - PROCESS | 30013 | __metrics 00:57:24 INFO - PROCESS | 30013 | 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" 00:57:24 INFO - PROCESS | 30013 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:24 INFO - PROCESS | 30013 | console.error: PushService: 00:57:24 INFO - PROCESS | 30013 | stateChangeProcessEnqueue: Error transitioning state 00:57:24 INFO - PROCESS | 30013 | UnknownError 00:57:25 INFO - TEST-INFO | 30013: exit 0 00:57:25 INFO - Browser initialized. 00:57:25 INFO - Running cycle 1/1 for kraken test... 00:57:25 INFO - TEST-INFO | started process 30092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVNXD8e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:37 INFO - PROCESS | 30092 | RSS: Main: 180809728 00:57:37 INFO - PROCESS | 30092 | 00:57:40 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-beat-detection) 00:57:41 INFO - PROCESS | 30092 | RSS: Main: 234397696 00:57:41 INFO - PROCESS | 30092 | 00:57:44 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-dft) 00:57:44 INFO - PROCESS | 30092 | RSS: Main: 224133120 00:57:44 INFO - PROCESS | 30092 | 00:57:47 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-fft) 00:57:48 INFO - PROCESS | 30092 | RSS: Main: 302526464 00:57:48 INFO - PROCESS | 30092 | 00:57:50 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41961/tests/kraken/driver.html?testName=audio-oscillator) 00:57:51 INFO - PROCESS | 30092 | RSS: Main: 212877312 00:57:51 INFO - PROCESS | 30092 | 00:57:53 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:57:54 INFO - PROCESS | 30092 | RSS: Main: 213946368 00:57:54 INFO - PROCESS | 30092 | 00:57:57 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-darkroom) 00:57:57 INFO - PROCESS | 30092 | RSS: Main: 253218816 00:57:57 INFO - PROCESS | 30092 | 00:58:01 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41961/tests/kraken/driver.html?testName=imaging-desaturate) 00:58:01 INFO - PROCESS | 30092 | RSS: Main: 247115776 00:58:01 INFO - PROCESS | 30092 | 00:58:04 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41961/tests/kraken/driver.html?testName=json-parse-financial) 00:58:05 INFO - PROCESS | 30092 | RSS: Main: 250683392 00:58:05 INFO - PROCESS | 30092 | 00:58:07 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41961/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:58:07 INFO - PROCESS | 30092 | RSS: Main: 213991424 00:58:07 INFO - PROCESS | 30092 | 00:58:09 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:58:10 INFO - PROCESS | 30092 | RSS: Main: 220839936 00:58:10 INFO - PROCESS | 30092 | 00:58:12 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:58:13 INFO - PROCESS | 30092 | RSS: Main: 221696000 00:58:13 INFO - PROCESS | 30092 | 00:58:15 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:58:16 INFO - PROCESS | 30092 | RSS: Main: 223137792 00:58:16 INFO - PROCESS | 30092 | 00:58:19 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:58:20 INFO - PROCESS | 30092 | RSS: Main: 220975104 00:58:20 INFO - PROCESS | 30092 | 00:58:21 INFO - PROCESS | 30092 | Cycle 1(1): loaded http://localhost:41961/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41961/tests/kraken/driver.html?testName=ai-astar) 00:58:22 INFO - PROCESS | 30092 | RSS: Main: 271597568 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | __start_tp_report 00:58:22 INFO - PROCESS | 30092 | _x_x_mozilla_page_load 00:58:22 INFO - PROCESS | 30092 | _x_x_mozilla_page_load_details 00:58:22 INFO - PROCESS | 30092 | |i|pagename|runs| 00:58:22 INFO - PROCESS | 30092 | |0;ai-astar;115;117;132;116;115;117;114;115;116;113 00:58:22 INFO - PROCESS | 30092 | |1;audio-beat-detection;154;121;145;178;129;144;144;128;192;123 00:58:22 INFO - PROCESS | 30092 | |2;audio-dft;162;162;163;161;162;161;162;161;161;161 00:58:22 INFO - PROCESS | 30092 | |3;audio-fft;82;78;76;178;78;77;75;75;160;76 00:58:22 INFO - PROCESS | 30092 | |4;audio-oscillator;83;83;144;84;83;83;134;83;83;139 00:58:22 INFO - PROCESS | 30092 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;117;118 00:58:22 INFO - PROCESS | 30092 | |6;imaging-darkroom;147;146;145;146;146;146;147;147;146;146 00:58:22 INFO - PROCESS | 30092 | |7;imaging-desaturate;95;95;95;95;95;94;102;95;95;94 00:58:22 INFO - PROCESS | 30092 | |8;json-parse-financial;63;64;64;63;64;64;63;63;64;71 00:58:22 INFO - PROCESS | 30092 | |9;json-stringify-tinderbox;66;66;66;65;67;65;65;66;66;65 00:58:22 INFO - PROCESS | 30092 | |10;stanford-crypto-aes;92;85;88;82;91;82;83;88;82;82 00:58:22 INFO - PROCESS | 30092 | |11;stanford-crypto-ccm;134;152;134;134;132;133;141;132;167;135 00:58:22 INFO - PROCESS | 30092 | |12;stanford-crypto-pbkdf2;173;174;180;173;172;177;176;175;179;174 00:58:22 INFO - PROCESS | 30092 | |13;stanford-crypto-sha256-iterative;69;67;68;70;70;69;69;73;67;69 00:58:22 INFO - PROCESS | 30092 | __end_tp_report 00:58:22 INFO - PROCESS | 30092 | __start_cc_report 00:58:22 INFO - PROCESS | 30092 | _x_x_mozilla_cycle_collect,1978 00:58:22 INFO - PROCESS | 30092 | __end_cc_report 00:58:22 INFO - PROCESS | 30092 | __startTimestamp1472198302204__endTimestamp 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | ------- Summary: start ------- 00:58:22 INFO - PROCESS | 30092 | Number of tests: 14 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#0] ai-astar Cycles:10 Average:117.00 Median:116.00 stddev:5.42 (4.7%) stddev-sans-first:5.70 00:58:22 INFO - PROCESS | 30092 | Values: 115.0 117.0 132.0 116.0 115.0 117.0 114.0 115.0 116.0 113.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:144.50 stddev:23.52 (16.3%) stddev-sans-first:24.76 00:58:22 INFO - PROCESS | 30092 | Values: 154.0 121.0 145.0 178.0 129.0 144.0 144.0 128.0 192.0 123.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 00:58:22 INFO - PROCESS | 30092 | Values: 162.0 162.0 163.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.50 stddev:39.02 (51.0%) stddev-sans-first:41.08 00:58:22 INFO - PROCESS | 30092 | Values: 82.0 78.0 76.0 178.0 78.0 77.0 75.0 75.0 160.0 76.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:83.00 stddev:27.09 (32.6%) stddev-sans-first:28.03 00:58:22 INFO - PROCESS | 30092 | Values: 83.0 83.0 144.0 84.0 83.0 83.0 134.0 83.0 83.0 139.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 00:58:22 INFO - PROCESS | 30092 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 00:58:22 INFO - PROCESS | 30092 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.32 (2.4%) stddev-sans-first:2.46 00:58:22 INFO - PROCESS | 30092 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 102.0 95.0 95.0 94.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:2.41 (3.8%) stddev-sans-first:2.51 00:58:22 INFO - PROCESS | 30092 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 71.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 00:58:22 INFO - PROCESS | 30092 | Values: 66.0 66.0 66.0 65.0 67.0 65.0 65.0 66.0 66.0 65.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:3.95 (4.6%) stddev-sans-first:3.42 00:58:22 INFO - PROCESS | 30092 | Values: 92.0 85.0 88.0 82.0 91.0 82.0 83.0 88.0 82.0 82.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:134.50 stddev:11.45 (8.5%) stddev-sans-first:11.98 00:58:22 INFO - PROCESS | 30092 | Values: 134.0 152.0 134.0 134.0 132.0 133.0 141.0 132.0 167.0 135.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.50 stddev:2.67 (1.5%) stddev-sans-first:2.70 00:58:22 INFO - PROCESS | 30092 | Values: 173.0 174.0 180.0 173.0 172.0 177.0 176.0 175.0 179.0 174.0 00:58:22 INFO - PROCESS | 30092 | 00:58:22 INFO - PROCESS | 30092 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.83 00:58:22 INFO - PROCESS | 30092 | Values: 69.0 67.0 68.0 70.0 70.0 69.0 69.0 73.0 67.0 69.0 00:58:22 INFO - PROCESS | 30092 | -------- Summary: end -------- 00:58:22 INFO - PROCESS | 30092 | 00:58:23 INFO - TEST-INFO | 30092: exit 0 00:58:23 INFO - TEST-OK | kraken | took 64800ms 00:58:23 INFO - SUITE-END | took 1186s 00:58:23 INFO - Completed test suite (00:19:47) 00:58:23 INFO - javascript benchmark 00:58:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.490369377971, 2621.9868900655492, 2626.7373262673736, 2631.0396705202593, 2680.370113023439, 4534.909301813962, 4598.011427543078, 4677.906441871165, 4764.237721964487, 4842.29786680931, 4636.605888499482, 4642.117997580466, 4652.953470465294, 4654.534546545344, 4709.623230141589, 4313.676474264435, 4371.27873900806, 4380.0, 4404.2512772828695, 4439.4672639283335, 4408.933865992013, 4424.336349547561, 4430.335449682541, 4440.0, 4453.28747400416, 4312.116016216668, 4433.290673492242, 4490.236659767847, 4501.212287849629, 4505.36924830524, 4241.1941731071, 4281.721688090264, 4397.31841564558, 4418.116376724652, 4459.665525085599, 4252.638525725286, 4275.0594869128745, 4317.633001194902, 4329.350597410382, 4360.193364227596, 4664.55686709762, 4738.384010078667, 4744.833930812405, 4749.073930583538, 4752.477227505006, 4858.416989961192, 5040.092783299005, 5042.823501177441, 5053.671511351788, 5090.185570308733, 4998.175301075318, 5005.749712514396, 5036.6726162799305, 5037.269595908573, 5118.539331460186, 4683.6721429500285, 4689.929651055237, 4693.694909830884, 4703.082898834695, 4757.595604373598, 4965.35450391454, 5125.589952803767, 5136.948630513722, 5143.897122057613, 5185.429602743695, 4975.0, 5025.597952163818, 5034.043531729033, 5046.343975283263, 5088.745562721849, 5102.566281866083, 5116.692998420107, 5117.283580298761, 5121.692698438105, 5179.430262671103, 4828.106800241966, 5069.569086627678, 5084.211947148124, 5085.0338435697095, 5088.6946783193125, 4956.157453232959, 5013.273075404046, 5023.120953833065, 5048.798048078109, 5051.722155281494, 4237.491501019897, 4244.575542445731, 4279.40088387626, 4289.571042895748, 4295.591918767712, 3721.5162028936606, 3724.8696295629525, 3730.2539492101146, 3763.172102137525, 3771.340015497332, 4250.638695710899, 4333.674974376934, 4365.934510982338, 4366.672499562545, 4418.248897687401, 5045.596352291881, 5083.983203359343, 5084.3898732152375, 5151.459096794782, 5151.459096794858, 4337.7180483268485, 4370.868873933787, 4372.540883207217, 4373.781310934504, 4426.623736982328, 4389.297712366006, 4478.910421791611, 4535.206338890747, 4545.431821022372, 4600.401947746772, 4701.03628756111, 4717.127331443694, 4765.35667684872, 4768.451628062817, 4771.498992605726, 5092.821751238689, 5105.923411148761, 5111.05445492585, 5115.64190506661, 5137.8715532112, 4748.952510474851, 4754.904901902012, 4759.119562880878, 4761.16679581065, 4817.253325734517, 4833.275008748576, 4966.478519755374, 5018.096742586224, 5032.6980381177245, 5102.846914592568, 5105.974470127626, 5106.565941894981, 5116.590672746246, 5126.806112882968, 5128.948710512847, 4983.227599722049, 4984.651074424755, 4989.276554899447, 4989.675671081368, 5036.420811606712, 4742.454617719007, 4868.659193856396, 4887.193613053806, 4904.8773780655765, 4996.975015124901, 4834.395700537433, 4841.661083724105, 4852.344933433941, 4854.0508339953185, 4912.336834527293, 4742.976285118552, 4823.3729615149805, 4917.385326834145, 4940.7035577865445, 4958.404991401055, 4859.708417494961, 4929.507049295042, 4948.257761335828, 4951.480094590016, 5009.198528235464], "value": 4645.8638205965135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3201290464347, 573.7590212110913, 582.2983305117334, 583.5506659871899, 585.8008277185758, 27592.17223483296, 30309.545356819664, 30655.38689226214, 30704.232394190156, 30752.38495230094, 31174.688253117463, 39587.80206098973, 40609.0, 40750.18499630006, 44672.3299150513, 7641.465097443182, 7759.883601745978, 7762.922370776305, 7766.37868970481, 7768.145503994584, 7627.923720762805, 7715.691372345127, 7718.305352518272, 7726.072871255429, 7754.224577542257, 7756.224377562226, 7778.727744528943, 7801.7907224380315, 7828.099768526607, 7838.098618658842, 7727.497712648688, 7770.494917830323, 7776.105747839014, 7776.844463110762, 7778.338841198477, 7614.086309642823, 7675.3859691225125, 7682.654280557333, 7682.7311044113185, 7687.961560192163, 38459.615403845884, 38803.611963880285, 38889.41665875014, 38932.22135557273, 38960.0, 3079.9230019249476, 3110.875564977398, 3121.750259979196, 3181.984090079558, 3434.6050204226585, 27810.860945695345, 28522.572161417596, 28591.57112643312, 28611.71388286132, 28634.570481442588, 3260.2012506935716, 3288.6875746804017, 3355.144438168276, 3528.1356067763563, 3529.3117842020815, 267525.0, 269389.6530517354, 269653.55196720647, 270091.0, 270589.0, 54509.72745136249, 55169.0, 55521.0, 55540.0, 55627.44372556303, 32189.356212875613, 33112.50331245033, 58478.415215848145, 58593.70703146542, 58624.4137558619, 14640.560783176521, 14905.254737263094, 14948.476803311833, 14973.625659358386, 14979.925100374647, 11222.719432014102, 11303.773924521627, 11314.943425282985, 11318.490667919963, 11319.886801132048, 17729.822701772817, 17802.287908483773, 17808.91095544514, 17840.821591784177, 17843.910780446015, 6602.405783479414, 6628.767993120314, 6835.624040677811, 6902.5150945659525, 7060.470464715064, 781.3280578702312, 886.1537231943479, 897.4794619121025, 933.5892207428709, 975.2441857560448, 26591.20226393211, 27140.728592714215, 27383.041593544527, 27618.8238352588, 27804.0, 944.15026476172, 967.264878692199, 979.1823827104448, 986.3391527676474, 1025.6717850287985, 14494.927525362305, 14635.707285854223, 14668.853311466963, 14884.330205140577, 14970.101793892401, 364584.0, 366834.0, 367278.0, 367301.0, 367392.0, 48676.0, 49171.75414122907, 49315.753421233385, 49320.0, 49357.753211233714, 1048.638219814163, 1094.600470828158, 1144.5021415684205, 1188.1326631559011, 1192.4097571702064, 26935.191944241706, 28005.29986750266, 28241.57637635396, 28594.857025714737, 28834.27914302159, 41364.586354136074, 41836.3724544126, 41893.79053104715, 41968.580314196464, 41999.58000419957, 290047.0, 290990.0, 291705.0, 291736.0, 292601.0, 21822.781772182076, 23556.175533856233, 24243.757562424857, 25000.0, 25028.374290642878, 40080.59919400885, 40706.59293407028, 40787.38818917659, 41171.58828411797, 41621.167576648906, 33031.66968330286, 36017.819910900274, 36145.81927090348, 36589.26821463609, 36684.082897927765, 35481.11297217487, 35532.289354212255, 35842.28315433625, 35967.460488093224, 36387.0, 34936.30127397489, 35201.64798352086, 35538.82230588831, 35837.0, 36263.81868090643, 30964.535531966587, 32984.34031319408, 33316.500252495745, 33483.66516334806, 33707.831460842535, 24794.25617231486, 25029.249122526355, 25236.24291271265, 25403.13320619455, 25808.870955645103], "value": 17203.74235642563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.7334479106295, 365.13463092470846, 366.9541307336583, 368.1201927393529, 385.4488082042678, 12467.0, 16037.117958512277, 16095.75856362154, 16949.91525042373, 17207.0, 16414.261358238877, 16567.91716041421, 17350.305987760476, 17490.125493725296, 17530.561735956606, 4993.75031248438, 4994.825181118662, 5148.613853960949, 5183.585313174937, 5195.974020129913, 3596.2088340565033, 5087.338645976018, 5173.5861131109605, 5175.146100893348, 5587.804426845061, 5857.150713146591, 5891.734871930774, 5967.134765459005, 5967.134765459027, 5968.01527747921, 5750.252467179282, 5960.7019649017375, 6101.725422356005, 6122.8775424491705, 6149.938500614981, 5409.891802163974, 5410.675359478444, 5412.648177868466, 5414.675119492843, 5415.83752487422, 21087.8945605271, 21333.67999480009, 21866.23468178606, 21963.780362196332, 22145.889270553544, 1944.9124789384512, 2162.9223219723735, 2357.1400167017823, 2526.873656317177, 2571.7338979495935, 12746.936265318614, 13100.148490348192, 13273.203607783467, 13385.933070334684, 13666.453341866314, 1766.832150945671, 1772.237937686794, 1773.423637317877, 1788.5707430216655, 1811.80975997521, 71971.64014179895, 72063.2793672067, 73407.26592734057, 73632.63183684101, 74576.0, 9405.71782846502, 9562.18721408688, 9651.951740241253, 9809.607615695293, 10024.348417352849, 13486.93256533711, 13522.729545409036, 13550.796738048937, 13562.254076025913, 13568.321583920962, 7119.181294151239, 7363.300486453778, 7405.333519983227, 7578.4316176287, 7596.430267729942, 7005.229424763272, 7025.367716905503, 7274.090738657668, 7281.490295679358, 7294.8905766413545, 6064.848378790565, 6189.96905015472, 6207.131001659771, 6239.313675495692, 6278.340774218641, 1792.865535084874, 1812.909354532268, 1822.6536957977942, 1831.560425497871, 1868.9252429902651, 740.9036825212688, 850.5067061104545, 853.4623187391903, 891.3537685178323, 948.990510094904, 16044.358225670843, 16422.589435263973, 16546.751798723028, 16571.337146514004, 17396.0, 818.9549574773445, 849.5497386385226, 853.8335024670254, 877.1491653096487, 883.5217215709995, 8902.465852048897, 8998.0, 9032.064579011847, 9772.95113524442, 9885.25860560461, 174993.0, 394333.0, 396665.0, 397591.0, 399791.0, 81511.0, 82360.0, 84152.0, 84604.57697711595, 85037.57481212678, 884.6815146547237, 921.3090182363228, 928.1831987850783, 928.3872644054892, 935.7239614313658, 14927.328270227648, 15663.0, 15942.760858587362, 15995.280212390238, 16976.830231697524, 35844.820775895954, 37584.0, 38947.415788763756, 40593.797031014656, 41201.1759764809, 49869.75065124651, 50722.746386267834, 51136.74431627818, 51980.480195199074, 52662.0, 7665.156832748282, 7713.2286771322415, 7812.140664527011, 7886.250806173404, 8002.239507308383, 9407.294452915921, 12252.448639811051, 12371.938140309241, 12401.441935112762, 12577.748445031231, 10285.125764310118, 10498.947505262426, 10604.734881628021, 10729.785404292026, 10778.407187604756, 10638.946805265925, 10703.411312377582, 10751.6236931707, 10759.569617215537, 11129.610463633733, 10748.247622666338, 11000.834987475035, 11023.338599684044, 11141.72145696364, 11187.552497899993, 7904.486208396436, 8058.274755272054, 8099.757007289791, 8155.0, 8244.917550824415, 10476.319039262424, 10512.632057877938, 10522.579096836042, 10671.253012289066, 11031.172662050218], "value": 8524.507885122164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.209465941797, 1353.0393420671323, 1392.7423426666066, 1453.9418423263064, 1668.3910372713956, 7545.584992825392, 7877.369810415167, 7947.125816160218, 8092.716754913579, 8103.878441823377, 7791.376689864811, 7897.802554936129, 7909.288164065233, 7910.485818421798, 7913.525188488695, 1866.178881292227, 2176.9020394082304, 2212.4911270407815, 2244.16965722682, 2247.83141264405, 2185.562887422514, 2200.8459407841456, 2204.8787316697576, 2204.9669254961186, 2207.4812419081504, 2212.623853944833, 2233.2630232023394, 2247.4718441166315, 2254.3349711834967, 2255.9210427635035, 2124.2352753008904, 2168.8590241634242, 2179.052112331125, 2180.3349978256547, 2214.1143542582936, 2202.2402271216565, 2222.0889435331437, 2222.4554984029014, 2222.7110475638065, 2226.6214743493647, 8145.877811832827, 8173.060098088737, 8197.221263979913, 8200.876986845202, 8205.466644668077, 4560.498345182027, 4704.200285951397, 4707.670463067587, 4712.198926182557, 4716.221823399135, 2867.211516832867, 2874.5113330733825, 3027.3339865229837, 3035.3777475617444, 3038.2100653829943, 975.9414435133915, 989.4706332112357, 1000.1298869983161, 1001.5993602559034, 1006.4665727164614, 10396.792064158675, 10437.2693911427, 10439.164866810637, 10445.425501597409, 10515.894841051568, 3984.641382275609, 4150.315197992358, 4321.416608757778, 4426.1369033038245, 4433.534478879736, 8623.611937462829, 8701.390902636882, 8710.869336959951, 8721.869171962426, 8738.126187381211, 4574.176648203355, 4574.245249533857, 4574.679772415899, 4575.702579332333, 4576.405067341224, 3568.892933211956, 4028.91942161161, 4119.114390406017, 4273.67947403946, 4279.422277992431, 3415.1803567143706, 3433.0, 3543.6633519815578, 3564.946525802115, 3574.4102223133414, 1039.9116075133547, 1047.2930771729052, 1053.6680945502142, 1054.2409465185056, 1056.9894301057045, 704.5103652961143, 772.6716145638081, 841.3479553346083, 853.8761879527434, 880.3969281042379, 5560.944390556124, 5634.971825140848, 5718.599698021182, 5740.712964351849, 5884.676342801187, 859.9183077607618, 868.7914900423852, 878.543157558079, 899.2446345070173, 916.4134953629682, 3633.255182687543, 3713.8514459421863, 3723.627637236309, 3831.9616803832164, 3909.139989202371, 9685.661001865043, 9857.802843943082, 9957.900420995842, 9962.0, 10070.345427547187, 9929.553170107363, 9933.50332483373, 9934.552945117342, 9935.403875767477, 9973.152282056106, 7281.963590182015, 7388.741394051182, 7390.5196162249285, 7405.7778266652085, 7435.367993720486, 5559.33288005442, 5565.638233514808, 5621.213030175697, 5652.123920792284, 5700.914486282792, 9078.45529268246, 9142.131497507726, 9153.588088535898, 9180.0, 9241.075892410705, 8413.0, 8770.210681038738, 8771.912280877365, 9054.0, 9238.676646317346, 6141.662208578392, 6721.092652491851, 6942.201646810681, 6954.652267386509, 7125.75059872902, 7642.273983971514, 7765.262300081483, 7769.92230077692, 7777.105632852295, 7781.494202876795, 6850.725970961105, 6952.965235173791, 6971.930280697128, 7004.754833581004, 7108.324709152622, 6718.428933540508, 6841.281665425257, 6912.93087069143, 6915.273896240822, 6969.16370035599, 6500.772472963424, 6572.277049524644, 6598.152517295165, 6664.200295964515, 6707.3292670732535, 4735.810567577259, 4763.642726795573, 4831.323614694016, 4847.030593881308, 4868.902621947612, 4742.288656701522, 4760.857174284777, 4832.202686556679, 4842.0, 5019.623528235324], "value": 4197.898903509002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.3776465188673, 287.587312206983, 290.49598945828984, 291.85407296351826, 297.1027496959183, 4610.285405762103, 4700.811967521295, 4824.155772739769, 4861.1492988727005, 4895.902081958358, 4761.619070474362, 4768.690035147722, 4773.427188737356, 4776.665633405663, 4806.231003039506, 3772.9058573013863, 3783.451399547064, 3786.924261514768, 3788.299164654534, 3791.0901383667997, 3564.786112833225, 3583.623719509453, 3775.0, 3792.5259342582176, 3813.733038687293, 3717.516722826029, 3729.4592284118785, 3739.682127019193, 3748.718846086541, 3758.2793034895394, 3739.2334571412794, 3765.265773174232, 3767.077066118805, 3772.1701225730294, 3779.7165212609166, 3307.355065762177, 3308.652591477908, 3323.587475322978, 3336.9833150834093, 3345.46472564391, 4648.0, 4676.719396836201, 4713.622910167179, 4723.527647235283, 4730.929036064462, 4298.828046878121, 4305.526392096866, 4306.160298741746, 4307.569243075699, 4314.590113939171, 5030.471800460936, 5046.318746969149, 5076.162433198518, 5088.414832294259, 5091.79632814687, 3561.3767590671528, 3564.8395822187804, 3624.4925710400566, 3655.744097913147, 3658.3414985302634, 5229.764660590283, 5233.607479439019, 5235.869103272411, 5239.633225674204, 5262.290085489721, 3706.814659267026, 3707.8331475083687, 3712.5706602958057, 3713.2387860488534, 3716.572594151653, 3765.7781908674015, 3766.981165094212, 3808.086059345737, 3808.904777380588, 3810.657040866335, 4189.748615083044, 4222.408862759216, 4258.638015768633, 4269.4449721536, 4298.333758267474, 4952.455229924705, 4976.377952755905, 4977.90044199114, 4983.401991761012, 4997.350344455198, 1230.5508489401484, 1243.042857000105, 1273.5287943460978, 1282.6344491819787, 1289.0010242062476, 867.7266661001764, 870.5212133326645, 887.0109827542244, 892.5537231384308, 894.4812009034745, 4398.69209155356, 4407.228734971367, 4421.408293014512, 4428.734275943454, 4440.4671439427475, 5112.258722485219, 5128.461511541309, 5133.563647089964, 5145.742712864342, 5147.3308469898675, 4378.233809083397, 4391.5827996340295, 4403.625691816167, 4407.669424793154, 4419.558044195554, 2312.231143175472, 2442.242904699549, 2442.9983706680177, 2447.180194634782, 2453.3562513116253, 4289.549597292302, 4304.5480224576595, 4310.52584215736, 4311.461067366579, 4344.45694288214, 4640.329481386698, 4660.836870709509, 4663.88066863957, 4670.949036466768, 4699.002923757389, 4322.762248076323, 4486.932696009562, 4836.830710925171, 4875.317455556154, 4886.462489126265, 5207.635465517377, 5207.71357575337, 5216.9739151304, 5220.556252718561, 5243.973780131075, 5111.3355263815465, 5113.181890897438, 5131.153359695609, 5132.897342053213, 5137.458762371349, 4686.89857883404, 4822.348982887265, 4845.830395936126, 4851.563359297539, 4863.610911127031, 3619.8190090495896, 3644.8359823808523, 3648.908777280589, 3649.927001459903, 3662.8717994870053, 4948.752562371939, 5164.115097989282, 5170.508801663836, 5176.767045482887, 5181.171012637959, 4875.829800847842, 4992.400911890596, 4992.550670439678, 5006.499350064964, 5007.899842003212, 5014.899702005867, 5025.39695236574, 5032.672876263031, 5046.1673823818655, 5049.899002020013, 4892.877678058077, 4967.677100988424, 4998.2502624606595, 5001.924971125509, 5004.2493625956395, 5067.442581316126, 5085.567726743268, 5122.282880396822, 5122.359705036871, 5127.2052831811125, 5006.899862002667, 5007.37407824022, 5009.273655319886, 5014.122528557415, 5032.295478632921], "value": 3755.5538866608317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9528285378598, 629.1443636654151, 663.777634492445, 666.1972323350363, 749.1983577571997, 13227.801582976252, 14370.712585748279, 14374.568762937102, 14376.209308488029, 14424.783628245585, 13426.0, 13567.45730170792, 13602.455901763917, 13618.182909025465, 13632.591022269347, 605.8152263559613, 727.5380133615166, 727.8617062758085, 745.7837227204104, 753.5742305597347, 743.2753065760867, 750.1710609776201, 750.8047907544023, 752.3266676324686, 752.7440670172141, 789.2265579731866, 789.8617741895174, 790.4466873188762, 790.8734602463607, 791.936645068396, 624.0514418084532, 762.6606160258688, 782.3467404717068, 783.8745800671894, 788.3456730913385, 581.1486172756931, 581.5405829394773, 581.869079457123, 581.9272590926134, 582.2925145947694, 12410.503579856795, 12429.192102513307, 12432.316222607753, 12434.067444941666, 12437.253764774143, 12324.81512777309, 12349.135560510767, 12827.486900523967, 12842.165259258118, 13138.540151094761, 11580.768384632345, 11954.0, 12136.211146275464, 12204.02367810573, 12819.294938778457, 4010.418489319062, 4065.10567675111, 4123.402106694542, 4169.812358443877, 4170.35359519275, 62631.6868415655, 62906.37093629051, 63007.0, 63363.683181583794, 64122.358776412104, 10096.394216346896, 10230.079292863678, 10556.894431055745, 10632.149428045737, 10640.521176547074, 18872.905635471736, 19001.14494847735, 19093.522661933563, 19181.80818191828, 19498.902505487382, 6649.867002659919, 6744.224414192333, 6820.897686534706, 6855.348741869514, 6987.231404545496, 3686.170611612366, 3706.6478684524927, 3729.1236559408517, 3730.2725968435893, 3809.3524100902914, 2844.928876778056, 2915.8833646653898, 2933.193371822766, 2937.3390987027747, 2937.4125174965093, 538.5207165622598, 541.3179393963555, 549.5411331538211, 550.6943646276355, 555.88604336111, 541.6939429222556, 560.8962341966749, 571.9113537401627, 573.2404563952779, 581.3459857660132, 7674.57789821554, 7711.768646940601, 7827.452078354574, 7836.529808211526, 8152.592370381457, 528.577138289367, 529.5736931769962, 542.1677724692578, 577.9479846813807, 580.7502773807304, 3628.727845411605, 3725.441183822394, 3908.3160446921675, 3956.1296514766705, 4029.1135950090934, 100464.0, 104298.0, 104415.4779226099, 104582.0, 106802.46598767112, 66571.66714166399, 71376.0, 74255.25744742592, 77591.0, 81264.0, 43492.782536087114, 50129.24806127911, 51707.0, 68171.65914170397, 69290.0, 8179.427440079137, 8518.74443766688, 8530.189631984951, 8543.231109200202, 8626.568671566522, 42172.367414488195, 42930.0, 43208.35187472253, 43580.0, 43908.78045609751, 59399.40600593939, 61507.38492615196, 61589.384106158366, 61662.0, 62237.0, 10104.64633737845, 10201.897981020094, 10543.789124217627, 10570.8414373786, 11002.229843910849, 12656.517072782937, 13390.129641573267, 13435.12671676338, 13540.255285959367, 13938.860611393757, 12044.156909016285, 12410.81383779226, 12575.308358040396, 12678.936605316914, 13186.0, 12778.869177051682, 12865.228086314477, 13017.716153490066, 13084.869151308365, 13367.532136375181, 11552.768944621228, 11710.180287379802, 12114.333711645591, 12114.333711645944, 12137.696557585778, 9800.705978820646, 10402.011808878144, 10445.11216546602, 10501.760694174278, 10690.893091069302, 9836.852447213441, 10291.0, 10357.0, 10363.740906477398, 10376.948115259376], "value": 6561.197877739491, "unit": "score"}], "name": "dromaeo_css", "value": 6427.117259681727, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 132.0, 116.0, 115.0, 117.0, 114.0, 115.0, 116.0, 113.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 145.0, 178.0, 129.0, 144.0, 144.0, 128.0, 192.0, 123.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 76.0, 178.0, 78.0, 77.0, 75.0, 75.0, 160.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 144.0, 84.0, 83.0, 83.0, 134.0, 83.0, 83.0, 139.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 102.0, 95.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 71.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 88.0, 82.0, 91.0, 82.0, 83.0, 88.0, 82.0, 82.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 152.0, 134.0, 134.0, 132.0, 133.0, 141.0, 132.0, 167.0, 135.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 180.0, 173.0, 172.0, 177.0, 176.0, 175.0, 179.0, 174.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 70.0, 70.0, 69.0, 69.0, 73.0, 67.0, 69.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1578.1999999999998, "alertThreshold": 2.0}]} 00:58:23 INFO - Return code: 0 00:58:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:58:24 INFO - # TBPL SUCCESS # 00:58:24 INFO - Running post-action listener: _resource_record_post_action 00:58:24 INFO - [mozharness: 2016-08-26 07:58:24.023453Z] Finished run-tests step (success) 00:58:24 INFO - Running post-run listener: _resource_record_post_run 00:58:24 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 405528576; Read time: 0; Write time: 359260 00:58:24 INFO - TinderboxPrint: CPU usage
13.0% 00:58:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:58:24 INFO - TinderboxPrint: I/O write bytes / time
405,528,576 / 359,260 00:58:24 INFO - TinderboxPrint: CPU idle
8,352.9 (86.9%) 00:58:24 INFO - TinderboxPrint: CPU user
1,203.7 (12.5%) 00:58:24 INFO - TinderboxPrint: Swap in / out
0 / 0 00:58:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114552832; Read time: 0; Write time: 134420 00:58:24 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290975744; Read time: 0; Write time: 224840 00:58:24 INFO - Running post-run listener: _upload_blobber_files 00:58:24 INFO - Blob upload gear active. 00:58:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:58:24 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 00:58:24 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:58:24 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 00:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:26 INFO - (blobuploader) - INFO - Done attempting. 00:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:26 INFO - (blobuploader) - INFO - Done attempting. 00:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:30 INFO - (blobuploader) - INFO - Done attempting. 00:58:30 INFO - (blobuploader) - INFO - Iteration through files over. 00:58:30 INFO - Return code: 0 00:58:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:58:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:58:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bc6cdb84568b6734e726ef7c06270505b115006d0162a5d36aa6d24c470f50fa2b1274faf591f4618ee26618c177e1eefd6a6334294bd7c7bfc26b9b37135e28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/337af2da1ec8d28ecde219a0ab8278a677acebe978d65dd7f312d79f98af6ff4b7473737d337e35198fee90a5d4f7aba022bdbb853d4e3c3a14eba5571f81596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624d6b20ee6a9a6fdd128c260eab023b510638b7d2cb483afaad99220ab996d706073e870dad7e867a4cda8df050aa0e3873813d7afdd87781dad02c27695933"} 00:58:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:58:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:58:30 INFO - Contents: 00:58:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bc6cdb84568b6734e726ef7c06270505b115006d0162a5d36aa6d24c470f50fa2b1274faf591f4618ee26618c177e1eefd6a6334294bd7c7bfc26b9b37135e28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/337af2da1ec8d28ecde219a0ab8278a677acebe978d65dd7f312d79f98af6ff4b7473737d337e35198fee90a5d4f7aba022bdbb853d4e3c3a14eba5571f81596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624d6b20ee6a9a6fdd128c260eab023b510638b7d2cb483afaad99220ab996d706073e870dad7e867a4cda8df050aa0e3873813d7afdd87781dad02c27695933"} 00:58:30 INFO - Running post-run listener: copy_logs_to_upload_dir 00:58:30 INFO - Copying logs to upload dir... 00:58:30 INFO - mkdir: /builds/slave/test/build/upload/logs 00:58:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.284775 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-26 00:58:30.561080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 00:58:30.564506) ========= 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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bc6cdb84568b6734e726ef7c06270505b115006d0162a5d36aa6d24c470f50fa2b1274faf591f4618ee26618c177e1eefd6a6334294bd7c7bfc26b9b37135e28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/337af2da1ec8d28ecde219a0ab8278a677acebe978d65dd7f312d79f98af6ff4b7473737d337e35198fee90a5d4f7aba022bdbb853d4e3c3a14eba5571f81596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624d6b20ee6a9a6fdd128c260eab023b510638b7d2cb483afaad99220ab996d706073e870dad7e867a4cda8df050aa0e3873813d7afdd87781dad02c27695933"} build_url:https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/RVdJbxmQTC2CXtI7r9wN7Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bc6cdb84568b6734e726ef7c06270505b115006d0162a5d36aa6d24c470f50fa2b1274faf591f4618ee26618c177e1eefd6a6334294bd7c7bfc26b9b37135e28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/337af2da1ec8d28ecde219a0ab8278a677acebe978d65dd7f312d79f98af6ff4b7473737d337e35198fee90a5d4f7aba022bdbb853d4e3c3a14eba5571f81596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/624d6b20ee6a9a6fdd128c260eab023b510638b7d2cb483afaad99220ab996d706073e870dad7e867a4cda8df050aa0e3873813d7afdd87781dad02c27695933"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 00:58:30.589662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:58:30.589976) ========= 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=7de08804244eb36560b44971000001c3-1472196383.759246-1603811790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 00:58:30.672828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 00:58:30.673153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 00:58:30.673446) ========= ========= Total master_lag: 0.17 =========