builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1475054537.88 results: success (0) buildid: 20160928011020 builduid: 756e4079600d4aeeb0b825cc990b2baa revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:17.884813) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:17.885360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:17.885964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:17.902310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:17.902974) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 02:22:19-- 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% 22.1M=0.001s 2016-09-28 02:22:19 (22.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:18.018722) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:18.019070) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:18.068378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 02:22:18.068774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45513d6773f099db66f0cd7bf1e312f6f9d11475 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 45513d6773f099db66f0cd7bf1e312f6f9d11475 --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=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 02:22:19,751 truncating revision to first 12 chars 2016-09-28 02:22:19,751 Setting DEBUG logging. 2016-09-28 02:22:19,751 attempt 1/10 2016-09-28 02:22:19,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45513d6773f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 02:22:21,903 unpacking tar archive at: fx-team-45513d6773f0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.540720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 02:22:20.624549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:20.625376) ========= script_repo_revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:20.626393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:20.627115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 02:22:20.638104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-28 02:22:20.638426) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:22 INFO - MultiFileLogger online at 20160928 02:22:22 in /builds/slave/test 02:22:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:22 INFO - {'append_to_log': False, 02:22:22 INFO - 'base_work_dir': '/builds/slave/test', 02:22:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:22 INFO - 'branch': 'Fx-Team-Non-PGO', 02:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:22 INFO - 'config_files': ('talos/linux_config.py',), 02:22:22 INFO - 'default_actions': ('clobber', 02:22:22 INFO - 'read-buildbot-config', 02:22:22 INFO - 'download-and-extract', 02:22:22 INFO - 'populate-webroot', 02:22:22 INFO - 'create-virtualenv', 02:22:22 INFO - 'install', 02:22:22 INFO - 'run-tests'), 02:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:22 INFO - 'download_minidump_stackwalk': True, 02:22:22 INFO - 'download_symbols': 'ondemand', 02:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:22 INFO - 'installer_path': 'installer.exe', 02:22:22 INFO - 'log_level': 'info', 02:22:22 INFO - 'log_name': 'talos', 02:22:22 INFO - 'log_to_console': True, 02:22:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:22 INFO - 'opt_config_files': (), 02:22:22 INFO - 'pip_index': False, 02:22:22 INFO - 'sps_profile': False, 02:22:22 INFO - 'sps_profile_interval': 0, 02:22:22 INFO - 'suite': 'dromaeojs', 02:22:22 INFO - 'system_bits': '32', 02:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:22 INFO - 'title': 'talos-linux64-ix-067', 02:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:22 INFO - 'use_talos_json': True, 02:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:22 INFO - 'work_dir': 'build'} 02:22:22 INFO - [mozharness: 2016-09-28 09:22:22.428712Z] Running clobber step. 02:22:22 INFO - Running pre-action listener: _resource_record_pre_action 02:22:22 INFO - Running main action method: clobber 02:22:22 INFO - rmtree: /builds/slave/test/build 02:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:23 INFO - Running post-action listener: _resource_record_post_action 02:22:23 INFO - [mozharness: 2016-09-28 09:22:23.409429Z] Finished clobber step (success) 02:22:23 INFO - [mozharness: 2016-09-28 09:22:23.409528Z] Running read-buildbot-config step. 02:22:23 INFO - Running pre-action listener: _resource_record_pre_action 02:22:23 INFO - Running main action method: read_buildbot_config 02:22:23 INFO - Using buildbot properties: 02:22:23 INFO - { 02:22:23 INFO - "project": "", 02:22:23 INFO - "product": "firefox", 02:22:23 INFO - "script_repo_revision": "production", 02:22:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:22:23 INFO - "repository": "", 02:22:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:22:23 INFO - "buildid": "20160928011020", 02:22:23 INFO - "pgo_build": "False", 02:22:23 INFO - "basedir": "/builds/slave/test", 02:22:23 INFO - "buildnumber": 3353, 02:22:23 INFO - "slavename": "talos-linux64-ix-067", 02:22:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:22:23 INFO - "platform": "ubuntu64_hw", 02:22:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:22:23 INFO - "branch": "fx-team", 02:22:23 INFO - "repo_path": "integration/fx-team", 02:22:23 INFO - "revision": "45513d6773f099db66f0cd7bf1e312f6f9d11475", 02:22:23 INFO - "stage_platform": "linux64", 02:22:23 INFO - "builduid": "756e4079600d4aeeb0b825cc990b2baa", 02:22:23 INFO - "slavebuilddir": "test" 02:22:23 INFO - } 02:22:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:22:23 INFO - Running post-action listener: _resource_record_post_action 02:22:23 INFO - [mozharness: 2016-09-28 09:22:23.411953Z] Finished read-buildbot-config step (success) 02:22:23 INFO - [mozharness: 2016-09-28 09:22:23.412042Z] Running download-and-extract step. 02:22:23 INFO - Running pre-action listener: _resource_record_pre_action 02:22:23 INFO - Running main action method: download_and_extract 02:22:23 INFO - mkdir: /builds/slave/test/build/tests 02:22:23 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')]} 02:22:23 INFO - trying https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:22:23 INFO - Downloading https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:22:23 INFO - Downloaded 1361 bytes. 02:22:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:22:23 INFO - Using the following test package requirements: 02:22:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'jsshell-linux-x86_64.zip'], 02:22:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:22:24 INFO - Expected file size: 20413434 02:22:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:22:29 INFO - Expected file size: 20413434 02:22:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:22:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:22:34 INFO - Expected file size: 14414062 02:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:35 INFO - trying https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:22:35 INFO - Downloading https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:22:36 INFO - Downloaded 55732710 bytes. 02:22:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:22:36 INFO - mkdir: /builds/slave/test/properties 02:22:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:36 INFO - Contents: 02:22:36 INFO - build_url:https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:22:37 INFO - Running post-action listener: _resource_record_post_action 02:22:37 INFO - Running post-action listener: set_extra_try_arguments 02:22:37 INFO - [mozharness: 2016-09-28 09:22:37.125666Z] Finished download-and-extract step (success) 02:22:37 INFO - [mozharness: 2016-09-28 09:22:37.125928Z] Running populate-webroot step. 02:22:37 INFO - Running pre-action listener: _resource_record_pre_action 02:22:37 INFO - Running main action method: populate_webroot 02:22:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:37 INFO - '--tppagecycles', 02:22:37 INFO - '7'], 02:22:37 INFO - 'tests': ['tsvgm']}}, 02:22:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['damp', 'tps']}, 02:22:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'tests': ['damp', 'tps']}, 02:22:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['dromaeo_dom']}, 02:22:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['basic_compositor_video']}, 02:22:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:22:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['a11yr', 02:22:37 INFO - 'ts_paint', 02:22:37 INFO - 'tpaint', 02:22:37 INFO - 'sessionrestore', 02:22:37 INFO - 'sessionrestore_no_auto_restore', 02:22:37 INFO - 'tabpaint']}, 02:22:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['tsvgx', 02:22:37 INFO - 'tsvgr_opacity', 02:22:37 INFO - 'tart', 02:22:37 INFO - 'tscrollx', 02:22:37 INFO - 'cart']}, 02:22:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:37 INFO - 'tsvgr_opacity', 02:22:37 INFO - 'tart', 02:22:37 INFO - 'tscrollx', 02:22:37 INFO - 'cart']}, 02:22:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'talos_options': ['--disable-e10s'], 02:22:37 INFO - 'tests': ['tp5o']}, 02:22:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'tests': ['tp5o']}, 02:22:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'talos_options': ['--disable-e10s', 02:22:37 INFO - '--xperf_path', 02:22:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:37 INFO - 'tests': ['tp5n']}, 02:22:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:37 INFO - 'talos_options': ['--xperf_path', 02:22:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:37 INFO - 'tests': ['tp5n']}}, 02:22:37 INFO - 'talos.zip': {'path': '', 02:22:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:37 INFO - Running post-action listener: _resource_record_post_action 02:22:37 INFO - [mozharness: 2016-09-28 09:22:37.146765Z] Finished populate-webroot step (success) 02:22:37 INFO - [mozharness: 2016-09-28 09:22:37.146854Z] Running create-virtualenv step. 02:22:37 INFO - Running pre-action listener: _resource_record_pre_action 02:22:37 INFO - Running main action method: create_virtualenv 02:22:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:22:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:37 INFO - Using real prefix '/usr' 02:22:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:39 INFO - Installing pip.................done. 02:22:39 INFO - Return code: 0 02:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:22:39 INFO - Reading from file tmpfile_stdout 02:22:39 INFO - Output received: 02:22:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:22:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:39 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:22:39 INFO - Using env: {'DISPLAY': ':0', 02:22:39 INFO - 'HOME': '/home/cltbld', 02:22:39 INFO - 'LANG': 'en_US.UTF-8', 02:22:39 INFO - 'LANGUAGE': 'en_US:en', 02:22:39 INFO - 'LOGNAME': 'cltbld', 02:22:39 INFO - 'MAIL': '/var/mail/cltbld', 02:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:39 INFO - 'MOZ_NO_REMOTE': '1', 02:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:39 INFO - 'NO_EM_RESTART': '1', 02:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:39 INFO - 'PWD': '/builds/slave/test', 02:22:39 INFO - 'SHELL': '/bin/bash', 02:22:39 INFO - 'SHLVL': '1', 02:22:39 INFO - 'TERM': 'linux', 02:22:39 INFO - 'TMOUT': '86400', 02:22:39 INFO - 'USER': 'cltbld', 02:22:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:39 INFO - '_': '/tools/buildbot/bin/python'} 02:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:22:40 INFO - Cleaning up... 02:22:40 INFO - Return code: 0 02:22:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:40 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')]} 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:40 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')]} 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:40 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:22:40 INFO - Using env: {'DISPLAY': ':0', 02:22:40 INFO - 'HOME': '/home/cltbld', 02:22:40 INFO - 'LANG': 'en_US.UTF-8', 02:22:40 INFO - 'LANGUAGE': 'en_US:en', 02:22:40 INFO - 'LOGNAME': 'cltbld', 02:22:40 INFO - 'MAIL': '/var/mail/cltbld', 02:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:40 INFO - 'MOZ_NO_REMOTE': '1', 02:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:40 INFO - 'NO_EM_RESTART': '1', 02:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:40 INFO - 'PWD': '/builds/slave/test', 02:22:40 INFO - 'SHELL': '/bin/bash', 02:22:40 INFO - 'SHLVL': '1', 02:22:40 INFO - 'TERM': 'linux', 02:22:40 INFO - 'TMOUT': '86400', 02:22:40 INFO - 'USER': 'cltbld', 02:22:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:40 INFO - '_': '/tools/buildbot/bin/python'} 02:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:40 INFO - Downloading/unpacking psutil>=3.1.1 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:42 INFO - Installing collected packages: psutil 02:22:42 INFO - Running setup.py install for psutil 02:22:42 INFO - building 'psutil._psutil_linux' extension 02:22:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:22:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:22:42 INFO - building 'psutil._psutil_posix' extension 02:22:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:22:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:42 INFO - Successfully installed psutil 02:22:42 INFO - Cleaning up... 02:22:42 INFO - Return code: 0 02:22:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:42 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:42 INFO - Using env: {'DISPLAY': ':0', 02:22:42 INFO - 'HOME': '/home/cltbld', 02:22:42 INFO - 'LANG': 'en_US.UTF-8', 02:22:42 INFO - 'LANGUAGE': 'en_US:en', 02:22:42 INFO - 'LOGNAME': 'cltbld', 02:22:42 INFO - 'MAIL': '/var/mail/cltbld', 02:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:42 INFO - 'MOZ_NO_REMOTE': '1', 02:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:42 INFO - 'NO_EM_RESTART': '1', 02:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:42 INFO - 'PWD': '/builds/slave/test', 02:22:42 INFO - 'SHELL': '/bin/bash', 02:22:42 INFO - 'SHLVL': '1', 02:22:42 INFO - 'TERM': 'linux', 02:22:42 INFO - 'TMOUT': '86400', 02:22:42 INFO - 'USER': 'cltbld', 02:22:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:42 INFO - '_': '/tools/buildbot/bin/python'} 02:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:45 INFO - Installing collected packages: mozsystemmonitor 02:22:45 INFO - Running setup.py install for mozsystemmonitor 02:22:45 INFO - Successfully installed mozsystemmonitor 02:22:45 INFO - Cleaning up... 02:22:45 INFO - Return code: 0 02:22:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:45 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:22:45 INFO - Using env: {'DISPLAY': ':0', 02:22:45 INFO - 'HOME': '/home/cltbld', 02:22:45 INFO - 'LANG': 'en_US.UTF-8', 02:22:45 INFO - 'LANGUAGE': 'en_US:en', 02:22:45 INFO - 'LOGNAME': 'cltbld', 02:22:45 INFO - 'MAIL': '/var/mail/cltbld', 02:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:45 INFO - 'MOZ_NO_REMOTE': '1', 02:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:45 INFO - 'NO_EM_RESTART': '1', 02:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:45 INFO - 'PWD': '/builds/slave/test', 02:22:45 INFO - 'SHELL': '/bin/bash', 02:22:45 INFO - 'SHLVL': '1', 02:22:45 INFO - 'TERM': 'linux', 02:22:45 INFO - 'TMOUT': '86400', 02:22:45 INFO - 'USER': 'cltbld', 02:22:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:45 INFO - '_': '/tools/buildbot/bin/python'} 02:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:45 INFO - Downloading/unpacking jsonschema==2.5.1 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:22:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:22:47 INFO - warning: no files found matching '*.txt' 02:22:47 INFO - no previously-included directories found matching 'build' 02:22:47 INFO - no previously-included directories found matching 'dist' 02:22:47 INFO - no previously-included directories found matching '.git*' 02:22:47 INFO - Installing collected packages: jsonschema, functools32 02:22:47 INFO - Running setup.py install for functools32 02:22:47 INFO - warning: no files found matching '*.txt' 02:22:47 INFO - no previously-included directories found matching 'build' 02:22:47 INFO - no previously-included directories found matching 'dist' 02:22:47 INFO - no previously-included directories found matching '.git*' 02:22:47 INFO - Successfully installed jsonschema functools32 02:22:47 INFO - Cleaning up... 02:22:47 INFO - Return code: 0 02:22:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:47 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:47 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 02:22:47 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 02:22:47 INFO - Using env: {'DISPLAY': ':0', 02:22:47 INFO - 'HOME': '/home/cltbld', 02:22:47 INFO - 'LANG': 'en_US.UTF-8', 02:22:47 INFO - 'LANGUAGE': 'en_US:en', 02:22:47 INFO - 'LOGNAME': 'cltbld', 02:22:47 INFO - 'MAIL': '/var/mail/cltbld', 02:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:47 INFO - 'MOZ_NO_REMOTE': '1', 02:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:47 INFO - 'NO_EM_RESTART': '1', 02:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:47 INFO - 'PWD': '/builds/slave/test', 02:22:47 INFO - 'SHELL': '/bin/bash', 02:22:47 INFO - 'SHLVL': '1', 02:22:47 INFO - 'TERM': 'linux', 02:22:47 INFO - 'TMOUT': '86400', 02:22:47 INFO - 'USER': 'cltbld', 02:22:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:47 INFO - '_': '/tools/buildbot/bin/python'} 02:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:22:48 INFO - Cleaning up... 02:22:48 INFO - Return code: 0 02:22:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:48 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')]} 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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')]} 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:48 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:22:48 INFO - Using env: {'DISPLAY': ':0', 02:22:48 INFO - 'HOME': '/home/cltbld', 02:22:48 INFO - 'LANG': 'en_US.UTF-8', 02:22:48 INFO - 'LANGUAGE': 'en_US:en', 02:22:48 INFO - 'LOGNAME': 'cltbld', 02:22:48 INFO - 'MAIL': '/var/mail/cltbld', 02:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:48 INFO - 'MOZ_NO_REMOTE': '1', 02:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:48 INFO - 'NO_EM_RESTART': '1', 02:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:48 INFO - 'PWD': '/builds/slave/test', 02:22:48 INFO - 'SHELL': '/bin/bash', 02:22:48 INFO - 'SHLVL': '1', 02:22:48 INFO - 'TERM': 'linux', 02:22:48 INFO - 'TMOUT': '86400', 02:22:48 INFO - 'USER': 'cltbld', 02:22:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:48 INFO - '_': '/tools/buildbot/bin/python'} 02:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - Downloading docopt-0.6.1.tar.gz 02:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:50 INFO - Running setup.py install for blobuploader 02:22:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:50 INFO - Running setup.py install for requests 02:22:51 INFO - Running setup.py install for docopt 02:22:51 INFO - Successfully installed blobuploader requests docopt 02:22:51 INFO - Cleaning up... 02:22:51 INFO - Return code: 0 02:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:51 INFO - Using env: {'DISPLAY': ':0', 02:22:51 INFO - 'HOME': '/home/cltbld', 02:22:51 INFO - 'LANG': 'en_US.UTF-8', 02:22:51 INFO - 'LANGUAGE': 'en_US:en', 02:22:51 INFO - 'LOGNAME': 'cltbld', 02:22:51 INFO - 'MAIL': '/var/mail/cltbld', 02:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:51 INFO - 'MOZ_NO_REMOTE': '1', 02:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:51 INFO - 'NO_EM_RESTART': '1', 02:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:51 INFO - 'PWD': '/builds/slave/test', 02:22:51 INFO - 'SHELL': '/bin/bash', 02:22:51 INFO - 'SHLVL': '1', 02:22:51 INFO - 'TERM': 'linux', 02:22:51 INFO - 'TMOUT': '86400', 02:22:51 INFO - 'USER': 'cltbld', 02:22:51 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:51 INFO - '_': '/tools/buildbot/bin/python'} 02:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:51 INFO - Running setup.py (path:/tmp/pip-kaDN8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:51 INFO - Running setup.py (path:/tmp/pip-kupja4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:51 INFO - Running setup.py (path:/tmp/pip-yner6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:51 INFO - Running setup.py (path:/tmp/pip-Pdcr3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:51 INFO - Running setup.py (path:/tmp/pip-3vHmYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:52 INFO - Running setup.py (path:/tmp/pip-RYsFFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:52 INFO - Running setup.py (path:/tmp/pip-zEJ9yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:52 INFO - Running setup.py (path:/tmp/pip-0ItA4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:52 INFO - Running setup.py (path:/tmp/pip-fFabTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:52 INFO - Running setup.py (path:/tmp/pip-WBdvZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:52 INFO - Running setup.py (path:/tmp/pip-qSZWfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:52 INFO - Running setup.py (path:/tmp/pip-iC8Z4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:52 INFO - Running setup.py (path:/tmp/pip-ZD7KMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:52 INFO - Running setup.py (path:/tmp/pip-GbirfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:52 INFO - Running setup.py (path:/tmp/pip-YzXmvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:52 INFO - Running setup.py (path:/tmp/pip-VZbmbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:52 INFO - Running setup.py (path:/tmp/pip-1Zu1FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:52 INFO - Running setup.py install for manifestparser 02:22:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Running setup.py install for mozcrash 02:22:53 INFO - Running setup.py install for mozdebug 02:22:53 INFO - Running setup.py install for mozdevice 02:22:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Running setup.py install for mozfile 02:22:53 INFO - Running setup.py install for mozhttpd 02:22:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Running setup.py install for mozinfo 02:22:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Running setup.py install for mozInstall 02:22:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:53 INFO - Running setup.py install for mozleak 02:22:53 INFO - Running setup.py install for mozlog 02:22:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for moznetwork 02:22:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for mozprocess 02:22:54 INFO - Running setup.py install for mozprofile 02:22:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for mozrunner 02:22:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Running setup.py install for mozscreenshot 02:22:54 INFO - Running setup.py install for moztest 02:22:54 INFO - Running setup.py install for mozversion 02:22:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:54 INFO - Cleaning up... 02:22:54 INFO - Return code: 0 02:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:54 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:54 INFO - Using env: {'DISPLAY': ':0', 02:22:54 INFO - 'HOME': '/home/cltbld', 02:22:54 INFO - 'LANG': 'en_US.UTF-8', 02:22:54 INFO - 'LANGUAGE': 'en_US:en', 02:22:54 INFO - 'LOGNAME': 'cltbld', 02:22:54 INFO - 'MAIL': '/var/mail/cltbld', 02:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:54 INFO - 'MOZ_NO_REMOTE': '1', 02:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:54 INFO - 'NO_EM_RESTART': '1', 02:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:54 INFO - 'PWD': '/builds/slave/test', 02:22:54 INFO - 'SHELL': '/bin/bash', 02:22:54 INFO - 'SHLVL': '1', 02:22:54 INFO - 'TERM': 'linux', 02:22:54 INFO - 'TMOUT': '86400', 02:22:54 INFO - 'USER': 'cltbld', 02:22:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:54 INFO - '_': '/tools/buildbot/bin/python'} 02:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Running setup.py (path:/tmp/pip-jdGesI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Running setup.py (path:/tmp/pip-Hd_hbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Running setup.py (path:/tmp/pip-QXozEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:55 INFO - Running setup.py (path:/tmp/pip-Qak4Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:55 INFO - Running setup.py (path:/tmp/pip-uF6M2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:55 INFO - Running setup.py (path:/tmp/pip-HAj3sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:55 INFO - Running setup.py (path:/tmp/pip-iUxYt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:55 INFO - Running setup.py (path:/tmp/pip-q4Yg_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:55 INFO - Running setup.py (path:/tmp/pip-0PmcrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:55 INFO - Running setup.py (path:/tmp/pip-Ze5Q98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:55 INFO - Running setup.py (path:/tmp/pip-H2BcEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:55 INFO - Running setup.py (path:/tmp/pip-47LCZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:55 INFO - Running setup.py (path:/tmp/pip-Z2NMlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:55 INFO - Running setup.py (path:/tmp/pip-n0NUS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:56 INFO - Running setup.py (path:/tmp/pip-cHU5O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:56 INFO - Running setup.py (path:/tmp/pip-pyIb44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:56 INFO - Running setup.py (path:/tmp/pip-J3BQ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:22:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:58 INFO - Downloading blessings-1.6.tar.gz 02:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:22:58 INFO - Installing collected packages: blessings 02:22:58 INFO - Running setup.py install for blessings 02:22:58 INFO - Successfully installed blessings 02:22:58 INFO - Cleaning up... 02:22:58 INFO - Return code: 0 02:22:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:58 INFO - Reading from file tmpfile_stdout 02:22:58 INFO - Current package versions: 02:22:58 INFO - argparse == 1.2.1 02:22:58 INFO - blessings == 1.6 02:22:58 INFO - blobuploader == 1.2.4 02:22:58 INFO - docopt == 0.6.1 02:22:58 INFO - functools32 == 3.2.3-2 02:22:58 INFO - jsonschema == 2.5.1 02:22:58 INFO - manifestparser == 1.1 02:22:58 INFO - mozInstall == 1.12 02:22:58 INFO - mozcrash == 0.17 02:22:58 INFO - mozdebug == 0.1 02:22:58 INFO - mozdevice == 0.48 02:22:58 INFO - mozfile == 1.2 02:22:58 INFO - mozhttpd == 0.7 02:22:58 INFO - mozinfo == 0.9 02:22:58 INFO - mozleak == 0.1 02:22:58 INFO - mozlog == 3.4 02:22:58 INFO - moznetwork == 0.27 02:22:58 INFO - mozprocess == 0.23 02:22:58 INFO - mozprofile == 0.28 02:22:58 INFO - mozrunner == 6.12 02:22:58 INFO - mozscreenshot == 0.1 02:22:58 INFO - mozsystemmonitor == 0.3 02:22:58 INFO - moztest == 0.7 02:22:58 INFO - mozversion == 1.4 02:22:58 INFO - psutil == 3.1.1 02:22:58 INFO - requests == 1.2.3 02:22:58 INFO - wsgiref == 0.1.2 02:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 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 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:22:58 INFO - Using env: {'DISPLAY': ':0', 02:22:58 INFO - 'HOME': '/home/cltbld', 02:22:58 INFO - 'LANG': 'en_US.UTF-8', 02:22:58 INFO - 'LANGUAGE': 'en_US:en', 02:22:58 INFO - 'LOGNAME': 'cltbld', 02:22:58 INFO - 'MAIL': '/var/mail/cltbld', 02:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:58 INFO - 'MOZ_NO_REMOTE': '1', 02:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:58 INFO - 'NO_EM_RESTART': '1', 02:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:58 INFO - 'PWD': '/builds/slave/test', 02:22:58 INFO - 'SHELL': '/bin/bash', 02:22:58 INFO - 'SHLVL': '1', 02:22:58 INFO - 'TERM': 'linux', 02:22:58 INFO - 'TMOUT': '86400', 02:22:58 INFO - 'USER': 'cltbld', 02:22:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:58 INFO - '_': '/tools/buildbot/bin/python'} 02:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:22:58 INFO - Cleaning up... 02:22:58 INFO - Return code: 0 02:22:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a81a60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2534ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:22:58 INFO - Using env: {'DISPLAY': ':0', 02:22:58 INFO - 'HOME': '/home/cltbld', 02:22:58 INFO - 'LANG': 'en_US.UTF-8', 02:22:58 INFO - 'LANGUAGE': 'en_US:en', 02:22:58 INFO - 'LOGNAME': 'cltbld', 02:22:58 INFO - 'MAIL': '/var/mail/cltbld', 02:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:58 INFO - 'MOZ_NO_REMOTE': '1', 02:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:58 INFO - 'NO_EM_RESTART': '1', 02:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:58 INFO - 'PWD': '/builds/slave/test', 02:22:58 INFO - 'SHELL': '/bin/bash', 02:22:58 INFO - 'SHLVL': '1', 02:22:58 INFO - 'TERM': 'linux', 02:22:58 INFO - 'TMOUT': '86400', 02:22:58 INFO - 'USER': 'cltbld', 02:22:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:58 INFO - '_': '/tools/buildbot/bin/python'} 02:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:22:59 INFO - Cleaning up... 02:22:59 INFO - Return code: 0 02:22:59 INFO - Running post-action listener: _resource_record_post_action 02:22:59 INFO - Running post-action listener: _start_resource_monitoring 02:22:59 INFO - Starting resource monitoring. 02:22:59 INFO - [mozharness: 2016-09-28 09:22:59.080244Z] Finished create-virtualenv step (success) 02:22:59 INFO - [mozharness: 2016-09-28 09:22:59.080754Z] Running install step. 02:22:59 INFO - Running pre-action listener: _resource_record_pre_action 02:22:59 INFO - Running main action method: install 02:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:22:59 INFO - Reading from file tmpfile_stdout 02:22:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:22:59 INFO - Reading from file tmpfile_stdout 02:22:59 INFO - Output received: 02:22:59 INFO - Usage: mozinstall [options] installer 02:22:59 INFO - Options: 02:22:59 INFO - -h, --help show this help message and exit 02:22:59 INFO - -d DEST, --destination=DEST 02:22:59 INFO - Directory to install application into. [default: 02:22:59 INFO - "/builds/slave/test"] 02:22:59 INFO - --app=APP Application being installed. [default: firefox] 02:22:59 INFO - mkdir: /builds/slave/test/build/application 02:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:23:15 INFO - Reading from file tmpfile_stdout 02:23:15 INFO - Output received: 02:23:15 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:15 INFO - Running post-action listener: _resource_record_post_action 02:23:15 INFO - [mozharness: 2016-09-28 09:23:15.476050Z] Finished install step (success) 02:23:15 INFO - [mozharness: 2016-09-28 09:23:15.476296Z] Running run-tests step. 02:23:15 INFO - Running pre-action listener: _resource_record_pre_action 02:23:15 INFO - Running main action method: run_tests 02:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:15 INFO - Python 2.7.3 02:23:15 INFO - Return code: 0 02:23:15 INFO - grabbing minidump binary from tooltool 02:23: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')]} 02:23:15 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 0x2531f60>, '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 0x2532d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25331d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:23:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:23:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:23:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:15 INFO - Return code: 0 02:23:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:23:15 INFO - Using env: {'DISPLAY': ':0', 02:23:15 INFO - 'HOME': '/home/cltbld', 02:23:15 INFO - 'LANG': 'en_US.UTF-8', 02:23:15 INFO - 'LANGUAGE': 'en_US:en', 02:23:15 INFO - 'LOGNAME': 'cltbld', 02:23:15 INFO - 'MAIL': '/var/mail/cltbld', 02:23:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:15 INFO - 'MOZ_NO_REMOTE': '1', 02:23:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:15 INFO - 'NO_EM_RESTART': '1', 02:23:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:15 INFO - 'PWD': '/builds/slave/test', 02:23:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:15 INFO - 'SHELL': '/bin/bash', 02:23:15 INFO - 'SHLVL': '1', 02:23:15 INFO - 'TERM': 'linux', 02:23:15 INFO - 'TMOUT': '86400', 02:23:15 INFO - 'USER': 'cltbld', 02:23:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082', 02:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:15 INFO - '_': '/tools/buildbot/bin/python'} 02:23:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:23:15 INFO - mozversion application_buildid: 20160928011020 02:23:15 INFO - mozversion application_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 02:23:15 INFO - mozversion application_display_name: Nightly 02:23:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:15 INFO - mozversion application_name: Firefox 02:23:15 INFO - mozversion application_remotingname: firefox 02:23:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:23:15 INFO - mozversion application_vendor: Mozilla 02:23:15 INFO - mozversion application_version: 52.0a1 02:23:15 INFO - mozversion platform_buildid: 20160928011020 02:23:15 INFO - mozversion platform_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 02:23:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:23:15 INFO - mozversion platform_version: 52.0a1 02:23:15 INFO - using testdate: 1475054595 02:23:15 INFO - actual date: 1475054595 02:23:15 INFO - starting webserver on 'localhost:51256' 02:23:15 INFO - SUITE-START | Running 2 tests 02:23:15 INFO - TEST-START | dromaeo_css 02:23:15 INFO - operating with platform_type : linux_ 02:23:15 INFO - Initialising browser for dromaeo_css test... 02:23:15 INFO - TEST-INFO | started process 22988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEj95qJ/profile http://localhost:51256/getInfo.html) 02:23:19 INFO - PROCESS | 22988 | __metrics Screen width/height:1600/1200 02:23:19 INFO - PROCESS | 22988 | colorDepth:24 02:23:19 INFO - PROCESS | 22988 | Browser inner width/height: 1024/697 02:23:19 INFO - PROCESS | 22988 | __metrics 02:23:20 INFO - PROCESS | 22988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:23:20 INFO - PROCESS | 22988 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:20 INFO - PROCESS | 22988 | console.error: PushService: 02:23:20 INFO - PROCESS | 22988 | stateChangeProcessEnqueue: Error transitioning state 02:23:20 INFO - PROCESS | 22988 | UnknownError 02:23:21 INFO - TEST-INFO | 22988: exit 0 02:23:21 INFO - Browser initialized. 02:23:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:21 INFO - TEST-INFO | started process 23070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEj95qJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:33 INFO - PROCESS | 23070 | RSS: Main: 175345664 02:23:33 INFO - PROCESS | 23070 | 02:24:25 INFO - PROCESS | 23070 | 1475054665180 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:26:37 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51256/tests/dromaeo/cssquery-ext.html) 02:26:38 INFO - PROCESS | 23070 | RSS: Main: 308903936 02:26:38 INFO - PROCESS | 23070 | 02:29:41 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-ext.html (next: http://localhost:51256/tests/dromaeo/cssquery-jquery.html) 02:29:42 INFO - PROCESS | 23070 | RSS: Main: 275640320 02:29:42 INFO - PROCESS | 23070 | 02:32:44 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51256/tests/dromaeo/cssquery-mootools.html) 02:32:45 INFO - PROCESS | 23070 | RSS: Main: 218513408 02:32:45 INFO - PROCESS | 23070 | 02:35:47 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51256/tests/dromaeo/cssquery-prototype.html) 02:35:47 INFO - PROCESS | 23070 | RSS: Main: 220233728 02:35:47 INFO - PROCESS | 23070 | 02:38:51 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51256/tests/dromaeo/cssquery-yui.html) 02:38:51 INFO - PROCESS | 23070 | RSS: Main: 221605888 02:38:51 INFO - PROCESS | 23070 | 02:41:54 INFO - PROCESS | 23070 | Cycle 1(1): loaded http://localhost:51256/tests/dromaeo/cssquery-yui.html (next: http://localhost:51256/tests/dromaeo/cssquery-dojo.html) 02:41:55 INFO - PROCESS | 23070 | RSS: Main: 311664640 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | __start_tp_report 02:41:55 INFO - PROCESS | 23070 | _x_x_mozilla_page_load 02:41:55 INFO - PROCESS | 23070 | _x_x_mozilla_page_load_details 02:41:55 INFO - PROCESS | 23070 | |i|pagename|runs| 02:41:55 INFO - PROCESS | 23070 | |0;dojo.html;2584.44434446594;2612.516684413385;2645.153550863723;2653.3499292673296;2663.8268512546697;4676.508966558514;4698.73377635492;4748.643851711118;4776.211925032366;4807.182778927582;4732.692374995623;4738.644601654881;4788.473267940523;4788.784504697288;4847.927281090787;4294.806733696991;4323.675724320673;4370.628496577795;4392.5827046430695;4399.934000989988;4157.66738660908;4421.955780442203;4439.334099885011;4461.196984542781;4519.728816271017;4239.936400953989;4401.581849724271;4418.867433976986;4427.800748966304;4517.322401639747;4272.401863739079;4328.7402755834755;4332.935005974913;4334.176506463793;4389.846355377546;4351.216780979423;4353.455818022747;4356.6514678825615;4408.713433626836;4427.845025424094;4762.166620841339;4762.761861906891;4775.379200703886;4789.49710280419;4797.568218860284;4922.286268491049;4966.726830024347;5019.84940451787;5021.673591216596;5102;5116.820911268088;5118.053160165381;5119.872003199913;5162.638615296931;5173.120569503193;4776.47458779534;4782.163121453732;4783.784729687172;4783.856484305476;4841.709497430165;5061.063703214917;5111.948880511147;5208.166693329049;5219;5295.523402893758;5002.499750024968;5037.823676171316;5038.269450929594;5101.0308041472;5107.361579802525;5107.336046313955;5118.846434606968;5119.283300337956;5122.487751224922;5185.988732197261;4887.902241955212;4941.777620007108;5074.797008119708;5082;5093.821716239914;4956.553910148104;4974.602031837444;5019.899602008012;5082.415522214993;5091.439941606494;4292.935605965913;4304.504981927118;4305.203537345601;4306.397104405386;4358.084802191512;3713.851445942132;3789.1853251551047;3792.3173828711097;3811.7903515306925;3815.389537673959;4269.914601707948;4282.100758840616;4301.634361079344;4304.4834619845815;4358.5205627380965;5040.445550989388;5051.908282918799;5054.873628159326;5055.595552355802;5093.057784309841;4273.166732487197;4303.677224208197;4303.763293018914;4306.720063195945;4357.9782101089295;4444.777761111932;4459.620932220798;4496.010877606921;4504.707194032443;4516.6160876325885;4682.1103990241745;4688.2733176357715;4690.437147542317;4713.929291060568;4731.763411829326;5014.7994080236385;5025.597952163891;5027.396712394536;5035.118854200427;5097.388313402415;4531.229690952612;4576.244919588231;4662.300654901792;4672.112298663243;4704.858854234241;5017.623678224075;5027;5027.773750181177;5079.796808127633;5089.211172268304;5071.92392114126;5089.720065396291;5091.745412729423;5091.974540127276;5148.665336753099;4787.760611969457;4798.23228283473;4822.42130944289;4948.233023881304;4966.950330496793;4813.205821039489;4900.558949694402;4902.583280421204;4942.678725882806;4966.726830024239;4801.6607698027;4839.056384005085;4841.031793641216;4852.490488498657;4908.9754551227015;4762.9285560715925;4809.326694262736;4910.45984941649;4968.378952630921;4981.950180498148;4845.224764037737;4869;4916.287138364989;4934.950650493449;4948.084604348207 02:41:55 INFO - PROCESS | 23070 | |1;ext.html;570.164708701752;572.6993328502539;577.4716134736716;582.4815913836686;583.1456915618618;28059.29851753707;41851.581484185146;43432.56567434325;43563.128737425235;43745.343819842645;39894.60105398945;40194.56886898097;40265.39601905966;40377.39433908494;40398.59601403985;7661.770146895588;7715;7718.151003389623;7811.414143939227;7823.569703666296;7655.923440765577;7742.070951485802;7759.5344279343135;7763.689452421896;7763.689452421896;7751.496152750082;7788.961055194716;7791.987041684573;7801.453898227126;7802.024746906637;7742.109657389387;7771.106322772897;7772.106207786121;7779.688812447495;7781.455298129134;7636.007319048488;7681.731139410093;7706.922930770676;7709.267619576131;7709.884351734729;37437.81281093604;37806.81096594527;37848.43227351592;37871.81064094662;37874.24251514954;2874.594691072798;3036.0739974307826;3065.1877252528097;3243.189202699325;3321.368939901411;27865.86067069672;28129.57805632917;28194.295142621395;28808;29381.41237175266;3369.359821633882;3465.5668041494814;3508.19311558343;3551.8401671924826;3584.551931008624;262875;263767.9999999981;263915;264095;265068.58902575495;31031.224219394244;31996.680033199835;32065.19837004047;34037.31925361479;53351.466485335426;33723;33845.153871153416;33866.153346166546;33874;33883.32233355319;13067.542636007884;13185.53850615243;13192.934035329761;13195.868041319656;13196.736065278641;10680.839787403194;10714.678559643224;10728.73178170552;10732.356058636507;10786.56853725858;7699.422543309274;7752.4573279869865;7780.377569794403;7843.6470358833985;7853.253940875607;3063.188255112397;3075.2773098321877;3081.6764239754953;3098.798578092462;3112.346407254502;838.9706360277361;899.7255836969656;902.9503377314179;925.9537023148815;947.1239103828931;26373.868130659223;27595.31011724723;27733.722662773518;28239.43521129566;28273.57589636157;941.1717688434271;960.2845879819439;964.4309857184295;996.1433167475965;1009.2934945538005;13894.583162505141;14587.41650333996;14658.340374683165;15017;15021.173835439156;360489;364308;364456;364871;364912;48894.51105488971;49053.509464905605;49183.50816491861;49193;49339.25991110136;972.2270794718357;1046.5081411736471;1119.630521927778;1163.831244469547;1184.1119160629528;25543.23370298894;28861;29317.26706832346;29519.704802951695;29662.555061673662;40524.9343832021;41074.794626026676;41084.1783164341;41103.794481027406;41152.58847411488;283031;283954;284348;284556;285107;21593.13627454884;22382.66426003644;22862.77137228673;23924.880375598706;25104.246872593852;40297.99255018531;40398.39402408907;40407.1918561633;41023;41046.45872807133;34106;34428.31143377168;34890.82554587211;34920.65079349276;34970;34256.143596410286;34263.65736342605;34433;34791.47812782861;34869.825650871586;34133.48799768055;34341.484877726354;34586.30827383488;35108.12229694278;37070.629293707796;34037.65962340345;34517.65482345144;36957;37434.812825935696;37444.81277593595;27259.727402726512;29313;29836.61021991969;29903.55144672788;30382.392352153274 02:41:55 INFO - PROCESS | 23070 | |2;jquery.html;364.74285628631816;367.79219740846423;379.34562879033655;379.4232766195383;396.89879080834385;15209.315580798862;16518.339266429342;17260.91369543152;17364.652706945853;17370.21834017472;16860.241289141988;16882.240299186535;17099.23053462594;17304.56738581536;17409.47771566852;5018.2974383586325;5276.8153114641;5288.894222115556;5292.629515933886;5296.894062118756;3671.816409179544;3888.863889763845;5121.718305493197;5750.108733146369;5998.910016349758;6090.847728806771;6096.725647345858;6098.695065246742;6101.725422355982;6107.419795119479;5884;6099.115628233903;6127.172831667713;6139.508839292846;6150.169727086831;4624.884377890546;5366.758495867695;5367.087595108841;5374.516293533562;5378.97310513445;11501.88498115025;11875.52497900083;11879.58421455245;11883.762324753456;11905.761884762343;1810.9185086671132;1869.2336142181775;1875.4279944616887;1989.2341448542415;2087.3633541769755;8809.295256379473;8959.776005599848;8995.235404990584;9053.230475409599;9221.67724129659;1614.7497137943637;1621.1813034417662;1634.820169781323;1642.5154579398986;1732.8267173282698;71427.28572714259;72040.6397968012;72406.63796680982;72973.63513182453;73500.6324968377;9630.662926797668;9791.167750741124;9849.50752462374;10072.841623213279;10755.892441075646;13888.513902013381;13889.305534723224;13943.721125577431;13948.930255348658;13957.162570245819;6573.112629795012;6683.933160668331;6803;6855.828604284833;6898.448124150056;5558.499735023786;5733.655980641175;5753.827385178452;6125.234345706786;6142.170806941006;3969.583193764671;4003.959960400417;4171.018766086085;4277.230098582285;4279.358096285582;1551.4027099566522;1672.3227093027344;1683.2425408566194;1734.0376091269213;1760.8503277221323;793.5119901260683;868.669905435943;872.1888643561549;879.4195830751801;884.8982367027875;16178.595535111717;16601.098741795668;16673.333066677198;16997.575060623585;17742.379016734354;833.9916600833914;851.4040171879709;861.4874149880811;875.1211993138279;897.869808877709;9022.323325750463;9160.931088085432;9540.666076687283;9654.613815447445;9659.71020869361;174619;177028;383913;385246;386994;70376;81360;82035;82041;82436;848.8514509960733;885.1900511032334;925.2782829393084;948.0898337595985;951.8477043672979;15030.549083527512;15777.68444631078;16412.507624771275;16435.01389916561;16748.916255418644;26675.866620666773;27036.864815675795;35250.294994100484;37528.49886004529;38883.611163887996;46828.7658561705;47560;47877.760611198115;49040.2643960348;51386.229206561184;6605.405513503808;6878.209005964378;7021.929780702128;7343.77968660941;7700.037495313086;11356.148288878532;12128.151029428209;12313.507459701512;12500.06249531307;12558.358076157812;10468.738281543023;10516.57933682644;10537.789244214919;10539.894601053891;10943.124550036136;10362.222833287382;10368.585256589953;10415.1667866572;10520.736981575521;10591.20565957541;10156.289059765746;10488.632897848538;10635.734106647396;11038.944805275922;11224.831627525431;6845.589264644137;7017.193022802443;7105.751298704728;7107.893381599383;7109.644517774194;9940.502974851084;10662.8400573993;10792.244542881923;10820.837687434852;10880.075193608633 02:41:55 INFO - PROCESS | 23070 | |3;mootools.html;1278.469435184399;1325.2644782145906;1343.9852911052155;1618.100378088806;1671.7492376143568;6747.763828266012;7004.194517630474;7408.814779630512;8051.476654017485;8054.476459030167;7390.963045184767;7706.4990775599545;7708.498947568404;7890;7894.578975784357;2134.8505604607685;2159.730033745782;2163.1131236193164;2165.2746329979395;2170.3163503496426;1703.761473393726;1754.9649007019852;2081.7189679393314;2144.924927627533;2155.7305336832897;2011.2457828314382;2044.0393015282793;2045.6726923692213;2049.3237231713497;2054.1783286685295;1917.5685470769106;1920.4334721257194;1991.9203231870708;2066.6360202266583;2068.131384818365;2055.3628375203734;2067.917283308666;2069.1516478244;2072.1504183284933;2087.2590230468118;8014;8033.397495187826;8111.594420278962;8118.391120665974;8129.349652027883;4298.398224248608;4413;4413.3821265022925;4415.712978656377;4416.624586910117;2771.986140069307;2883.9279018024718;2892;2914.329704168053;2921.2550799546193;862.5600943518788;872.8210716803104;886.3308202307281;892.5983307511581;902.1519771414848;10440.68677939663;10443.582256709722;10446.634367797167;10456.215783816167;10514.631987880464;3795.449659799369;3940.7241493095207;4067.084905896209;4091.89770255746;4200.180964711913;9026.142516460926;9033.05152958943;9045.095490450902;9051.954740226389;9054.81890362189;4622.86131416058;4624.97687511567;4625.676202665781;4626.583607475276;4634.675572709878;4163.250614889349;4232.280512312914;4243.27864263076;4248.129133527619;4258.190943720683;3521.735869809723;3555.5733312002726;3635.1820840311248;3659.780413175218;3676.191237927652;1054.773223756896;1079.5250089960393;1128.1426116151783;1150.5282834038005;1159.3217967488945;744.7840126363294;765.2615226306641;812.8577498937781;813.1868131868132;835.4653022065883;5020.196768517093;5156.381234251914;5265.736713164327;5312.468753124656;5346.839594812084;850.8000619854329;864.9567521623893;888.6800751729372;892.205936716323;914.8307563100848;3533.222691007974;3533.717302615785;3559.875404360835;3566.28674265148;3685.723570732152;9514.857277140849;9808.803823923481;9869.506524673738;9879.654212102541;9888.20894328452;9725.513724313756;9781.266405019653;9784.706458806248;9811.509424528887;9823.705288841204;7002.544834585736;7162.176349719744;7284;7339.266073392725;7423.035005449365;5571.526420254162;5631.267935168402;5662.933029444305;5772.278465191851;5855.887311579074;8886.422382545114;8929.196372326522;9072.999999999736;9104.590293436944;9152.22206112488;8880.689175878813;9195.678151264941;9196;9211.907880921104;9306.208972237435;6695.866082678222;6828.760993365208;6836.179658441019;6836.897446538206;6841.589504629738;7470.252974702486;7473.588952607442;7486.064241969754;7507.436942229246;7550.942867998595;6454.096426500388;6459.61242325462;6623.470122390101;6696.464282857457;6747.257801641914;6359.682015899279;6461.386168314003;6500.804975850732;6612.702428390638;6629.038789375417;6104.236970378703;6157.96921015392;6227.875442491216;6229.781957631461;6287.811365659038;4461.063176732792;4505.61702255312;4554.863354099382;4576.695641742088;4767.046590681808;4519.141363141124;4549;4562.361269422217;4584.564466375689;4638.095571363552 02:41:55 INFO - PROCESS | 23070 | |4;prototype.html;292.5859908229855;297.33545525749946;306.6994345541368;307.4113073464316;307.6615722705024;4799.400074990626;4813.3983252093485;4831.589314908237;4842.85471435857;4885.584725298354;4734.502877197896;4782.210935195697;4785.425748910127;4797.136515427222;4800.639952003597;3779;3791.3744232201793;3805.2009078093565;3812.4662547243406;3815.9809200953955;3687.926241475169;3812.1041555234497;3828.7894165820867;3847.3844184930417;3858.151206734514;3765.265773174232;3768.943465848001;3769.6795772359383;3778.9622103778884;3800.296945065158;3755.699544036484;3759.680427163667;3768.152165762709;3769.1330993871425;3770.8491660333552;3105.642851072133;3203.6956489133495;3248.415285248654;3361.2605226850055;3364.66353364664;4630.328602352673;4653.0689763748005;4657.138429390574;4670.883227919295;4675.742834144121;4281.721688090295;4291.420658211164;4298.398224248608;4325.243082460557;4326.783660816946;4624.560666736655;4708.176069187913;5005.57452616528;5033.874153146164;5035.672681275742;3601.5318008658705;3613.7470377073614;3619.348517266917;3639;3649.708023358125;5236.73816309183;5255.658382205144;5261.789528418859;5263.0000299942885;5274.393444753864;3635.0003748968716;3752.493413389212;3757.9060523486582;3759.774413535197;3761.3041587306434;3809.638084382035;3810.9237815244096;3817.5800661927165;3822.7897465639103;3824.598417166213;4272.850450234227;4277.57224277576;4284.464441944757;4287.871363859089;4322.222000040023;4998.475160108136;5000.474950130257;5004.799808007711;5007.649464537448;5014.648974571745;1274.8916342111024;1322.4313545175667;1327.3628658244097;1335.5125379236704;1337.8729020743015;816.9331591074591;840.82342708032;842.6460886427715;851.5316575883239;852.0244320253399;3863.362545180014;3872.8838134856;3937.586553411908;3955.782431966212;3958.188571342868;4500.887477813081;4536.274196128669;4551.884788226906;4552.884543286916;4554.886127846764;3888.616903294152;3897.8830635080994;3908.2378936107184;3909.276783795007;3925.5878132795647;2281.1673739085445;2375.346779635614;2395.2215529952487;2418.762644553781;2423.9272821815375;4226.978865105655;4548.7725613719185;4684.508126646721;4700.931590100345;4776.9761151194025;5236.842894713165;5251.10731175701;5258.342707161605;5261.921540991287;5261.973690131601;4807.61539076873;4811.975940120277;4812.422509298836;4820.734859582757;4827;4963.578095861748;5081.5426611605135;5101.183810590436;5124.666896651705;5173.4826517347965;4967.155583550732;4980.651354405157;4983.8504844854715;4991.2513123030385;5019.84940451787;4754.23932170851;4756.310335001474;4788.784504697227;4790.952090479051;4792;3581.409067503833;3732;3772.830222640043;3785.971223021517;3796.46849441084;5077.898442031213;5107.931287828435;5123.154679477993;5125.641205115606;5170.663906846043;4974.502549744997;4981.277714731416;5016.523430274118;5018.447970723145;5029.4216165140015;4688.33564084745;4971.6022718183185;4993.329902521717;5028.597712182944;5035.723035233097;4925.359703238556;4945.208766597327;4948.698855032283;4950.232713929347;4979.925301120558;5033.949660503348;5058.342415485963;5066.392032956069;5078.136716758087;5079.6952182869145;4812.711237325631;4910.21436570147;4928.531789479994;4937;4943.65394422387 02:41:55 INFO - PROCESS | 23070 | |5;yui.html;619.6684773646099;696.2758730919841;724.9705418306005;737.7639155470251;740.2745309596595;11962.940185299072;13010.73978520429;13174.802377964314;13179.538716144936;13180.670483237924;14514;14667.779983300232;14755.704885902276;14822.184779837105;14832.48086316979;750.5234176298036;773.5165521549031;775.8681024225895;776.1423626892288;777.063638315828;622.9906551401733;643.1157158906503;745.8545583611198;768.6464226455837;772.9574873381962;821.8643923752574;822.4859462835727;823.1521532821204;823.3742355809597;824.286991752136;817.0726225733775;817.8854960305562;817.9304759095484;820.1429506166041;821.2362502872327;477.57018683185066;487.44918242386234;571.4514066496168;584.6550535184261;588.7085892483205;12951.740965180643;12989.285589292585;12991.935040324832;13003.804942925864;13018.414171362312;12014.279143251433;12446.626601201979;12479.93760031194;12493.18794278369;13278.336083195802;11708.53165873364;11832.349220792852;11965.700857478545;12101.152919295653;12661.683457913534;4157.48031496063;4178.707490475668;4180.101278225196;4371.759553224571;4383.123375324916;65847.3415265846;66597.33402665959;67323.32676673269;67814;68577.65711171462;10160.33957792756;10337.586496540054;10455.21585881062;10483.47582620866;10573.89426105729;18508.16713247907;18560.350387736366;18624.627507450045;18649.533761655795;18884.339048133523;6223.844403889849;6244.375562443719;6286.339934306923;6300.936990630035;6492.642904640195;3562.3587754203973;3562.8931132066077;3569.37535931211;3582;3601.405768048243;2598.9090381836545;2666.186813022008;2679.7186295439087;2679.866006699657;2684.6509953706286;496.67467808585434;499.88002879308704;502.1989926067916;509.03283760854674;514.665467446163;464.3104989091197;465.3066930273935;525.8107081450675;569.7635481275307;585.7217821534737;7970.4819186752675;8559.272461840688;8698.434601750865;8805.16350946659;8852.424592401474;526.3788729299387;546.2461802712311;621.4500167351836;631.6841579210395;633.7053270229366;3906.8632597859505;3985.20295940813;4020.4974378202724;4054.6756259499757;4081.77550234734;99496.50251748695;100248.99502010064;103891.48054259832;107239;111270;87317.56341218253;88360;91397.54301228584;91518;92152;60740;77161;78354.6082269585;79410;81293.18706812974;8163.3469322452875;8807.735767926717;8835;8891.866622000805;8906.332025098272;32592.511112333807;33693.32613347768;40116;40562;41959.580404196786;34771;34887.65112348844;35669.1082722934;52992;62012;10633.255672103189;10844.24090313702;11066.502007409847;11136.832947505633;11372.886271137182;12444.191127576678;12494.68763280889;12582.748345033231;13163.934180329037;13374.732505350034;11213.439328033728;11602.361870097226;11693.562423850746;12427.44076516577;12480.937595311965;10160.898391015995;10240.948795255976;10348.335111740587;10917.672469825919;10992.340459572451;11641.6507504775;11796;12543.56097536582;12594.559190428658;12612.117151799286;9444.716658500256;9540.713778586654;9728;9846.803063938825;10193.898061019296;9176.495292758962;9875.753106172404;9908.702738917844;9983.1013916501;10022.849657255292 02:41:55 INFO - PROCESS | 23070 | __end_tp_report 02:41:55 INFO - PROCESS | 23070 | __start_cc_report 02:41:55 INFO - PROCESS | 23070 | _x_x_mozilla_cycle_collect,1057 02:41:55 INFO - PROCESS | 23070 | __end_cc_report 02:41:55 INFO - PROCESS | 23070 | __startTimestamp1475055715071__endTimestamp 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | ------- Summary: start ------- 02:41:55 INFO - PROCESS | 23070 | Number of tests: 6 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#0] dojo.html Cycles:165 Average:4676.51 Median:4789.50 stddev:493.29 (10.3%) stddev-sans-first:466.70 02:41:55 INFO - PROCESS | 23070 | Values: 2584.4 2612.5 2645.2 2653.3 2663.8 4676.5 4698.7 4748.6 4776.2 4807.2 4732.7 4738.6 4788.5 4788.8 4847.9 4294.8 4323.7 4370.6 4392.6 4399.9 4157.7 4422.0 4439.3 4461.2 4519.7 4239.9 4401.6 4418.9 4427.8 4517.3 4272.4 4328.7 4332.9 4334.2 4389.8 4351.2 4353.5 4356.7 4408.7 4427.8 4762.2 4762.8 4775.4 4789.5 4797.6 4922.3 4966.7 5019.8 5021.7 5102.0 5116.8 5118.1 5119.9 5162.6 5173.1 4776.5 4782.2 4783.8 4783.9 4841.7 5061.1 5111.9 5208.2 5219.0 5295.5 5002.5 5037.8 5038.3 5101.0 5107.4 5107.3 5118.8 5119.3 5122.5 5186.0 4887.9 4941.8 5074.8 5082.0 5093.8 4956.6 4974.6 5019.9 5082.4 5091.4 4292.9 4304.5 4305.2 4306.4 4358.1 3713.9 3789.2 3792.3 3811.8 3815.4 4269.9 4282.1 4301.6 4304.5 4358.5 5040.4 5051.9 5054.9 5055.6 5093.1 4273.2 4303.7 4303.8 4306.7 4358.0 4444.8 4459.6 4496.0 4504.7 4516.6 4682.1 4688.3 4690.4 4713.9 4731.8 5014.8 5025.6 5027.4 5035.1 5097.4 4531.2 4576.2 4662.3 4672.1 4704.9 5017.6 5027.0 5027.8 5079.8 5089.2 5071.9 5089.7 5091.7 5092.0 5148.7 4787.8 4798.2 4822.4 4948.2 4967.0 4813.2 4900.6 4902.6 4942.7 4966.7 4801.7 4839.1 4841.0 4852.5 4909.0 4762.9 4809.3 4910.5 4968.4 4982.0 4845.2 4869.0 4916.3 4935.0 4948.1 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#1] ext.html Cycles:180 Average:44638.27 Median:34945.33 stddev:80790.36 (231.2%) stddev-sans-first:80949.24 02:41:55 INFO - PROCESS | 23070 | Values: 570.2 572.7 577.5 582.5 583.1 28059.3 41851.6 43432.6 43563.1 43745.3 39894.6 40194.6 40265.4 40377.4 40398.6 7661.8 7715.0 7718.2 7811.4 7823.6 7655.9 7742.1 7759.5 7763.7 7763.7 7751.5 7789.0 7792.0 7801.5 7802.0 7742.1 7771.1 7772.1 7779.7 7781.5 7636.0 7681.7 7706.9 7709.3 7709.9 37437.8 37806.8 37848.4 37871.8 37874.2 2874.6 3036.1 3065.2 3243.2 3321.4 27865.9 28129.6 28194.3 28808.0 29381.4 3369.4 3465.6 3508.2 3551.8 3584.6 262875.0 263768.0 263915.0 264095.0 265068.6 31031.2 31996.7 32065.2 34037.3 53351.5 33723.0 33845.2 33866.2 33874.0 33883.3 13067.5 13185.5 13192.9 13195.9 13196.7 10680.8 10714.7 10728.7 10732.4 10786.6 7699.4 7752.5 7780.4 7843.6 7853.3 3063.2 3075.3 3081.7 3098.8 3112.3 839.0 899.7 903.0 926.0 947.1 26373.9 27595.3 27733.7 28239.4 28273.6 941.2 960.3 964.4 996.1 1009.3 13894.6 14587.4 14658.3 15017.0 15021.2 360489.0 364308.0 364456.0 364871.0 364912.0 48894.5 49053.5 49183.5 49193.0 49339.3 972.2 1046.5 1119.6 1163.8 1184.1 25543.2 28861.0 29317.3 29519.7 29662.6 40524.9 41074.8 41084.2 41103.8 41152.6 283031.0 283954.0 284348.0 284556.0 285107.0 21593.1 22382.7 22862.8 23924.9 25104.2 40298.0 40398.4 40407.2 41023.0 41046.5 34106.0 34428.3 34890.8 34920.7 34970.0 34256.1 34263.7 34433.0 34791.5 34869.8 34133.5 34341.5 34586.3 35108.1 37070.6 34037.7 34517.7 36957.0 37434.8 37444.8 27259.7 29313.0 29836.6 29903.6 30382.4 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#2] jquery.html Cycles:180 Average:21597.10 Median:4224.12 stddev:53499.57 (1266.5%) stddev-sans-first:53625.90 02:41:55 INFO - PROCESS | 23070 | Values: 364.7 367.8 379.3 379.4 396.9 15209.3 16518.3 17260.9 17364.7 17370.2 16860.2 16882.2 17099.2 17304.6 17409.5 5018.3 5276.8 5288.9 5292.6 5296.9 3671.8 3888.9 5121.7 5750.1 5998.9 6090.8 6096.7 6098.7 6101.7 6107.4 5884.0 6099.1 6127.2 6139.5 6150.2 4624.9 5366.8 5367.1 5374.5 5379.0 11501.9 11875.5 11879.6 11883.8 11905.8 1810.9 1869.2 1875.4 1989.2 2087.4 8809.3 8959.8 8995.2 9053.2 9221.7 1614.7 1621.2 1634.8 1642.5 1732.8 71427.3 72040.6 72406.6 72973.6 73500.6 9630.7 9791.2 9849.5 10072.8 10755.9 13888.5 13889.3 13943.7 13948.9 13957.2 6573.1 6683.9 6803.0 6855.8 6898.4 5558.5 5733.7 5753.8 6125.2 6142.2 3969.6 4004.0 4171.0 4277.2 4279.4 1551.4 1672.3 1683.2 1734.0 1760.9 793.5 868.7 872.2 879.4 884.9 16178.6 16601.1 16673.3 16997.6 17742.4 834.0 851.4 861.5 875.1 897.9 9022.3 9160.9 9540.7 9654.6 9659.7 174619.0 177028.0 383913.0 385246.0 386994.0 70376.0 81360.0 82035.0 82041.0 82436.0 848.9 885.2 925.3 948.1 951.8 15030.5 15777.7 16412.5 16435.0 16748.9 26675.9 27036.9 35250.3 37528.5 38883.6 46828.8 47560.0 47877.8 49040.3 51386.2 6605.4 6878.2 7021.9 7343.8 7700.0 11356.1 12128.2 12313.5 12500.1 12558.4 10468.7 10516.6 10537.8 10539.9 10943.1 10362.2 10368.6 10415.2 10520.7 10591.2 10156.3 10488.6 10635.7 11038.9 11224.8 6845.6 7017.2 7105.8 7107.9 7109.6 9940.5 10662.8 10792.2 10820.8 10880.1 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#3] mootools.html Cycles:180 Average:5114.52 Median:5601.40 stddev:2912.85 (52.0%) stddev-sans-first:2906.75 02:41:55 INFO - PROCESS | 23070 | Values: 1278.5 1325.3 1344.0 1618.1 1671.7 6747.8 7004.2 7408.8 8051.5 8054.5 7391.0 7706.5 7708.5 7890.0 7894.6 2134.9 2159.7 2163.1 2165.3 2170.3 1703.8 1755.0 2081.7 2144.9 2155.7 2011.2 2044.0 2045.7 2049.3 2054.2 1917.6 1920.4 1991.9 2066.6 2068.1 2055.4 2067.9 2069.2 2072.2 2087.3 8014.0 8033.4 8111.6 8118.4 8129.3 4298.4 4413.0 4413.4 4415.7 4416.6 2772.0 2883.9 2892.0 2914.3 2921.3 862.6 872.8 886.3 892.6 902.2 10440.7 10443.6 10446.6 10456.2 10514.6 3795.4 3940.7 4067.1 4091.9 4200.2 9026.1 9033.1 9045.1 9052.0 9054.8 4622.9 4625.0 4625.7 4626.6 4634.7 4163.3 4232.3 4243.3 4248.1 4258.2 3521.7 3555.6 3635.2 3659.8 3676.2 1054.8 1079.5 1128.1 1150.5 1159.3 744.8 765.3 812.9 813.2 835.5 5020.2 5156.4 5265.7 5312.5 5346.8 850.8 865.0 888.7 892.2 914.8 3533.2 3533.7 3559.9 3566.3 3685.7 9514.9 9808.8 9869.5 9879.7 9888.2 9725.5 9781.3 9784.7 9811.5 9823.7 7002.5 7162.2 7284.0 7339.3 7423.0 5571.5 5631.3 5662.9 5772.3 5855.9 8886.4 8929.2 9073.0 9104.6 9152.2 8880.7 9195.7 9196.0 9211.9 9306.2 6695.9 6828.8 6836.2 6836.9 6841.6 7470.3 7473.6 7486.1 7507.4 7550.9 6454.1 6459.6 6623.5 6696.5 6747.3 6359.7 6461.4 6500.8 6612.7 6629.0 6104.2 6158.0 6227.9 6229.8 6287.8 4461.1 4505.6 4554.9 4576.7 4767.0 4519.1 4549.0 4562.4 4584.6 4638.1 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#4] prototype.html Cycles:180 Average:4111.93 Median:4664.01 stddev:1195.23 (25.6%) stddev-sans-first:1163.70 02:41:55 INFO - PROCESS | 23070 | Values: 292.6 297.3 306.7 307.4 307.7 4799.4 4813.4 4831.6 4842.9 4885.6 4734.5 4782.2 4785.4 4797.1 4800.6 3779.0 3791.4 3805.2 3812.5 3816.0 3687.9 3812.1 3828.8 3847.4 3858.2 3765.3 3768.9 3769.7 3779.0 3800.3 3755.7 3759.7 3768.2 3769.1 3770.8 3105.6 3203.7 3248.4 3361.3 3364.7 4630.3 4653.1 4657.1 4670.9 4675.7 4281.7 4291.4 4298.4 4325.2 4326.8 4624.6 4708.2 5005.6 5033.9 5035.7 3601.5 3613.7 3619.3 3639.0 3649.7 5236.7 5255.7 5261.8 5263.0 5274.4 3635.0 3752.5 3757.9 3759.8 3761.3 3809.6 3810.9 3817.6 3822.8 3824.6 4272.9 4277.6 4284.5 4287.9 4322.2 4998.5 5000.5 5004.8 5007.6 5014.6 1274.9 1322.4 1327.4 1335.5 1337.9 816.9 840.8 842.6 851.5 852.0 3863.4 3872.9 3937.6 3955.8 3958.2 4500.9 4536.3 4551.9 4552.9 4554.9 3888.6 3897.9 3908.2 3909.3 3925.6 2281.2 2375.3 2395.2 2418.8 2423.9 4227.0 4548.8 4684.5 4700.9 4777.0 5236.8 5251.1 5258.3 5261.9 5262.0 4807.6 4812.0 4812.4 4820.7 4827.0 4963.6 5081.5 5101.2 5124.7 5173.5 4967.2 4980.7 4983.9 4991.3 5019.8 4754.2 4756.3 4788.8 4791.0 4792.0 3581.4 3732.0 3772.8 3786.0 3796.5 5077.9 5107.9 5123.2 5125.6 5170.7 4974.5 4981.3 5016.5 5018.4 5029.4 4688.3 4971.6 4993.3 5028.6 5035.7 4925.4 4945.2 4948.7 4950.2 4979.9 5033.9 5058.3 5066.4 5078.1 5079.7 4812.7 4910.2 4928.5 4937.0 4943.7 02:41:55 INFO - PROCESS | 23070 | 02:41:55 INFO - PROCESS | 23070 | [#5] yui.html Cycles:180 Average:17650.69 Median:23069.84 stddev:25919.41 (112.4%) stddev-sans-first:25960.57 02:41:55 INFO - PROCESS | 23070 | Values: 619.7 696.3 725.0 737.8 740.3 11962.9 13010.7 13174.8 13179.5 13180.7 14514.0 14667.8 14755.7 14822.2 14832.5 750.5 773.5 775.9 776.1 777.1 623.0 643.1 745.9 768.6 773.0 821.9 822.5 823.2 823.4 824.3 817.1 817.9 817.9 820.1 821.2 477.6 487.4 571.5 584.7 588.7 12951.7 12989.3 12991.9 13003.8 13018.4 12014.3 12446.6 12479.9 12493.2 13278.3 11708.5 11832.3 11965.7 12101.2 12661.7 4157.5 4178.7 4180.1 4371.8 4383.1 65847.3 66597.3 67323.3 67814.0 68577.7 10160.3 10337.6 10455.2 10483.5 10573.9 18508.2 18560.4 18624.6 18649.5 18884.3 6223.8 6244.4 6286.3 6300.9 6492.6 3562.4 3562.9 3569.4 3582.0 3601.4 2598.9 2666.2 2679.7 2679.9 2684.7 496.7 499.9 502.2 509.0 514.7 464.3 465.3 525.8 569.8 585.7 7970.5 8559.3 8698.4 8805.2 8852.4 526.4 546.2 621.5 631.7 633.7 3906.9 3985.2 4020.5 4054.7 4081.8 99496.5 100249.0 103891.5 107239.0 111270.0 87317.6 88360.0 91397.5 91518.0 92152.0 60740.0 77161.0 78354.6 79410.0 81293.2 8163.3 8807.7 8835.0 8891.9 8906.3 32592.5 33693.3 40116.0 40562.0 41959.6 34771.0 34887.7 35669.1 52992.0 62012.0 10633.3 10844.2 11066.5 11136.8 11372.9 12444.2 12494.7 12582.7 13163.9 13374.7 11213.4 11602.4 11693.6 12427.4 12480.9 10160.9 10240.9 10348.3 10917.7 10992.3 11641.7 11796.0 12543.6 12594.6 12612.1 9444.7 9540.7 9728.0 9846.8 10193.9 9176.5 9875.8 9908.7 9983.1 10022.8 02:41:55 INFO - PROCESS | 23070 | -------- Summary: end -------- 02:41:55 INFO - PROCESS | 23070 | 02:41:56 INFO - TEST-INFO | 23070: exit 0 02:41:56 INFO - TEST-OK | dromaeo_css | took 1120361ms 02:41:56 INFO - TEST-START | kraken 02:41:56 INFO - operating with platform_type : linux_ 02:41:56 INFO - Initialising browser for kraken test... 02:41:56 INFO - TEST-INFO | started process 23370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6YqEy/profile http://localhost:51256/getInfo.html) 02:42:00 INFO - PROCESS | 23370 | __metrics Screen width/height:1600/1200 02:42:00 INFO - PROCESS | 23370 | colorDepth:24 02:42:00 INFO - PROCESS | 23370 | Browser inner width/height: 1024/697 02:42:00 INFO - PROCESS | 23370 | __metrics 02:42:00 INFO - PROCESS | 23370 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:42:00 INFO - PROCESS | 23370 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:42:01 INFO - PROCESS | 23370 | console.error: PushService: 02:42:01 INFO - PROCESS | 23370 | stateChangeProcessEnqueue: Error transitioning state 02:42:01 INFO - PROCESS | 23370 | UnknownError 02:42:01 INFO - TEST-INFO | 23370: exit 0 02:42:01 INFO - Browser initialized. 02:42:01 INFO - Running cycle 1/1 for kraken test... 02:42:01 INFO - TEST-INFO | started process 23453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd6YqEy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:14 INFO - PROCESS | 23453 | RSS: Main: 175517696 02:42:14 INFO - PROCESS | 23453 | 02:42:16 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:17 INFO - PROCESS | 23453 | RSS: Main: 242884608 02:42:17 INFO - PROCESS | 23453 | 02:42:20 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-dft) 02:42:21 INFO - PROCESS | 23453 | RSS: Main: 218886144 02:42:21 INFO - PROCESS | 23453 | 02:42:24 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-fft) 02:42:25 INFO - PROCESS | 23453 | RSS: Main: 301752320 02:42:25 INFO - PROCESS | 23453 | 02:42:27 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51256/tests/kraken/driver.html?testName=audio-oscillator) 02:42:27 INFO - PROCESS | 23453 | RSS: Main: 210059264 02:42:27 INFO - PROCESS | 23453 | 02:42:30 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:30 INFO - PROCESS | 23453 | RSS: Main: 214097920 02:42:30 INFO - PROCESS | 23453 | 02:42:33 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:34 INFO - PROCESS | 23453 | RSS: Main: 250482688 02:42:34 INFO - PROCESS | 23453 | 02:42:38 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51256/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:38 INFO - PROCESS | 23453 | RSS: Main: 245071872 02:42:38 INFO - PROCESS | 23453 | 02:42:41 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51256/tests/kraken/driver.html?testName=json-parse-financial) 02:42:42 INFO - PROCESS | 23453 | RSS: Main: 247930880 02:42:42 INFO - PROCESS | 23453 | 02:42:43 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:44 INFO - PROCESS | 23453 | RSS: Main: 211107840 02:42:44 INFO - PROCESS | 23453 | 02:42:46 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:47 INFO - PROCESS | 23453 | RSS: Main: 218607616 02:42:47 INFO - PROCESS | 23453 | 02:42:49 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:49 INFO - PROCESS | 23453 | RSS: Main: 223150080 02:42:49 INFO - PROCESS | 23453 | 02:42:52 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:53 INFO - PROCESS | 23453 | RSS: Main: 224075776 02:42:53 INFO - PROCESS | 23453 | 02:42:56 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:56 INFO - PROCESS | 23453 | RSS: Main: 221609984 02:42:56 INFO - PROCESS | 23453 | 02:42:58 INFO - PROCESS | 23453 | Cycle 1(1): loaded http://localhost:51256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51256/tests/kraken/driver.html?testName=ai-astar) 02:42:59 INFO - PROCESS | 23453 | RSS: Main: 273129472 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | __start_tp_report 02:42:59 INFO - PROCESS | 23453 | _x_x_mozilla_page_load 02:42:59 INFO - PROCESS | 23453 | _x_x_mozilla_page_load_details 02:42:59 INFO - PROCESS | 23453 | |i|pagename|runs| 02:42:59 INFO - PROCESS | 23453 | |0;ai-astar;111;114;114;114;114;114;114;114;113;113 02:42:59 INFO - PROCESS | 23453 | |1;audio-beat-detection;165;128;125;174;125;135;125;123;172;123 02:42:59 INFO - PROCESS | 23453 | |2;audio-dft;161;163;162;161;161;161;161;162;163;161 02:42:59 INFO - PROCESS | 23453 | |3;audio-fft;77;77;76;111;76;77;76;75;98;77 02:42:59 INFO - PROCESS | 23453 | |4;audio-oscillator;84;83;114;84;85;84;107;84;83;108 02:42:59 INFO - PROCESS | 23453 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;120;118;118 02:42:59 INFO - PROCESS | 23453 | |6;imaging-darkroom;147;147;148;148;147;147;148;147;148;147 02:42:59 INFO - PROCESS | 23453 | |7;imaging-desaturate;94;95;95;95;94;94;94;95;95;95 02:42:59 INFO - PROCESS | 23453 | |8;json-parse-financial;65;65;63;63;64;64;65;64;63;64 02:42:59 INFO - PROCESS | 23453 | |9;json-stringify-tinderbox;65;67;66;67;66;66;66;66;68;67 02:42:59 INFO - PROCESS | 23453 | |10;stanford-crypto-aes;83;91;86;82;83;82;82;85;81;82 02:42:59 INFO - PROCESS | 23453 | |11;stanford-crypto-ccm;135;142;134;132;136;141;134;133;179;144 02:42:59 INFO - PROCESS | 23453 | |12;stanford-crypto-pbkdf2;175;179;178;179;178;178;174;180;180;175 02:42:59 INFO - PROCESS | 23453 | |13;stanford-crypto-sha256-iterative;69;69;70;77;70;68;72;69;69;68 02:42:59 INFO - PROCESS | 23453 | __end_tp_report 02:42:59 INFO - PROCESS | 23453 | __start_cc_report 02:42:59 INFO - PROCESS | 23453 | _x_x_mozilla_cycle_collect,1934 02:42:59 INFO - PROCESS | 23453 | __end_cc_report 02:42:59 INFO - PROCESS | 23453 | __startTimestamp1475055779061__endTimestamp 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | ------- Summary: start ------- 02:42:59 INFO - PROCESS | 23453 | Number of tests: 14 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.97 (0.9%) stddev-sans-first:0.44 02:42:59 INFO - PROCESS | 23453 | Values: 111.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:131.50 stddev:21.67 (16.5%) stddev-sans-first:20.92 02:42:59 INFO - PROCESS | 23453 | Values: 165.0 128.0 125.0 174.0 125.0 135.0 125.0 123.0 172.0 123.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:42:59 INFO - PROCESS | 23453 | Values: 161.0 163.0 162.0 161.0 161.0 161.0 161.0 162.0 163.0 161.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#3] audio-fft Cycles:10 Average:82.00 Median:77.00 stddev:12.27 (15.9%) stddev-sans-first:12.88 02:42:59 INFO - PROCESS | 23453 | Values: 77.0 77.0 76.0 111.0 76.0 77.0 76.0 75.0 98.0 77.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:12.61 (15.0%) stddev-sans-first:13.07 02:42:59 INFO - PROCESS | 23453 | Values: 84.0 83.0 114.0 84.0 85.0 84.0 107.0 84.0 83.0 108.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 02:42:59 INFO - PROCESS | 23453 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 120.0 118.0 118.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:42:59 INFO - PROCESS | 23453 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 147.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:42:59 INFO - PROCESS | 23453 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 02:42:59 INFO - PROCESS | 23453 | Values: 65.0 65.0 63.0 63.0 64.0 64.0 65.0 64.0 63.0 64.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 02:42:59 INFO - PROCESS | 23453 | Values: 65.0 67.0 66.0 67.0 66.0 66.0 66.0 66.0 68.0 67.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.98 (3.6%) stddev-sans-first:3.15 02:42:59 INFO - PROCESS | 23453 | Values: 83.0 91.0 86.0 82.0 83.0 82.0 82.0 85.0 81.0 82.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:138.50 stddev:13.98 (10.1%) stddev-sans-first:14.65 02:42:59 INFO - PROCESS | 23453 | Values: 135.0 142.0 134.0 132.0 136.0 141.0 134.0 133.0 179.0 144.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:178.50 stddev:2.17 (1.2%) stddev-sans-first:2.09 02:42:59 INFO - PROCESS | 23453 | Values: 175.0 179.0 178.0 179.0 178.0 178.0 174.0 180.0 180.0 175.0 02:42:59 INFO - PROCESS | 23453 | 02:42:59 INFO - PROCESS | 23453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.50 stddev:2.69 (3.9%) stddev-sans-first:2.82 02:42:59 INFO - PROCESS | 23453 | Values: 69.0 69.0 70.0 77.0 70.0 68.0 72.0 69.0 69.0 68.0 02:42:59 INFO - PROCESS | 23453 | -------- Summary: end -------- 02:42:59 INFO - PROCESS | 23453 | 02:43:00 INFO - TEST-INFO | 23453: exit 0 02:43:00 INFO - TEST-OK | kraken | took 64259ms 02:43:00 INFO - SUITE-END | took 1184s 02:43:00 INFO - Completed test suite (00:19:44) 02:43:00 INFO - javascript benchmark 02:43:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.44434446594, 2612.516684413385, 2645.153550863723, 2653.3499292673296, 2663.8268512546697, 4676.508966558514, 4698.73377635492, 4748.643851711118, 4776.211925032366, 4807.182778927582, 4732.692374995623, 4738.644601654881, 4788.473267940523, 4788.784504697288, 4847.927281090787, 4294.806733696991, 4323.675724320673, 4370.628496577795, 4392.5827046430695, 4399.934000989988, 4157.66738660908, 4421.955780442203, 4439.334099885011, 4461.196984542781, 4519.728816271017, 4239.936400953989, 4401.581849724271, 4418.867433976986, 4427.800748966304, 4517.322401639747, 4272.401863739079, 4328.7402755834755, 4332.935005974913, 4334.176506463793, 4389.846355377546, 4351.216780979423, 4353.455818022747, 4356.6514678825615, 4408.713433626836, 4427.845025424094, 4762.166620841339, 4762.761861906891, 4775.379200703886, 4789.49710280419, 4797.568218860284, 4922.286268491049, 4966.726830024347, 5019.84940451787, 5021.673591216596, 5102.0, 5116.820911268088, 5118.053160165381, 5119.872003199913, 5162.638615296931, 5173.120569503193, 4776.47458779534, 4782.163121453732, 4783.784729687172, 4783.856484305476, 4841.709497430165, 5061.063703214917, 5111.948880511147, 5208.166693329049, 5219.0, 5295.523402893758, 5002.499750024968, 5037.823676171316, 5038.269450929594, 5101.0308041472, 5107.361579802525, 5107.336046313955, 5118.846434606968, 5119.283300337956, 5122.487751224922, 5185.988732197261, 4887.902241955212, 4941.777620007108, 5074.797008119708, 5082.0, 5093.821716239914, 4956.553910148104, 4974.602031837444, 5019.899602008012, 5082.415522214993, 5091.439941606494, 4292.935605965913, 4304.504981927118, 4305.203537345601, 4306.397104405386, 4358.084802191512, 3713.851445942132, 3789.1853251551047, 3792.3173828711097, 3811.7903515306925, 3815.389537673959, 4269.914601707948, 4282.100758840616, 4301.634361079344, 4304.4834619845815, 4358.5205627380965, 5040.445550989388, 5051.908282918799, 5054.873628159326, 5055.595552355802, 5093.057784309841, 4273.166732487197, 4303.677224208197, 4303.763293018914, 4306.720063195945, 4357.9782101089295, 4444.777761111932, 4459.620932220798, 4496.010877606921, 4504.707194032443, 4516.6160876325885, 4682.1103990241745, 4688.2733176357715, 4690.437147542317, 4713.929291060568, 4731.763411829326, 5014.7994080236385, 5025.597952163891, 5027.396712394536, 5035.118854200427, 5097.388313402415, 4531.229690952612, 4576.244919588231, 4662.300654901792, 4672.112298663243, 4704.858854234241, 5017.623678224075, 5027.0, 5027.773750181177, 5079.796808127633, 5089.211172268304, 5071.92392114126, 5089.720065396291, 5091.745412729423, 5091.974540127276, 5148.665336753099, 4787.760611969457, 4798.23228283473, 4822.42130944289, 4948.233023881304, 4966.950330496793, 4813.205821039489, 4900.558949694402, 4902.583280421204, 4942.678725882806, 4966.726830024239, 4801.6607698027, 4839.056384005085, 4841.031793641216, 4852.490488498657, 4908.9754551227015, 4762.9285560715925, 4809.326694262736, 4910.45984941649, 4968.378952630921, 4981.950180498148, 4845.224764037737, 4869.0, 4916.287138364989, 4934.950650493449, 4948.084604348207], "value": 4644.894063230716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.164708701752, 572.6993328502539, 577.4716134736716, 582.4815913836686, 583.1456915618618, 28059.29851753707, 41851.581484185146, 43432.56567434325, 43563.128737425235, 43745.343819842645, 39894.60105398945, 40194.56886898097, 40265.39601905966, 40377.39433908494, 40398.59601403985, 7661.770146895588, 7715.0, 7718.151003389623, 7811.414143939227, 7823.569703666296, 7655.923440765577, 7742.070951485802, 7759.5344279343135, 7763.689452421896, 7763.689452421896, 7751.496152750082, 7788.961055194716, 7791.987041684573, 7801.453898227126, 7802.024746906637, 7742.109657389387, 7771.106322772897, 7772.106207786121, 7779.688812447495, 7781.455298129134, 7636.007319048488, 7681.731139410093, 7706.922930770676, 7709.267619576131, 7709.884351734729, 37437.81281093604, 37806.81096594527, 37848.43227351592, 37871.81064094662, 37874.24251514954, 2874.594691072798, 3036.0739974307826, 3065.1877252528097, 3243.189202699325, 3321.368939901411, 27865.86067069672, 28129.57805632917, 28194.295142621395, 28808.0, 29381.41237175266, 3369.359821633882, 3465.5668041494814, 3508.19311558343, 3551.8401671924826, 3584.551931008624, 262875.0, 263767.9999999981, 263915.0, 264095.0, 265068.58902575495, 31031.224219394244, 31996.680033199835, 32065.19837004047, 34037.31925361479, 53351.466485335426, 33723.0, 33845.153871153416, 33866.153346166546, 33874.0, 33883.32233355319, 13067.542636007884, 13185.53850615243, 13192.934035329761, 13195.868041319656, 13196.736065278641, 10680.839787403194, 10714.678559643224, 10728.73178170552, 10732.356058636507, 10786.56853725858, 7699.422543309274, 7752.4573279869865, 7780.377569794403, 7843.6470358833985, 7853.253940875607, 3063.188255112397, 3075.2773098321877, 3081.6764239754953, 3098.798578092462, 3112.346407254502, 838.9706360277361, 899.7255836969656, 902.9503377314179, 925.9537023148815, 947.1239103828931, 26373.868130659223, 27595.31011724723, 27733.722662773518, 28239.43521129566, 28273.57589636157, 941.1717688434271, 960.2845879819439, 964.4309857184295, 996.1433167475965, 1009.2934945538005, 13894.583162505141, 14587.41650333996, 14658.340374683165, 15017.0, 15021.173835439156, 360489.0, 364308.0, 364456.0, 364871.0, 364912.0, 48894.51105488971, 49053.509464905605, 49183.50816491861, 49193.0, 49339.25991110136, 972.2270794718357, 1046.5081411736471, 1119.630521927778, 1163.831244469547, 1184.1119160629528, 25543.23370298894, 28861.0, 29317.26706832346, 29519.704802951695, 29662.555061673662, 40524.9343832021, 41074.794626026676, 41084.1783164341, 41103.794481027406, 41152.58847411488, 283031.0, 283954.0, 284348.0, 284556.0, 285107.0, 21593.13627454884, 22382.66426003644, 22862.77137228673, 23924.880375598706, 25104.246872593852, 40297.99255018531, 40398.39402408907, 40407.1918561633, 41023.0, 41046.45872807133, 34106.0, 34428.31143377168, 34890.82554587211, 34920.65079349276, 34970.0, 34256.143596410286, 34263.65736342605, 34433.0, 34791.47812782861, 34869.825650871586, 34133.48799768055, 34341.484877726354, 34586.30827383488, 35108.12229694278, 37070.629293707796, 34037.65962340345, 34517.65482345144, 36957.0, 37434.812825935696, 37444.81277593595, 27259.727402726512, 29313.0, 29836.61021991969, 29903.55144672788, 30382.392352153274], "value": 16172.33703290483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.74285628631816, 367.79219740846423, 379.34562879033655, 379.4232766195383, 396.89879080834385, 15209.315580798862, 16518.339266429342, 17260.91369543152, 17364.652706945853, 17370.21834017472, 16860.241289141988, 16882.240299186535, 17099.23053462594, 17304.56738581536, 17409.47771566852, 5018.2974383586325, 5276.8153114641, 5288.894222115556, 5292.629515933886, 5296.894062118756, 3671.816409179544, 3888.863889763845, 5121.718305493197, 5750.108733146369, 5998.910016349758, 6090.847728806771, 6096.725647345858, 6098.695065246742, 6101.725422355982, 6107.419795119479, 5884.0, 6099.115628233903, 6127.172831667713, 6139.508839292846, 6150.169727086831, 4624.884377890546, 5366.758495867695, 5367.087595108841, 5374.516293533562, 5378.97310513445, 11501.88498115025, 11875.52497900083, 11879.58421455245, 11883.762324753456, 11905.761884762343, 1810.9185086671132, 1869.2336142181775, 1875.4279944616887, 1989.2341448542415, 2087.3633541769755, 8809.295256379473, 8959.776005599848, 8995.235404990584, 9053.230475409599, 9221.67724129659, 1614.7497137943637, 1621.1813034417662, 1634.820169781323, 1642.5154579398986, 1732.8267173282698, 71427.28572714259, 72040.6397968012, 72406.63796680982, 72973.63513182453, 73500.6324968377, 9630.662926797668, 9791.167750741124, 9849.50752462374, 10072.841623213279, 10755.892441075646, 13888.513902013381, 13889.305534723224, 13943.721125577431, 13948.930255348658, 13957.162570245819, 6573.112629795012, 6683.933160668331, 6803.0, 6855.828604284833, 6898.448124150056, 5558.499735023786, 5733.655980641175, 5753.827385178452, 6125.234345706786, 6142.170806941006, 3969.583193764671, 4003.959960400417, 4171.018766086085, 4277.230098582285, 4279.358096285582, 1551.4027099566522, 1672.3227093027344, 1683.2425408566194, 1734.0376091269213, 1760.8503277221323, 793.5119901260683, 868.669905435943, 872.1888643561549, 879.4195830751801, 884.8982367027875, 16178.595535111717, 16601.098741795668, 16673.333066677198, 16997.575060623585, 17742.379016734354, 833.9916600833914, 851.4040171879709, 861.4874149880811, 875.1211993138279, 897.869808877709, 9022.323325750463, 9160.931088085432, 9540.666076687283, 9654.613815447445, 9659.71020869361, 174619.0, 177028.0, 383913.0, 385246.0, 386994.0, 70376.0, 81360.0, 82035.0, 82041.0, 82436.0, 848.8514509960733, 885.1900511032334, 925.2782829393084, 948.0898337595985, 951.8477043672979, 15030.549083527512, 15777.68444631078, 16412.507624771275, 16435.01389916561, 16748.916255418644, 26675.866620666773, 27036.864815675795, 35250.294994100484, 37528.49886004529, 38883.611163887996, 46828.7658561705, 47560.0, 47877.760611198115, 49040.2643960348, 51386.229206561184, 6605.405513503808, 6878.209005964378, 7021.929780702128, 7343.77968660941, 7700.037495313086, 11356.148288878532, 12128.151029428209, 12313.507459701512, 12500.06249531307, 12558.358076157812, 10468.738281543023, 10516.57933682644, 10537.789244214919, 10539.894601053891, 10943.124550036136, 10362.222833287382, 10368.585256589953, 10415.1667866572, 10520.736981575521, 10591.20565957541, 10156.289059765746, 10488.632897848538, 10635.734106647396, 11038.944805275922, 11224.831627525431, 6845.589264644137, 7017.193022802443, 7105.751298704728, 7107.893381599383, 7109.644517774194, 9940.502974851084, 10662.8400573993, 10792.244542881923, 10820.837687434852, 10880.075193608633], "value": 7950.524919464994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.469435184399, 1325.2644782145906, 1343.9852911052155, 1618.100378088806, 1671.7492376143568, 6747.763828266012, 7004.194517630474, 7408.814779630512, 8051.476654017485, 8054.476459030167, 7390.963045184767, 7706.4990775599545, 7708.498947568404, 7890.0, 7894.578975784357, 2134.8505604607685, 2159.730033745782, 2163.1131236193164, 2165.2746329979395, 2170.3163503496426, 1703.761473393726, 1754.9649007019852, 2081.7189679393314, 2144.924927627533, 2155.7305336832897, 2011.2457828314382, 2044.0393015282793, 2045.6726923692213, 2049.3237231713497, 2054.1783286685295, 1917.5685470769106, 1920.4334721257194, 1991.9203231870708, 2066.6360202266583, 2068.131384818365, 2055.3628375203734, 2067.917283308666, 2069.1516478244, 2072.1504183284933, 2087.2590230468118, 8014.0, 8033.397495187826, 8111.594420278962, 8118.391120665974, 8129.349652027883, 4298.398224248608, 4413.0, 4413.3821265022925, 4415.712978656377, 4416.624586910117, 2771.986140069307, 2883.9279018024718, 2892.0, 2914.329704168053, 2921.2550799546193, 862.5600943518788, 872.8210716803104, 886.3308202307281, 892.5983307511581, 902.1519771414848, 10440.68677939663, 10443.582256709722, 10446.634367797167, 10456.215783816167, 10514.631987880464, 3795.449659799369, 3940.7241493095207, 4067.084905896209, 4091.89770255746, 4200.180964711913, 9026.142516460926, 9033.05152958943, 9045.095490450902, 9051.954740226389, 9054.81890362189, 4622.86131416058, 4624.97687511567, 4625.676202665781, 4626.583607475276, 4634.675572709878, 4163.250614889349, 4232.280512312914, 4243.27864263076, 4248.129133527619, 4258.190943720683, 3521.735869809723, 3555.5733312002726, 3635.1820840311248, 3659.780413175218, 3676.191237927652, 1054.773223756896, 1079.5250089960393, 1128.1426116151783, 1150.5282834038005, 1159.3217967488945, 744.7840126363294, 765.2615226306641, 812.8577498937781, 813.1868131868132, 835.4653022065883, 5020.196768517093, 5156.381234251914, 5265.736713164327, 5312.468753124656, 5346.839594812084, 850.8000619854329, 864.9567521623893, 888.6800751729372, 892.205936716323, 914.8307563100848, 3533.222691007974, 3533.717302615785, 3559.875404360835, 3566.28674265148, 3685.723570732152, 9514.857277140849, 9808.803823923481, 9869.506524673738, 9879.654212102541, 9888.20894328452, 9725.513724313756, 9781.266405019653, 9784.706458806248, 9811.509424528887, 9823.705288841204, 7002.544834585736, 7162.176349719744, 7284.0, 7339.266073392725, 7423.035005449365, 5571.526420254162, 5631.267935168402, 5662.933029444305, 5772.278465191851, 5855.887311579074, 8886.422382545114, 8929.196372326522, 9072.999999999736, 9104.590293436944, 9152.22206112488, 8880.689175878813, 9195.678151264941, 9196.0, 9211.907880921104, 9306.208972237435, 6695.866082678222, 6828.760993365208, 6836.179658441019, 6836.897446538206, 6841.589504629738, 7470.252974702486, 7473.588952607442, 7486.064241969754, 7507.436942229246, 7550.942867998595, 6454.096426500388, 6459.61242325462, 6623.470122390101, 6696.464282857457, 6747.257801641914, 6359.682015899279, 6461.386168314003, 6500.804975850732, 6612.702428390638, 6629.038789375417, 6104.236970378703, 6157.96921015392, 6227.875442491216, 6229.781957631461, 6287.811365659038, 4461.063176732792, 4505.61702255312, 4554.863354099382, 4576.695641742088, 4767.046590681808, 4519.141363141124, 4549.0, 4562.361269422217, 4584.564466375689, 4638.095571363552], "value": 4082.027428577231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.5859908229855, 297.33545525749946, 306.6994345541368, 307.4113073464316, 307.6615722705024, 4799.400074990626, 4813.3983252093485, 4831.589314908237, 4842.85471435857, 4885.584725298354, 4734.502877197896, 4782.210935195697, 4785.425748910127, 4797.136515427222, 4800.639952003597, 3779.0, 3791.3744232201793, 3805.2009078093565, 3812.4662547243406, 3815.9809200953955, 3687.926241475169, 3812.1041555234497, 3828.7894165820867, 3847.3844184930417, 3858.151206734514, 3765.265773174232, 3768.943465848001, 3769.6795772359383, 3778.9622103778884, 3800.296945065158, 3755.699544036484, 3759.680427163667, 3768.152165762709, 3769.1330993871425, 3770.8491660333552, 3105.642851072133, 3203.6956489133495, 3248.415285248654, 3361.2605226850055, 3364.66353364664, 4630.328602352673, 4653.0689763748005, 4657.138429390574, 4670.883227919295, 4675.742834144121, 4281.721688090295, 4291.420658211164, 4298.398224248608, 4325.243082460557, 4326.783660816946, 4624.560666736655, 4708.176069187913, 5005.57452616528, 5033.874153146164, 5035.672681275742, 3601.5318008658705, 3613.7470377073614, 3619.348517266917, 3639.0, 3649.708023358125, 5236.73816309183, 5255.658382205144, 5261.789528418859, 5263.0000299942885, 5274.393444753864, 3635.0003748968716, 3752.493413389212, 3757.9060523486582, 3759.774413535197, 3761.3041587306434, 3809.638084382035, 3810.9237815244096, 3817.5800661927165, 3822.7897465639103, 3824.598417166213, 4272.850450234227, 4277.57224277576, 4284.464441944757, 4287.871363859089, 4322.222000040023, 4998.475160108136, 5000.474950130257, 5004.799808007711, 5007.649464537448, 5014.648974571745, 1274.8916342111024, 1322.4313545175667, 1327.3628658244097, 1335.5125379236704, 1337.8729020743015, 816.9331591074591, 840.82342708032, 842.6460886427715, 851.5316575883239, 852.0244320253399, 3863.362545180014, 3872.8838134856, 3937.586553411908, 3955.782431966212, 3958.188571342868, 4500.887477813081, 4536.274196128669, 4551.884788226906, 4552.884543286916, 4554.886127846764, 3888.616903294152, 3897.8830635080994, 3908.2378936107184, 3909.276783795007, 3925.5878132795647, 2281.1673739085445, 2375.346779635614, 2395.2215529952487, 2418.762644553781, 2423.9272821815375, 4226.978865105655, 4548.7725613719185, 4684.508126646721, 4700.931590100345, 4776.9761151194025, 5236.842894713165, 5251.10731175701, 5258.342707161605, 5261.921540991287, 5261.973690131601, 4807.61539076873, 4811.975940120277, 4812.422509298836, 4820.734859582757, 4827.0, 4963.578095861748, 5081.5426611605135, 5101.183810590436, 5124.666896651705, 5173.4826517347965, 4967.155583550732, 4980.651354405157, 4983.8504844854715, 4991.2513123030385, 5019.84940451787, 4754.23932170851, 4756.310335001474, 4788.784504697227, 4790.952090479051, 4792.0, 3581.409067503833, 3732.0, 3772.830222640043, 3785.971223021517, 3796.46849441084, 5077.898442031213, 5107.931287828435, 5123.154679477993, 5125.641205115606, 5170.663906846043, 4974.502549744997, 4981.277714731416, 5016.523430274118, 5018.447970723145, 5029.4216165140015, 4688.33564084745, 4971.6022718183185, 4993.329902521717, 5028.597712182944, 5035.723035233097, 4925.359703238556, 4945.208766597327, 4948.698855032283, 4950.232713929347, 4979.925301120558, 5033.949660503348, 5058.342415485963, 5066.392032956069, 5078.136716758087, 5079.6952182869145, 4812.711237325631, 4910.21436570147, 4928.531789479994, 4937.0, 4943.65394422387], "value": 3735.489813071367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.6684773646099, 696.2758730919841, 724.9705418306005, 737.7639155470251, 740.2745309596595, 11962.940185299072, 13010.73978520429, 13174.802377964314, 13179.538716144936, 13180.670483237924, 14514.0, 14667.779983300232, 14755.704885902276, 14822.184779837105, 14832.48086316979, 750.5234176298036, 773.5165521549031, 775.8681024225895, 776.1423626892288, 777.063638315828, 622.9906551401733, 643.1157158906503, 745.8545583611198, 768.6464226455837, 772.9574873381962, 821.8643923752574, 822.4859462835727, 823.1521532821204, 823.3742355809597, 824.286991752136, 817.0726225733775, 817.8854960305562, 817.9304759095484, 820.1429506166041, 821.2362502872327, 477.57018683185066, 487.44918242386234, 571.4514066496168, 584.6550535184261, 588.7085892483205, 12951.740965180643, 12989.285589292585, 12991.935040324832, 13003.804942925864, 13018.414171362312, 12014.279143251433, 12446.626601201979, 12479.93760031194, 12493.18794278369, 13278.336083195802, 11708.53165873364, 11832.349220792852, 11965.700857478545, 12101.152919295653, 12661.683457913534, 4157.48031496063, 4178.707490475668, 4180.101278225196, 4371.759553224571, 4383.123375324916, 65847.3415265846, 66597.33402665959, 67323.32676673269, 67814.0, 68577.65711171462, 10160.33957792756, 10337.586496540054, 10455.21585881062, 10483.47582620866, 10573.89426105729, 18508.16713247907, 18560.350387736366, 18624.627507450045, 18649.533761655795, 18884.339048133523, 6223.844403889849, 6244.375562443719, 6286.339934306923, 6300.936990630035, 6492.642904640195, 3562.3587754203973, 3562.8931132066077, 3569.37535931211, 3582.0, 3601.405768048243, 2598.9090381836545, 2666.186813022008, 2679.7186295439087, 2679.866006699657, 2684.6509953706286, 496.67467808585434, 499.88002879308704, 502.1989926067916, 509.03283760854674, 514.665467446163, 464.3104989091197, 465.3066930273935, 525.8107081450675, 569.7635481275307, 585.7217821534737, 7970.4819186752675, 8559.272461840688, 8698.434601750865, 8805.16350946659, 8852.424592401474, 526.3788729299387, 546.2461802712311, 621.4500167351836, 631.6841579210395, 633.7053270229366, 3906.8632597859505, 3985.20295940813, 4020.4974378202724, 4054.6756259499757, 4081.77550234734, 99496.50251748695, 100248.99502010064, 103891.48054259832, 107239.0, 111270.0, 87317.56341218253, 88360.0, 91397.54301228584, 91518.0, 92152.0, 60740.0, 77161.0, 78354.6082269585, 79410.0, 81293.18706812974, 8163.3469322452875, 8807.735767926717, 8835.0, 8891.866622000805, 8906.332025098272, 32592.511112333807, 33693.32613347768, 40116.0, 40562.0, 41959.580404196786, 34771.0, 34887.65112348844, 35669.1082722934, 52992.0, 62012.0, 10633.255672103189, 10844.24090313702, 11066.502007409847, 11136.832947505633, 11372.886271137182, 12444.191127576678, 12494.68763280889, 12582.748345033231, 13163.934180329037, 13374.732505350034, 11213.439328033728, 11602.361870097226, 11693.562423850746, 12427.44076516577, 12480.937595311965, 10160.898391015995, 10240.948795255976, 10348.335111740587, 10917.672469825919, 10992.340459572451, 11641.6507504775, 11796.0, 12543.56097536582, 12594.559190428658, 12612.117151799286, 9444.716658500256, 9540.713778586654, 9728.0, 9846.803063938825, 10193.898061019296, 9176.495292758962, 9875.753106172404, 9908.702738917844, 9983.1013916501, 10022.849657255292], "value": 6516.615019049774, "unit": "score"}], "name": "dromaeo_css", "value": 6245.58079040604, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 125.0, 174.0, 125.0, 135.0, 125.0, 123.0, 172.0, 123.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 111.0, 76.0, 77.0, 76.0, 75.0, 98.0, 77.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 85.0, 84.0, 107.0, 84.0, 83.0, 108.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 120.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 68.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 86.0, 82.0, 83.0, 82.0, 82.0, 85.0, 81.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 134.0, 132.0, 136.0, 141.0, 134.0, 133.0, 179.0, 144.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 178.0, 179.0, 178.0, 178.0, 174.0, 180.0, 180.0, 175.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 77.0, 70.0, 68.0, 72.0, 69.0, 69.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1551.0, "alertThreshold": 2.0}]} 02:43:00 INFO - Return code: 0 02:43:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:43:00 INFO - # TBPL SUCCESS # 02:43:00 INFO - Running post-action listener: _resource_record_post_action 02:43:00 INFO - [mozharness: 2016-09-28 09:43:00.841760Z] Finished run-tests step (success) 02:43:00 INFO - Running post-run listener: _resource_record_post_run 02:43:00 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 409661440; Read time: 0; Write time: 251872 02:43:00 INFO - TinderboxPrint: CPU usage
13.0% 02:43:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:43:00 INFO - TinderboxPrint: I/O write bytes / time
409,661,440 / 251,872 02:43:00 INFO - TinderboxPrint: CPU idle
8,334.2 (87.0%) 02:43:00 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 02:43:00 INFO - TinderboxPrint: Swap in / out
0 / 0 02:43:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99885056; Read time: 0; Write time: 88860 02:43:00 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 292986880; Read time: 0; Write time: 156828 02:43:01 INFO - Running post-run listener: _upload_blobber_files 02:43:01 INFO - Blob upload gear active. 02:43:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:43:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:06 INFO - (blobuploader) - INFO - Done attempting. 02:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:07 INFO - (blobuploader) - INFO - Done attempting. 02:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:08 INFO - (blobuploader) - INFO - Done attempting. 02:43:08 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:08 INFO - Return code: 0 02:43:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18a3fad0b74362151101a248d12c6fe0769da54a11b7bcfb924457d6cb752deb2b65a93f59848a0830cb248868edc620c643b0dc26f1986ef6e3fbed076aa802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3a3bc08674afc22b8f9a66135ce2fdef6c8dcecbe0b0f00a73fe4bbc6d6e169e421386d1a3b46c4217731e88a6df806608b98036bef75e95910256045ad74f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9802362471f522e9ec0f04032a8d31c03646e1a8bec94a10476cdb2d443185d0a14898a96cdd1b572ce593f6e3f3b8945f7607f4b97b27aee52e0de394398d21"} 02:43:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:08 INFO - Contents: 02:43:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18a3fad0b74362151101a248d12c6fe0769da54a11b7bcfb924457d6cb752deb2b65a93f59848a0830cb248868edc620c643b0dc26f1986ef6e3fbed076aa802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3a3bc08674afc22b8f9a66135ce2fdef6c8dcecbe0b0f00a73fe4bbc6d6e169e421386d1a3b46c4217731e88a6df806608b98036bef75e95910256045ad74f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9802362471f522e9ec0f04032a8d31c03646e1a8bec94a10476cdb2d443185d0a14898a96cdd1b572ce593f6e3f3b8945f7607f4b97b27aee52e0de394398d21"} 02:43:08 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:08 INFO - Copying logs to upload dir... 02:43:08 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.045899 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-28 02:43:06.689318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 02:43:06.693107) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18a3fad0b74362151101a248d12c6fe0769da54a11b7bcfb924457d6cb752deb2b65a93f59848a0830cb248868edc620c643b0dc26f1986ef6e3fbed076aa802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3a3bc08674afc22b8f9a66135ce2fdef6c8dcecbe0b0f00a73fe4bbc6d6e169e421386d1a3b46c4217731e88a6df806608b98036bef75e95910256045ad74f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9802362471f522e9ec0f04032a8d31c03646e1a8bec94a10476cdb2d443185d0a14898a96cdd1b572ce593f6e3f3b8945f7607f4b97b27aee52e0de394398d21"} build_url:https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/LfMrTHzjSYKBgBLomXw4Vw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18a3fad0b74362151101a248d12c6fe0769da54a11b7bcfb924457d6cb752deb2b65a93f59848a0830cb248868edc620c643b0dc26f1986ef6e3fbed076aa802", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3a3bc08674afc22b8f9a66135ce2fdef6c8dcecbe0b0f00a73fe4bbc6d6e169e421386d1a3b46c4217731e88a6df806608b98036bef75e95910256045ad74f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9802362471f522e9ec0f04032a8d31c03646e1a8bec94a10476cdb2d443185d0a14898a96cdd1b572ce593f6e3f3b8945f7607f4b97b27aee52e0de394398d21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 02:43:06.719003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:43:06.719345) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1475050044.681006-267601082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 02:43:06.801531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 02:43:06.801869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 02:43:06.802190) ========= ========= Total master_lag: 0.16 =========