builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1474983078.0 results: success (0) buildid: 20160927033006 builduid: f6749104b0f24b6b9524a8c280e1e7ca revision: cb212903f7036117ddbb29b3bdbc390b161b1bb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.003226) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.003686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.004183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.044694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.044996) ========= 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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 06:31:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.6M=0s 2016-09-27 06:31:18 (24.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.158605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.158937) ========= 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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015094 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:18.221457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:31:18.221823) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb212903f7036117ddbb29b3bdbc390b161b1bb2 --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 cb212903f7036117ddbb29b3bdbc390b161b1bb2 --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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 06:31:18,879 truncating revision to first 12 chars 2016-09-27 06:31:18,879 Setting DEBUG logging. 2016-09-27 06:31:18,879 attempt 1/10 2016-09-27 06:31:18,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb212903f703?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 06:31:19,722 unpacking tar archive at: fx-team-cb212903f703/testing/mozharness/ program finished with exit code 0 elapsedTime=1.173245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 06:31:19.415546) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:19.415888) ========= script_repo_revision: cb212903f7036117ddbb29b3bdbc390b161b1bb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:19.416388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:19.416705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:31:19.426238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-27 06:31:19.426550) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:31:20 INFO - MultiFileLogger online at 20160927 06:31:20 in /builds/slave/test 06:31:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:31:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:31:20 INFO - {'append_to_log': False, 06:31:20 INFO - 'base_work_dir': '/builds/slave/test', 06:31:20 INFO - 'blob_upload_branch': 'Fx-Team', 06:31:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:31:20 INFO - 'branch': 'Fx-Team', 06:31:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:31:20 INFO - 'config_files': ('talos/linux_config.py',), 06:31:20 INFO - 'default_actions': ('clobber', 06:31:20 INFO - 'read-buildbot-config', 06:31:20 INFO - 'download-and-extract', 06:31:20 INFO - 'populate-webroot', 06:31:20 INFO - 'create-virtualenv', 06:31:20 INFO - 'install', 06:31:20 INFO - 'run-tests'), 06:31:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:31:20 INFO - 'download_minidump_stackwalk': True, 06:31:20 INFO - 'download_symbols': 'ondemand', 06:31:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:31:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:31:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:31:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:31:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:31:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:31:20 INFO - 'installer_path': 'installer.exe', 06:31:20 INFO - 'log_level': 'info', 06:31:20 INFO - 'log_name': 'talos', 06:31:20 INFO - 'log_to_console': True, 06:31:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:31:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:31:20 INFO - 'opt_config_files': (), 06:31:20 INFO - 'pip_index': False, 06:31:20 INFO - 'sps_profile': False, 06:31:20 INFO - 'sps_profile_interval': 0, 06:31:20 INFO - 'suite': 'dromaeojs', 06:31:20 INFO - 'system_bits': '32', 06:31:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:31:20 INFO - 'title': 'talos-linux64-ix-047', 06:31:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:31:20 INFO - 'use_talos_json': True, 06:31:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:31:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:31:20 INFO - 'work_dir': 'build'} 06:31:20 INFO - [mozharness: 2016-09-27 13:31:20.178592Z] Running clobber step. 06:31:20 INFO - Running pre-action listener: _resource_record_pre_action 06:31:20 INFO - Running main action method: clobber 06:31:20 INFO - rmtree: /builds/slave/test/build 06:31:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:31:21 INFO - Running post-action listener: _resource_record_post_action 06:31:21 INFO - [mozharness: 2016-09-27 13:31:21.164469Z] Finished clobber step (success) 06:31:21 INFO - [mozharness: 2016-09-27 13:31:21.164571Z] Running read-buildbot-config step. 06:31:21 INFO - Running pre-action listener: _resource_record_pre_action 06:31:21 INFO - Running main action method: read_buildbot_config 06:31:21 INFO - Using buildbot properties: 06:31:21 INFO - { 06:31:21 INFO - "project": "", 06:31:21 INFO - "product": "firefox", 06:31:21 INFO - "script_repo_revision": "production", 06:31:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:31:21 INFO - "repository": "", 06:31:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:31:21 INFO - "buildid": "20160927033006", 06:31:21 INFO - "pgo_build": "True", 06:31:21 INFO - "basedir": "/builds/slave/test", 06:31:21 INFO - "buildnumber": 1598, 06:31:21 INFO - "slavename": "talos-linux64-ix-047", 06:31:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:31:21 INFO - "platform": "ubuntu64_hw", 06:31:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:31:21 INFO - "branch": "fx-team", 06:31:21 INFO - "repo_path": "integration/fx-team", 06:31:21 INFO - "revision": "cb212903f7036117ddbb29b3bdbc390b161b1bb2", 06:31:21 INFO - "stage_platform": "linux64-pgo", 06:31:21 INFO - "builduid": "f6749104b0f24b6b9524a8c280e1e7ca", 06:31:21 INFO - "slavebuilddir": "test" 06:31:21 INFO - } 06:31:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:31:21 INFO - Running post-action listener: _resource_record_post_action 06:31:21 INFO - [mozharness: 2016-09-27 13:31:21.166985Z] Finished read-buildbot-config step (success) 06:31:21 INFO - [mozharness: 2016-09-27 13:31:21.167073Z] Running download-and-extract step. 06:31:21 INFO - Running pre-action listener: _resource_record_pre_action 06:31:21 INFO - Running main action method: download_and_extract 06:31:21 INFO - mkdir: /builds/slave/test/build/tests 06:31:21 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')]} 06:31:21 INFO - trying https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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 06:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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 06:31:21 INFO - Downloaded 1361 bytes. 06:31:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:31:21 INFO - Using the following test package requirements: 06:31:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:31:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:31:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'jsshell-linux-x86_64.zip'], 06:31:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:31:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:31:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:31:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:31:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:31:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:31:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:31:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:31:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:31:22 INFO - Expected file size: 21984910 06:31:26 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 06:31:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:31:27 INFO - Expected file size: 21984910 06:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:31:32 INFO - Expected file size: 14414057 06:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:33 INFO - trying https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:33 INFO - Downloading https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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 06:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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 06:31:34 INFO - Downloaded 59718393 bytes. 06:31:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:34 INFO - mkdir: /builds/slave/test/properties 06:31:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:31:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:31:34 INFO - Contents: 06:31:34 INFO - build_url:https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:31:34 INFO - Running post-action listener: _resource_record_post_action 06:31:34 INFO - Running post-action listener: set_extra_try_arguments 06:31:34 INFO - [mozharness: 2016-09-27 13:31:34.810872Z] Finished download-and-extract step (success) 06:31:34 INFO - [mozharness: 2016-09-27 13:31:34.811097Z] Running populate-webroot step. 06:31:34 INFO - Running pre-action listener: _resource_record_pre_action 06:31:34 INFO - Running main action method: populate_webroot 06:31:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:31:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:31:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:31:34 INFO - '--tppagecycles', 06:31:34 INFO - '7'], 06:31:34 INFO - 'tests': ['tsvgm']}}, 06:31:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:31:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:31:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:31:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:31:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:31:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['damp', 'tps']}, 06:31:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'tests': ['damp', 'tps']}, 06:31:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['dromaeo_dom']}, 06:31:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:31:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['basic_compositor_video']}, 06:31:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:31:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'other-e10s': {'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['a11yr', 06:31:34 INFO - 'ts_paint', 06:31:34 INFO - 'tpaint', 06:31:34 INFO - 'sessionrestore', 06:31:34 INFO - 'sessionrestore_no_auto_restore', 06:31:34 INFO - 'tabpaint']}, 06:31:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['tsvgx', 06:31:34 INFO - 'tsvgr_opacity', 06:31:34 INFO - 'tart', 06:31:34 INFO - 'tscrollx', 06:31:34 INFO - 'cart']}, 06:31:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:31:34 INFO - 'tsvgr_opacity', 06:31:34 INFO - 'tart', 06:31:34 INFO - 'tscrollx', 06:31:34 INFO - 'cart']}, 06:31:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'talos_options': ['--disable-e10s'], 06:31:34 INFO - 'tests': ['tp5o']}, 06:31:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'tests': ['tp5o']}, 06:31:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'talos_options': ['--disable-e10s', 06:31:34 INFO - '--xperf_path', 06:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:34 INFO - 'tests': ['tp5n']}, 06:31:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:31:34 INFO - 'talos_options': ['--xperf_path', 06:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:31:34 INFO - 'tests': ['tp5n']}}, 06:31:34 INFO - 'talos.zip': {'path': '', 06:31:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:31:34 INFO - Running post-action listener: _resource_record_post_action 06:31:34 INFO - [mozharness: 2016-09-27 13:31:34.827216Z] Finished populate-webroot step (success) 06:31:34 INFO - [mozharness: 2016-09-27 13:31:34.827304Z] Running create-virtualenv step. 06:31:34 INFO - Running pre-action listener: _resource_record_pre_action 06:31:34 INFO - Running main action method: create_virtualenv 06:31:34 INFO - Creating virtualenv /builds/slave/test/build/venv 06:31:34 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 06:31:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:31:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:31:34 INFO - Using real prefix '/usr' 06:31:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:31:35 INFO - Installing distribute.............................................................................................................................................................................................done. 06:31:37 INFO - Installing pip.................done. 06:31:37 INFO - Return code: 0 06:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:31:37 INFO - Reading from file tmpfile_stdout 06:31:37 INFO - Output received: 06:31:37 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) 06:31:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:31:37 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')]} 06:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 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')]} 06:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:37 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 06:31:37 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 06:31:37 INFO - Using env: {'DISPLAY': ':0', 06:31:37 INFO - 'HOME': '/home/cltbld', 06:31:37 INFO - 'LANG': 'en_US.UTF-8', 06:31:37 INFO - 'LANGUAGE': 'en_US:en', 06:31:37 INFO - 'LOGNAME': 'cltbld', 06:31:37 INFO - 'MAIL': '/var/mail/cltbld', 06:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:37 INFO - 'MOZ_NO_REMOTE': '1', 06:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:37 INFO - 'NO_EM_RESTART': '1', 06:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:37 INFO - 'PWD': '/builds/slave/test', 06:31:37 INFO - 'SHELL': '/bin/bash', 06:31:37 INFO - 'SHLVL': '1', 06:31:37 INFO - 'TERM': 'linux', 06:31:37 INFO - 'TMOUT': '86400', 06:31:37 INFO - 'USER': 'cltbld', 06:31:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:37 INFO - '_': '/tools/buildbot/bin/python'} 06:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:37 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 06:31:37 INFO - Cleaning up... 06:31:37 INFO - Return code: 0 06:31:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:31:37 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')]} 06:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 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')]} 06:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:37 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:37 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 06:31:37 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 06:31:37 INFO - Using env: {'DISPLAY': ':0', 06:31:37 INFO - 'HOME': '/home/cltbld', 06:31:37 INFO - 'LANG': 'en_US.UTF-8', 06:31:37 INFO - 'LANGUAGE': 'en_US:en', 06:31:37 INFO - 'LOGNAME': 'cltbld', 06:31:37 INFO - 'MAIL': '/var/mail/cltbld', 06:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:37 INFO - 'MOZ_NO_REMOTE': '1', 06:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:37 INFO - 'NO_EM_RESTART': '1', 06:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:37 INFO - 'PWD': '/builds/slave/test', 06:31:37 INFO - 'SHELL': '/bin/bash', 06:31:37 INFO - 'SHLVL': '1', 06:31:37 INFO - 'TERM': 'linux', 06:31:37 INFO - 'TMOUT': '86400', 06:31:37 INFO - 'USER': 'cltbld', 06:31:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:37 INFO - '_': '/tools/buildbot/bin/python'} 06:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:38 INFO - Downloading/unpacking psutil>=3.1.1 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:38 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 06:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:31:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:40 INFO - Installing collected packages: psutil 06:31:40 INFO - Running setup.py install for psutil 06:31:40 INFO - building 'psutil._psutil_linux' extension 06:31:40 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 06:31:40 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 06:31:40 INFO - building 'psutil._psutil_posix' extension 06:31:40 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 06:31:40 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 06:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:31:40 INFO - Successfully installed psutil 06:31:40 INFO - Cleaning up... 06:31:40 INFO - Return code: 0 06:31:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:31: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 mozsystemmonitor==0.3 06:31:40 INFO - Using env: {'DISPLAY': ':0', 06:31:40 INFO - 'HOME': '/home/cltbld', 06:31:40 INFO - 'LANG': 'en_US.UTF-8', 06:31:40 INFO - 'LANGUAGE': 'en_US:en', 06:31:40 INFO - 'LOGNAME': 'cltbld', 06:31:40 INFO - 'MAIL': '/var/mail/cltbld', 06:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:40 INFO - 'MOZ_NO_REMOTE': '1', 06:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:40 INFO - 'NO_EM_RESTART': '1', 06:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:40 INFO - 'PWD': '/builds/slave/test', 06:31:40 INFO - 'SHELL': '/bin/bash', 06:31:40 INFO - 'SHLVL': '1', 06:31:40 INFO - 'TERM': 'linux', 06:31:40 INFO - 'TMOUT': '86400', 06:31:40 INFO - 'USER': 'cltbld', 06:31:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:40 INFO - '_': '/tools/buildbot/bin/python'} 06:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:42 INFO - Installing collected packages: mozsystemmonitor 06:31:42 INFO - Running setup.py install for mozsystemmonitor 06:31:42 INFO - Successfully installed mozsystemmonitor 06:31:42 INFO - Cleaning up... 06:31:42 INFO - Return code: 0 06:31:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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', '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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:31: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 jsonschema==2.5.1 06:31:42 INFO - Using env: {'DISPLAY': ':0', 06:31:42 INFO - 'HOME': '/home/cltbld', 06:31:42 INFO - 'LANG': 'en_US.UTF-8', 06:31:42 INFO - 'LANGUAGE': 'en_US:en', 06:31:42 INFO - 'LOGNAME': 'cltbld', 06:31:42 INFO - 'MAIL': '/var/mail/cltbld', 06:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:42 INFO - 'MOZ_NO_REMOTE': '1', 06:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:42 INFO - 'NO_EM_RESTART': '1', 06:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:42 INFO - 'PWD': '/builds/slave/test', 06:31:42 INFO - 'SHELL': '/bin/bash', 06:31:42 INFO - 'SHLVL': '1', 06:31:42 INFO - 'TERM': 'linux', 06:31:42 INFO - 'TMOUT': '86400', 06:31:42 INFO - 'USER': 'cltbld', 06:31:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:42 INFO - '_': '/tools/buildbot/bin/python'} 06:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31:44 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 06:31:44 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 06:31:44 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 06:31:44 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 06:31:44 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 06:31:44 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 06:31:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:45 INFO - warning: no files found matching '*.txt' 06:31:45 INFO - no previously-included directories found matching 'build' 06:31:45 INFO - no previously-included directories found matching 'dist' 06:31:45 INFO - no previously-included directories found matching '.git*' 06:31:45 INFO - Installing collected packages: jsonschema, functools32 06:31:45 INFO - Running setup.py install for functools32 06:31:45 INFO - warning: no files found matching '*.txt' 06:31:45 INFO - no previously-included directories found matching 'build' 06:31:45 INFO - no previously-included directories found matching 'dist' 06:31:45 INFO - no previously-included directories found matching '.git*' 06:31:45 INFO - Successfully installed jsonschema functools32 06:31:45 INFO - Cleaning up... 06:31:45 INFO - Return code: 0 06:31:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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', '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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:31: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 functools32==3.2.3-2 06:31:45 INFO - Using env: {'DISPLAY': ':0', 06:31:45 INFO - 'HOME': '/home/cltbld', 06:31:45 INFO - 'LANG': 'en_US.UTF-8', 06:31:45 INFO - 'LANGUAGE': 'en_US:en', 06:31:45 INFO - 'LOGNAME': 'cltbld', 06:31:45 INFO - 'MAIL': '/var/mail/cltbld', 06:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:45 INFO - 'MOZ_NO_REMOTE': '1', 06:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:45 INFO - 'NO_EM_RESTART': '1', 06:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:45 INFO - 'PWD': '/builds/slave/test', 06:31:45 INFO - 'SHELL': '/bin/bash', 06:31:45 INFO - 'SHLVL': '1', 06:31:45 INFO - 'TERM': 'linux', 06:31:45 INFO - 'TMOUT': '86400', 06:31:45 INFO - 'USER': 'cltbld', 06:31:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:45 INFO - '_': '/tools/buildbot/bin/python'} 06:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:31:45 INFO - Cleaning up... 06:31:45 INFO - Return code: 0 06:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31: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')]} 06:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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')]} 06:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31: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', '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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:31: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 blobuploader==1.2.4 06:31:45 INFO - Using env: {'DISPLAY': ':0', 06:31:45 INFO - 'HOME': '/home/cltbld', 06:31:45 INFO - 'LANG': 'en_US.UTF-8', 06:31:45 INFO - 'LANGUAGE': 'en_US:en', 06:31:45 INFO - 'LOGNAME': 'cltbld', 06:31:45 INFO - 'MAIL': '/var/mail/cltbld', 06:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:45 INFO - 'MOZ_NO_REMOTE': '1', 06:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:45 INFO - 'NO_EM_RESTART': '1', 06:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:45 INFO - 'PWD': '/builds/slave/test', 06:31:45 INFO - 'SHELL': '/bin/bash', 06:31:45 INFO - 'SHLVL': '1', 06:31:45 INFO - 'TERM': 'linux', 06:31:45 INFO - 'TMOUT': '86400', 06:31:45 INFO - 'USER': 'cltbld', 06:31:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:45 INFO - '_': '/tools/buildbot/bin/python'} 06:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31: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 06:31:48 INFO - Downloading docopt-0.6.1.tar.gz 06:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:48 INFO - Running setup.py install for blobuploader 06:31:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:48 INFO - Running setup.py install for requests 06:31:48 INFO - Running setup.py install for docopt 06:31:49 INFO - Successfully installed blobuploader requests docopt 06:31:49 INFO - Cleaning up... 06:31:49 INFO - Return code: 0 06:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:49 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')]} 06:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:49 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')]} 06:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:49 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:49 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 06:31:49 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 06:31:49 INFO - Using env: {'DISPLAY': ':0', 06:31:49 INFO - 'HOME': '/home/cltbld', 06:31:49 INFO - 'LANG': 'en_US.UTF-8', 06:31:49 INFO - 'LANGUAGE': 'en_US:en', 06:31:49 INFO - 'LOGNAME': 'cltbld', 06:31:49 INFO - 'MAIL': '/var/mail/cltbld', 06:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:49 INFO - 'MOZ_NO_REMOTE': '1', 06:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:49 INFO - 'NO_EM_RESTART': '1', 06:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:49 INFO - 'PWD': '/builds/slave/test', 06:31:49 INFO - 'SHELL': '/bin/bash', 06:31:49 INFO - 'SHLVL': '1', 06:31:49 INFO - 'TERM': 'linux', 06:31:49 INFO - 'TMOUT': '86400', 06:31:49 INFO - 'USER': 'cltbld', 06:31:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:49 INFO - '_': '/tools/buildbot/bin/python'} 06:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:49 INFO - Running setup.py (path:/tmp/pip-aGQA6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:49 INFO - Running setup.py (path:/tmp/pip-x779bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:49 INFO - Running setup.py (path:/tmp/pip-XBfTbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:49 INFO - Running setup.py (path:/tmp/pip-LXqOqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:49 INFO - Running setup.py (path:/tmp/pip-4Wbbgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:49 INFO - Running setup.py (path:/tmp/pip-0_KuBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:49 INFO - Running setup.py (path:/tmp/pip-_RubUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:49 INFO - Running setup.py (path:/tmp/pip-a2y04J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:49 INFO - Running setup.py (path:/tmp/pip-doVUVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:50 INFO - Running setup.py (path:/tmp/pip-F54Vkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:50 INFO - Running setup.py (path:/tmp/pip-AGGfmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:50 INFO - Running setup.py (path:/tmp/pip-QCRNcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:50 INFO - Running setup.py (path:/tmp/pip-yie3Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:50 INFO - Running setup.py (path:/tmp/pip-vuoku2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:50 INFO - Running setup.py (path:/tmp/pip-VfRL8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:50 INFO - Running setup.py (path:/tmp/pip-USyglk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:50 INFO - Running setup.py (path:/tmp/pip-FmFLDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:50 INFO - Running setup.py install for manifestparser 06:31:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:50 INFO - Running setup.py install for mozcrash 06:31:50 INFO - Running setup.py install for mozdebug 06:31:50 INFO - Running setup.py install for mozdevice 06:31:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozfile 06:31:51 INFO - Running setup.py install for mozhttpd 06:31:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozinfo 06:31:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozInstall 06:31:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozleak 06:31:51 INFO - Running setup.py install for mozlog 06:31:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for moznetwork 06:31:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozprocess 06:31:51 INFO - Running setup.py install for mozprofile 06:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:51 INFO - Running setup.py install for mozrunner 06:31:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:52 INFO - Running setup.py install for mozscreenshot 06:31:52 INFO - Running setup.py install for moztest 06:31:52 INFO - Running setup.py install for mozversion 06:31:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:52 INFO - Cleaning up... 06:31:52 INFO - Return code: 0 06:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:52 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:52 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 06:31:52 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 06:31:52 INFO - Using env: {'DISPLAY': ':0', 06:31:52 INFO - 'HOME': '/home/cltbld', 06:31:52 INFO - 'LANG': 'en_US.UTF-8', 06:31:52 INFO - 'LANGUAGE': 'en_US:en', 06:31:52 INFO - 'LOGNAME': 'cltbld', 06:31:52 INFO - 'MAIL': '/var/mail/cltbld', 06:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:52 INFO - 'MOZ_NO_REMOTE': '1', 06:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:52 INFO - 'NO_EM_RESTART': '1', 06:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:52 INFO - 'PWD': '/builds/slave/test', 06:31:52 INFO - 'SHELL': '/bin/bash', 06:31:52 INFO - 'SHLVL': '1', 06:31:52 INFO - 'TERM': 'linux', 06:31:52 INFO - 'TMOUT': '86400', 06:31:52 INFO - 'USER': 'cltbld', 06:31:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:52 INFO - '_': '/tools/buildbot/bin/python'} 06:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:52 INFO - Running setup.py (path:/tmp/pip-R8tIEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:52 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)) 06:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:52 INFO - Running setup.py (path:/tmp/pip-xpPYYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:52 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)) 06:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:52 INFO - Running setup.py (path:/tmp/pip-sj3Pj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:52 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)) 06:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:52 INFO - Running setup.py (path:/tmp/pip-10xl0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:52 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)) 06:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:52 INFO - Running setup.py (path:/tmp/pip-hvtLO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:53 INFO - Running setup.py (path:/tmp/pip-EwlCl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:53 INFO - Running setup.py (path:/tmp/pip-TBUOyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:53 INFO - Running setup.py (path:/tmp/pip-m9eKWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:53 INFO - Running setup.py (path:/tmp/pip-OZ5BM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:53 INFO - Running setup.py (path:/tmp/pip-AmOEUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:53 INFO - Running setup.py (path:/tmp/pip-7wMUaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:53 INFO - Running setup.py (path:/tmp/pip-_5x47b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:53 INFO - Running setup.py (path:/tmp/pip-3LAO29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:53 INFO - Running setup.py (path:/tmp/pip-khNYHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:53 INFO - Running setup.py (path:/tmp/pip-I7hrqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:53 INFO - Running setup.py (path:/tmp/pip-3Gvk3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:53 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)) 06:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:53 INFO - Running setup.py (path:/tmp/pip-Ys6sLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:53 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)) 06:31:53 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)) 06:31:53 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)) 06:31:53 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)) 06:31:53 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)) 06:31:53 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)) 06:31:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:53 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 06:31:53 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 06:31:53 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 06:31:53 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 06:31:53 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 06:31:53 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 06:31:55 INFO - Downloading blessings-1.6.tar.gz 06:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:55 INFO - Installing collected packages: blessings 06:31:55 INFO - Running setup.py install for blessings 06:31:55 INFO - Successfully installed blessings 06:31:55 INFO - Cleaning up... 06:31:56 INFO - Return code: 0 06:31:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:56 INFO - Reading from file tmpfile_stdout 06:31:56 INFO - Current package versions: 06:31:56 INFO - argparse == 1.2.1 06:31:56 INFO - blessings == 1.6 06:31:56 INFO - blobuploader == 1.2.4 06:31:56 INFO - docopt == 0.6.1 06:31:56 INFO - functools32 == 3.2.3-2 06:31:56 INFO - jsonschema == 2.5.1 06:31:56 INFO - manifestparser == 1.1 06:31:56 INFO - mozInstall == 1.12 06:31:56 INFO - mozcrash == 0.17 06:31:56 INFO - mozdebug == 0.1 06:31:56 INFO - mozdevice == 0.48 06:31:56 INFO - mozfile == 1.2 06:31:56 INFO - mozhttpd == 0.7 06:31:56 INFO - mozinfo == 0.9 06:31:56 INFO - mozleak == 0.1 06:31:56 INFO - mozlog == 3.4 06:31:56 INFO - moznetwork == 0.27 06:31:56 INFO - mozprocess == 0.23 06:31:56 INFO - mozprofile == 0.28 06:31:56 INFO - mozrunner == 6.12 06:31:56 INFO - mozscreenshot == 0.1 06:31:56 INFO - mozsystemmonitor == 0.3 06:31:56 INFO - moztest == 0.7 06:31:56 INFO - mozversion == 1.4 06:31:56 INFO - psutil == 3.1.1 06:31:56 INFO - requests == 1.2.3 06:31:56 INFO - wsgiref == 0.1.2 06:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:56 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')]} 06:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 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')]} 06:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:56 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 06:31:56 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 06:31:56 INFO - Using env: {'DISPLAY': ':0', 06:31:56 INFO - 'HOME': '/home/cltbld', 06:31:56 INFO - 'LANG': 'en_US.UTF-8', 06:31:56 INFO - 'LANGUAGE': 'en_US:en', 06:31:56 INFO - 'LOGNAME': 'cltbld', 06:31:56 INFO - 'MAIL': '/var/mail/cltbld', 06:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:56 INFO - 'MOZ_NO_REMOTE': '1', 06:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:56 INFO - 'NO_EM_RESTART': '1', 06:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:56 INFO - 'PWD': '/builds/slave/test', 06:31:56 INFO - 'SHELL': '/bin/bash', 06:31:56 INFO - 'SHLVL': '1', 06:31:56 INFO - 'TERM': 'linux', 06:31:56 INFO - 'TMOUT': '86400', 06:31:56 INFO - 'USER': 'cltbld', 06:31:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:56 INFO - '_': '/tools/buildbot/bin/python'} 06:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 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)) 06:31:56 INFO - Cleaning up... 06:31:56 INFO - Return code: 0 06:31:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31:56 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')]} 06:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 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')]} 06:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:56 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 0x7f6f0a938f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, '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': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', '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 06:31:56 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 06:31:56 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 06:31:56 INFO - Using env: {'DISPLAY': ':0', 06:31:56 INFO - 'HOME': '/home/cltbld', 06:31:56 INFO - 'LANG': 'en_US.UTF-8', 06:31:56 INFO - 'LANGUAGE': 'en_US:en', 06:31:56 INFO - 'LOGNAME': 'cltbld', 06:31:56 INFO - 'MAIL': '/var/mail/cltbld', 06:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:56 INFO - 'MOZ_NO_REMOTE': '1', 06:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:56 INFO - 'NO_EM_RESTART': '1', 06:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:56 INFO - 'PWD': '/builds/slave/test', 06:31:56 INFO - 'SHELL': '/bin/bash', 06:31:56 INFO - 'SHLVL': '1', 06:31:56 INFO - 'TERM': 'linux', 06:31:56 INFO - 'TMOUT': '86400', 06:31:56 INFO - 'USER': 'cltbld', 06:31:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:56 INFO - '_': '/tools/buildbot/bin/python'} 06:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:31:56 INFO - Cleaning up... 06:31:56 INFO - Return code: 0 06:31:56 INFO - Running post-action listener: _resource_record_post_action 06:31:56 INFO - Running post-action listener: _start_resource_monitoring 06:31:56 INFO - Starting resource monitoring. 06:31:56 INFO - [mozharness: 2016-09-27 13:31:56.709231Z] Finished create-virtualenv step (success) 06:31:56 INFO - [mozharness: 2016-09-27 13:31:56.709749Z] Running install step. 06:31:56 INFO - Running pre-action listener: _resource_record_pre_action 06:31:56 INFO - Running main action method: install 06:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:56 INFO - Reading from file tmpfile_stdout 06:31:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:57 INFO - Reading from file tmpfile_stdout 06:31:57 INFO - Output received: 06:31:57 INFO - Usage: mozinstall [options] installer 06:31:57 INFO - Options: 06:31:57 INFO - -h, --help show this help message and exit 06:31:57 INFO - -d DEST, --destination=DEST 06:31:57 INFO - Directory to install application into. [default: 06:31:57 INFO - "/builds/slave/test"] 06:31:57 INFO - --app=APP Application being installed. [default: firefox] 06:31:57 INFO - mkdir: /builds/slave/test/build/application 06:31:57 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'] 06:31:57 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 06:32:14 INFO - Reading from file tmpfile_stdout 06:32:14 INFO - Output received: 06:32:14 INFO - /builds/slave/test/build/application/firefox/firefox 06:32:14 INFO - Running post-action listener: _resource_record_post_action 06:32:14 INFO - [mozharness: 2016-09-27 13:32:14.010797Z] Finished install step (success) 06:32:14 INFO - [mozharness: 2016-09-27 13:32:14.011042Z] Running run-tests step. 06:32:14 INFO - Running pre-action listener: _resource_record_pre_action 06:32:14 INFO - Running main action method: run_tests 06:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:32:14 INFO - Python 2.7.3 06:32:14 INFO - Return code: 0 06:32:14 INFO - grabbing minidump binary from tooltool 06:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:14 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 0x27ac930>, '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 0x27ad830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:32:14 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 06:32:14 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 06:32:14 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 06:32:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:32:14 INFO - Return code: 0 06:32:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:32:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:32:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:32:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:32:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 06:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 06:32:14 INFO - Using env: {'DISPLAY': ':0', 06:32:14 INFO - 'HOME': '/home/cltbld', 06:32:14 INFO - 'LANG': 'en_US.UTF-8', 06:32:14 INFO - 'LANGUAGE': 'en_US:en', 06:32:14 INFO - 'LOGNAME': 'cltbld', 06:32:14 INFO - 'MAIL': '/var/mail/cltbld', 06:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:14 INFO - 'MOZ_NO_REMOTE': '1', 06:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:14 INFO - 'NO_EM_RESTART': '1', 06:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:14 INFO - 'PWD': '/builds/slave/test', 06:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:14 INFO - 'SHELL': '/bin/bash', 06:32:14 INFO - 'SHLVL': '1', 06:32:14 INFO - 'TERM': 'linux', 06:32:14 INFO - 'TMOUT': '86400', 06:32:14 INFO - 'USER': 'cltbld', 06:32:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744', 06:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:14 INFO - '_': '/tools/buildbot/bin/python'} 06:32:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 06:32:14 INFO - mozversion application_buildid: 20160927033006 06:32:14 INFO - mozversion application_changeset: cb212903f7036117ddbb29b3bdbc390b161b1bb2 06:32:14 INFO - mozversion application_display_name: Nightly 06:32:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:32:14 INFO - mozversion application_name: Firefox 06:32:14 INFO - mozversion application_remotingname: firefox 06:32:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:32:14 INFO - mozversion application_vendor: Mozilla 06:32:14 INFO - mozversion application_version: 52.0a1 06:32:14 INFO - mozversion platform_buildid: 20160927033006 06:32:14 INFO - mozversion platform_changeset: cb212903f7036117ddbb29b3bdbc390b161b1bb2 06:32:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:32:14 INFO - mozversion platform_version: 52.0a1 06:32:14 INFO - using testdate: 1474983134 06:32:14 INFO - actual date: 1474983134 06:32:14 INFO - starting webserver on 'localhost:35949' 06:32:14 INFO - SUITE-START | Running 2 tests 06:32:14 INFO - TEST-START | dromaeo_css 06:32:14 INFO - operating with platform_type : linux_ 06:32:14 INFO - Initialising browser for dromaeo_css test... 06:32:14 INFO - TEST-INFO | started process 8317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb8JSuh/profile http://localhost:35949/getInfo.html) 06:32:18 INFO - PROCESS | 8317 | __metrics Screen width/height:1600/1200 06:32:18 INFO - PROCESS | 8317 | colorDepth:24 06:32:18 INFO - PROCESS | 8317 | Browser inner width/height: 1024/697 06:32:18 INFO - PROCESS | 8317 | __metrics 06:32:19 INFO - PROCESS | 8317 | 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" 06:32:19 INFO - PROCESS | 8317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:32:19 INFO - PROCESS | 8317 | console.error: PushService: 06:32:19 INFO - PROCESS | 8317 | stateChangeProcessEnqueue: Error transitioning state 06:32:19 INFO - PROCESS | 8317 | UnknownError 06:32:20 INFO - TEST-INFO | 8317: exit 0 06:32:20 INFO - Browser initialized. 06:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:20 INFO - TEST-INFO | started process 8399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb8JSuh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:32 INFO - PROCESS | 8399 | RSS: Main: 173727744 06:32:32 INFO - PROCESS | 8399 | 06:33:23 INFO - PROCESS | 8399 | 1474983203989 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] 06:35:33 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35949/tests/dromaeo/cssquery-ext.html) 06:35:34 INFO - PROCESS | 8399 | RSS: Main: 302534656 06:35:34 INFO - PROCESS | 8399 | 06:38:36 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-ext.html (next: http://localhost:35949/tests/dromaeo/cssquery-jquery.html) 06:38:37 INFO - PROCESS | 8399 | RSS: Main: 270114816 06:38:37 INFO - PROCESS | 8399 | 06:41:39 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35949/tests/dromaeo/cssquery-mootools.html) 06:41:40 INFO - PROCESS | 8399 | RSS: Main: 215482368 06:41:40 INFO - PROCESS | 8399 | 06:44:42 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35949/tests/dromaeo/cssquery-prototype.html) 06:44:42 INFO - PROCESS | 8399 | RSS: Main: 253128704 06:44:42 INFO - PROCESS | 8399 | 06:47:45 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35949/tests/dromaeo/cssquery-yui.html) 06:47:45 INFO - PROCESS | 8399 | RSS: Main: 220676096 06:47:45 INFO - PROCESS | 8399 | 06:50:48 INFO - PROCESS | 8399 | Cycle 1(1): loaded http://localhost:35949/tests/dromaeo/cssquery-yui.html (next: http://localhost:35949/tests/dromaeo/cssquery-dojo.html) 06:50:49 INFO - PROCESS | 8399 | RSS: Main: 283926528 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | __start_tp_report 06:50:49 INFO - PROCESS | 8399 | _x_x_mozilla_page_load 06:50:49 INFO - PROCESS | 8399 | _x_x_mozilla_page_load_details 06:50:49 INFO - PROCESS | 8399 | |i|pagename|runs| 06:50:49 INFO - PROCESS | 8399 | |0;dojo.html;2938.2801213702637;2998.5502174673798;3025.636923569172;3052.9084127476185;3074.8001379910306;5189.247559103927;5199.662021968574;5271.4464981177;5287.154055351145;5329.813456529022;5259.9474005259935;5283.471652834714;5295.549878260353;5296.232046353286;5316.362036555619;4722.598579120761;4736.763161841911;4774.832880849171;4814.566688997998;4833.226683730604;4734.857954261378;4820.662553621248;4840.056189043138;4853.441854186761;4856.514348565151;4798.5201479852085;4811.4707382187935;4843.225083986563;4848.418189817209;4898.24077268024;4718.032803275355;4725.574698277172;4768.73771942543;4770.76146192689;4810.013947140863;4729.172394830891;4732.905341893177;4769.976150119262;4801.1117943180625;4803.327534145223;5274.841754747364;5293.814716484943;5298.735063246861;5303.204519322094;5309.5752339812725;5472.288602481692;5531.032069387841;5543.362513310981;5553.278073850373;5570;5591.524720398771;5592.6085174037835;5611.270534830446;5629.380768115504;5703.885922281573;5272.1300985337375;5277.736113194402;5284.7886084556185;5285.550728188108;5341.759620817073;5638.35158956717;5688.715564221855;5844.415558444121;5845.240118784531;5853.678047707332;5516.172574113915;5545.140503222007;5560.555155587544;5574.16387541872;5622.353429355595;5650.660960342392;5655.604107712421;5660.85847853807;5661.688607126647;5663.461971112738;5441.96602645504;5576.330840299109;5623.044082505902;5631.521320687705;5635.3519345275;5501.559875209973;5610;5660.490555849993;5670.971645141748;5705.971470142706;4371.584699453547;4390.143921935256;4394.846180383671;4396.208682437128;4449.1101779644205;3924.7056470764237;3930.9213815724097;3967.1867267210155;3988.4615576897327;3994.7603143811466;5232.084385232569;5282.577393808486;5290.65610735301;5334.839954801362;5344.652597581223;5675.914861277084;5687.260656114761;5690.829275121753;5691.9146212806845;5743.770249189985;5261.710605916712;5300.814471493479;5301.469853014745;5302.92045619316;5438.864028399322;4747.976260118678;4749.667523273338;4780.235162374073;4794.2808578713475;4859.927101093415;5744.310682718101;5814.302283726064;5849.181114643953;5853.473187413153;5867.706614669164;5627.409122042291;5635;5636.126400407943;5640.435956404327;5644;5782.913256301074;5785.855353616025;5786.161006653927;5787.479126878601;5788.392218816964;5369.0872551665525;5471.316085489314;5473.753681084281;5506.531944784738;5518.668879867221;5560.5551555876245;5637.492625663546;5640.802571909963;5649.039663257338;5701.9736447439855;5487.231787549826;5501.697406642673;5502.944970550403;5505.779768809363;5509.752061157177;5294.97352513235;5394.595405344537;5454.91817622728;5478.643888147258;5530.225768392348;5462.289902312674;5478.726063696879;5481.260029895913;5525.861853453695;5549.833504994856;5546.611737178358;5553.4724201200825;5558.416366281483;5564.165375193753;5564.415736347625;5324.227986941794;5363.678179309254;5404.040153920108;5408.296921400193;5475.288212532345 06:50:49 INFO - PROCESS | 8399 | |1;ext.html;577.5841394196177;606.1362558354346;619.7366119399254;620.7920346683861;630.9432151106399;32148.35703285933;43410.348844767315;44182.77908610452;44290.33564496535;44377;45137;45472.317915231295;45519;45542;45561.77219113908;7970.442069055169;8795.42829716068;8929.107089291052;8939.284857211407;8940.64237430502;7875.881861772078;10310.968903109666;10541.36751794891;10555.683329500089;10911.454427278604;10638.840417393707;10672.252942294042;10678.946605266963;10688.412137332443;10737.194710396712;10576.36541807494;10640;10644.840327395095;10657.946710266477;10666.466676666174;10117.949410252902;10171.949140254252;10206.132478739317;10242.617246671678;10254.436006019667;43194.56805431937;43426;43445.34831977523;43529;43541.78229108866;3247.8376081195847;3253.723433508131;3264.1513206566465;3337.599488061424;3377.712894403954;30689.079327620206;32650.83674581612;32721.83639081813;32770.836145819354;34330.14174645629;4348.543402942677;4392.648588112943;4412.0955204183065;4506.4817545982305;4560.931586026212;322080;322433;323302;323877.3806130978;324643;59316.40683593195;59781.701091494266;59865.911397531694;59906.400935990954;59955;36620.450693239625;37719.245615087544;37787.84333723288;39346.21307573833;61900;16396.75404868928;16986;16986.405475808286;16989.745153822703;16989.830101699074;11859.169858110023;12086.456109475095;12569;12864.935675321563;12948.935255323662;18552.25790968346;18972.430827075208;19119.617607647768;19198.424047278604;19314.517137071685;7079.141867682126;7172.175199852084;7289.380402665727;7329.926700733031;7537.773866784005;956.712986104166;1029.9330543514648;1074.4788777442934;1082.8971247731454;1087.8259478483562;31557.21106972298;32053.51919721206;32289;32539.83730081382;32584.837075814943;1072.3190773858655;1073.3398959639765;1074.693712291993;1093.94530273486;1118.7706520163347;16601.05444651532;17132;17205.7419138713;17292.394766183123;17646;157760;158402;158513;158615;159736;58575.41424585785;58741;58779.41220587825;58851.41148588545;58949.41050589525;1188.2217147768226;1256.2462522486435;1287.7488889666613;1292.6962163891667;1323.2259128409987;30031.484861899477;32824.34351313008;33048.37322774861;33213.833930830195;33308.833455832566;49834.75082624564;50404;50446.49553504418;50567.241491376924;50610.74694626503;383882;384186;384197;384358;386550;27219.59170612403;28213.43573128567;28421.57367639446;28473.145805625034;30229.395412092075;46984;47137.292940605235;47204;47373.52626473691;47845.521544784104;39312;40711.38932916068;40722.59277407188;40886.59113408828;42971.35542966796;40079.39880901731;40810.59189408068;41306.586934130275;41403.378949316386;41924;39935;39997;40159.79920100381;40291;40603.390949136374;33630;36285.86259907794;36559.81720091382;36700;37021.44467833039;27175.320616984733;27874.16377508678;27881;27888.72111278861;27973.44053118967 06:50:49 INFO - PROCESS | 8399 | |2;jquery.html;371.57640290069327;376.4936160863638;377.54128733588686;378.22841403536785;381.7976472469591;14278.71442571148;18225.270989160435;19676.9016154919;20495.385138445832;20676.793232067674;18439.354622588213;18902.243910243607;19178.808211917876;19369.903150484228;19389.709154362696;5674.659520428777;5950.37521060289;5951;5951.9107213391835;5953.255843019622;5662.943370566283;5772.509336706385;5786.652800831943;5797.971010144944;5851.414858514136;5757.942420575803;5760.4815566599;5767.279090113736;5768.250127483421;5769.076947688371;5561.5272701820195;5697.487226149646;5733.971330143364;5747.655140691551;5752;5117.5650069744115;5124.769385377667;5126.897462050775;5134.768935397916;5139.8458046258675;14006.649833754238;15926.362945482168;21203.893980530152;22051.22820701284;22088.33734987953;2181.2910803988607;2337;2715.5383584790434;2772.4400245646657;2854.885804567815;9740.610375584969;10331.845022324596;10401.994359886789;10671.306365086322;10761.892381076168;1953.2870502266712;1958.6082783443226;1963.882167069966;1986.6093734385843;2004.0480771633358;82302.58848705718;83609;84445;86784.56607716985;86942;10517.158627309796;10613.681589552325;10778.514966826511;10922.72693182661;11231;15584.844151558565;15591.844081559266;15604.843951560339;15606.687866242839;15620;7466.328030477283;7742.419318551131;7839.45123841337;8000.4399692021;8003.079645840803;7380.815479613053;7380.9261907381315;7429.36850367714;7524.811879703051;7582.924170758332;4759.6430267729365;4760.33355330254;4783.425988881287;4809.567138957511;4954.256861470808;1945.562248494106;1978.9505262368268;1995.5410255640993;2025.7670367907585;2051.8153366197116;709.9361057504849;883.4081165619051;915.2677857713802;937.3063932689761;954.5227386306847;17584.560385990197;17776.288948442176;18795.34216302423;19569.706454403196;20053.799462005485;908.7773495493647;918.1186061381148;952.5806548243067;974.907383798538;1006.1849901579744;10240.180785537139;10760.892391076146;10763.3541987481;10803.459827008619;10840.945795270973;438410;453694;465661;469530;471721;90055;92144;93228;94885;95347;921.755734730297;954.8567714842691;971.2618410008304;977.8093271812071;981.1954197557934;16503.66992660164;16726.66546669084;17122.486325410257;17438.389656361967;17686;42654.57345426506;42850.35724464198;42978.35532467078;43604.56395436132;44350.778246108566;54275;58694.7065264671;59858.10212846724;60032.699836500535;60443.69778151257;5876.324222714272;6375.904361434675;8238;8482.571154461026;8749.562521874008;12597;12980;13371.06402551812;13395.062345635712;13514.85123764491;11086.889131108586;11479.942600286946;11824.940875295568;11833.290002599872;12116.030717542399;11043.116550676088;11226;11518.654440366803;11615.245009074382;11689.649310520357;11712.063034957353;11713.41432928333;11784.057275417774;11800.940995294968;12112.21270617407;8182.304504117216;8461;8568.614412351584;8860.86708699357;8904.510251935946;10656;11081.778364432828;11708.590199342982;11740.765184696429;11996.220245684002 06:50:49 INFO - PROCESS | 8399 | |3;mootools.html;1446.2334962469888;1474.8230212374513;1609.3482139733405;1780.0832571225812;1796.3622913865577;7736.303732664059;7974.401919856019;8298.543580103093;8969.730908072761;8988.191062804346;8410;8716.08481109484;8718.73843784686;8971.05803890592;8984.595693193805;2341.438054866828;2370.6681064650875;2372.8694921779297;2374.76252374762;2380.9642855357183;1995.5510010247724;2273.7726227377298;2334.579775640384;2348.154664320843;2349.4361353275176;2017.1124705129696;2264.286749673856;2346.9061237550477;2355.4346956730346;2359.327591636384;2322.7096612923383;2343.4961483281177;2356.4211977974715;2359.775821296974;2366.2428023032635;2298.816094712419;2314.7685231476885;2324.9651255231183;2335.9182428615086;2339.3683705399617;8703.868497095336;8761.123887611251;8769.7807554811;8773.868391974125;8782.912170878337;5098.1842905135;5251.842444726664;5288.762005709714;5291.761870715827;5295.655782374133;3301.4387554115856;3426.229098452853;3500.929981400383;3505.544279243682;3536.416491278936;1119.5074167366415;1146.9311841289466;1163.941802909851;1178.3106882473762;1194.4266751959108;12140.15018948674;12431.937840310831;12450.190737602026;12489.50041998319;12530.185537940004;4408.448943882015;4571.177188106173;4743.857684269477;4749.857504274877;4776.880577985508;10506.579736810594;10508.842367364496;10512.26414151002;10521.053105220413;10534;5309.761060752276;5376.516113549799;5384.165454354581;5389.326334208224;5389.380221274525;4694;4779.928301075487;4911.607071434348;4928.260760885896;4928.408590969035;3693.593704692482;3702.7963462009848;3744.8689295874515;3775.622437756257;3815.3895376740143;1098.9285696429706;1126.2566705974018;1126.6480223731555;1129.7740451909651;1136.6078702847503;799.1249581708021;812.8171161488737;822.5393779483388;872.3326655108847;886.742844575079;5496.780128794883;5578.079616863253;5682.886342273131;5917.171595976567;6099.359567245464;506.4682083811983;510.7114480318608;516.7752027867889;518.4064246437807;653.8300041989022;3847.442120892511;4083.693722970789;4099.692523060723;4126.257273690764;4129.607687269705;10296.330738501973;10703.250772445854;10738.194635402377;10745.83881241782;10747.570097196025;10556.419396933088;10557.313774604627;10560.155187584975;10571.04860562553;10596.364218146937;7581.279778421152;7889.408294377829;7941.523508589503;7984.441089123706;8002;5773.74018169175;5857.092150716475;5872.060470324727;5884.823455296348;6213.440790328892;9362.578683959102;9454.621815127319;9800.215982721507;9846.852297215404;9848.753781155528;9806.901930980599;9880.16018638395;10119.696409107739;10179.287449878437;10284.382937023802;7611.619419028915;7688.615569221628;7756.68973241064;7765.1846556110795;7807;8305.294050005818;8450.408471406943;8454.619542120496;8469.153084691481;8472.915270847212;7442.144153422426;7516.661750221362;7550.622468876424;7592.316691497792;7802.258785415376;7298.6715597797165;7500.962495187489;7501.62491875415;7643.350315223046;7662.770116896502;6797.082393876961;6859.965700171667;6868.278830722702;6872.381485666314;6872.6907289173105;4980.975095124501;5069.062223488519;5107.208382700687;5146.8970620588125;5154.484551544815;5023.2214006829;5076.974615126901;5084.542391184811;5183.81856635016;5191.299174611379 06:50:49 INFO - PROCESS | 8399 | |4;prototype.html;306.5386593177269;316.2205164270074;318.4396457358939;321.04649191900046;323.4743541744665;5162.922556161651;5324.920126198101;5333.146696528552;5360.65155764875;5388.649737767048;5105.18317069269;5238.397584277809;5284.497972692598;5284.630075894689;5293.100172970595;4070.7354021988626;4103.507579090498;4112;4121.649659778923;4127.587241275878;3951.8221680024326;4105.486814148231;4112.753234805907;4121.5672354402805;4121.660460350398;4095.4471146395153;4100.5489396166395;4108.096218831867;4109.903948986009;4110.650594699439;4108.931677763788;4126.236646220444;4132.793360332002;4142.689298302639;4169.353750168699;3630.09247688078;3646.7082633389264;3659.4876717259604;3661.157933675243;3667.174885650734;5168.250603662448;5174.508421699932;5179.922301165486;5182.53357197854;5234.607404444682;4673.953260467386;4681.250999840044;4685.344051832746;4696.3894693689945;4705.458872229703;5338.425164576459;5520.254765606632;5526.585506087019;5533.778648854081;5538.529225015878;3906.199229158016;3923.9215215695526;3929.4105884117325;3952.960470395288;3960.3069462843887;5837.883242335172;5838.2118414013985;5842;5842.4741773240185;5861.413858614147;4096.467459230281;4101.52832424269;4106.979465102715;4110.424540564323;4113.958860411358;4049.6962727794944;4094.549599544048;4104.589541045872;4107.67138628909;4124.835006599762;4672.789724462407;4682.906341873144;4687.929681054787;4695.624350052056;4722.480527142012;5571.303587051619;5584.692841893735;5589.441055894378;5602.495775380154;5649.661020338793;1300.174389262806;1326.2771789374815;1380.861913808611;1394.187556176966;1397.73443045823;891.4339394484549;898.898848910093;900.2887718702283;905.4295793649958;917.8347897378536;4708.835190768306;4720.12677654635;4735.224290890916;4735.644826637947;4747.335373047776;4968.701877887338;4970.950290497049;4971.6271279654175;4977.303177555145;4982.188625701269;4500.279955207151;4665.4168228971375;4699.718016918996;4747.264174053027;4751.762411879392;2639;2644.378571035805;2664.6535950326333;2675.3846615278594;2684.2886635041727;5098.643094983389;5109.080365534165;5115.5396014358885;5119.769610367468;5149.407818100892;4912.410510738734;5034.874128146753;5065.164247899129;5091.567216786615;5204.245384419238;5094.898102037939;5117.590592752571;5118.641695081308;5122.795088196431;5152.758550030674;4998.125328067501;5006.749662516787;5032.597392208541;5033.597312214941;5051.393832740095;4704.317873908332;4783.617310615212;4950.801967921387;4983.6760610560195;4985.401751789808;5093.4651861554;5095.980803839173;5124;5141.794328226979;5147.3308469898675;3643.7813731176216;3648.3068217038676;3660.194757153422;3681.208540163878;3713.9071523212137;4812.326274321667;5027.069992051483;5106.336176297058;5113.284140220298;5139.815578379099;4881.877953051202;4899.216125419915;4919.810684245476;4924.384451943507;4926.679765815211;4867.10183028612;4883.560479556857;4885;4890.804367825247;4901.534354236342;4533.637309015205;4816.8795780105775;4839.854804355875;4846.17615005457;4860.3681521401995;4911.557959783637;4931.235658472942;4936.358273424432;4939.654224204415;4946.406431228275;4823.97393094908;4824.34871292371;4845.224764037737;4845.903081938271;4856.077345304381 06:50:49 INFO - PROCESS | 8399 | |5;yui.html;724.9166345870224;731.1993367262847;768.7232596265344;775.647080578337;818.9262966333031;16289.674206515863;17224.65550688987;17263.913680431597;17268.82731172688;17299;14611.196384198865;14672.119672819612;14730.18983955882;14748.410063597443;14752.114873107594;658.9110470086525;676.245985725917;771.6720393832627;789.9012623422072;792.2592376128309;770.3298130626335;792.0139426414094;797.3581267079999;805.3235282362814;806.0166596751953;841.0370126205491;841.5960339037266;845.2561745663808;845.6406027438314;847.326375531454;703.2967032967033;842.4566154830162;843.5360551696604;844.2444012608712;844.6621351459404;526.1240035341152;600.1058422949817;616.8704572039832;620.8230654263558;621.9813405597839;15178.696426071527;15187.772183417257;15224.771628425582;15229.847701522955;15241.16173610451;13511.189328640314;14014.509492167725;14299.142051476945;14483.203423811687;14493.565193044225;12802.48790048397;12941.741165176738;13182.67043323915;13452.32738363078;14081.436742530286;4241.088166044285;4264.424302719155;4337.63130133939;4348.21732088224;4406.823727050914;77275;77771.22228777697;79250;89246.55376723075;90713;11123.27698699582;11193.440327983568;11235.719107022227;11721.824172637418;11865.110116741278;21774.564508709736;21922.89038554797;21959.83943773212;21972.89013554922;21975.23086691958;8316.584170791437;8345.499270043816;8398.202170793766;8612.354073444392;8639.524826134622;4419.867403977886;4445.1998640245065;4476.001079276893;4498.977505112453;4549.363089167519;3220.2593403516853;3308.6856748608843;3312.5362449257123;3345.5483509725877;3350.3801796667694;538.0933127679793;542.3762672926088;543.2882923370397;543.6982474726485;544.4093158922534;584.8888711144868;606.8634557224589;608.3095686395973;632.9208848893888;663.177659701966;8198.38512111594;8428.915710842935;8646.437981531306;8806.91193088061;8849.159329863653;553.6235359955189;573.4208449465985;575.4705670782889;576.049518294817;614.173936056004;3945.506811648544;4259.42497762798;4259.510156332061;4262.339337402707;4278.679099067583;72354.63822680958;72822.63588682128;121404.78595214112;122796.38601806934;130822;110468;110961;112579.4371028156;116516;116899;57830.13254801181;82332.9999999988;96004;97386.51306743563;97922.5103874476;7898.842023159619;7948.443608947318;7950.602469876599;7958.880616790869;8225.42422030476;55019.449805501434;56624;56739.71630141823;57335.139972899604;57980;74800;79583;80824.19175808167;81839.59080204561;84287.57856210679;9968.451735154345;10151;10185.541650625888;10422.166226701695;12003.459844306852;11188.216824822184;11527.8270825936;12094.818577721517;12103.697407564881;12584.244945302946;11005.119590432907;11095.5561777528;11162.944185279022;11540.711482213012;11823.645290641294;10169.79660406773;10436.269461137648;10520.526576303932;10836.67489975302;10857.185711071543;9544.475053871825;10164.390136591828;11068;11117.499712512794;11203.719907002063;8948.86576701363;8977.28181745472;9015.2787776979;9113.989844468413;9416.482093484925;8724.214820666171;8925.750394944584;8975.865362019706;8990.955045224731;9017.458952462874 06:50:49 INFO - PROCESS | 8399 | __end_tp_report 06:50:49 INFO - PROCESS | 8399 | __start_cc_report 06:50:49 INFO - PROCESS | 8399 | _x_x_mozilla_cycle_collect,1033 06:50:49 INFO - PROCESS | 8399 | __end_cc_report 06:50:49 INFO - PROCESS | 8399 | __startTimestamp1474984249021__endTimestamp 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | ------- Summary: start ------- 06:50:49 INFO - PROCESS | 8399 | Number of tests: 6 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#0] dojo.html Cycles:165 Average:5232.90 Median:5441.97 stddev:583.11 (10.7%) stddev-sans-first:556.42 06:50:49 INFO - PROCESS | 8399 | Values: 2938.3 2998.6 3025.6 3052.9 3074.8 5189.2 5199.7 5271.4 5287.2 5329.8 5259.9 5283.5 5295.5 5296.2 5316.4 4722.6 4736.8 4774.8 4814.6 4833.2 4734.9 4820.7 4840.1 4853.4 4856.5 4798.5 4811.5 4843.2 4848.4 4898.2 4718.0 4725.6 4768.7 4770.8 4810.0 4729.2 4732.9 4770.0 4801.1 4803.3 5274.8 5293.8 5298.7 5303.2 5309.6 5472.3 5531.0 5543.4 5553.3 5570.0 5591.5 5592.6 5611.3 5629.4 5703.9 5272.1 5277.7 5284.8 5285.6 5341.8 5638.4 5688.7 5844.4 5845.2 5853.7 5516.2 5545.1 5560.6 5574.2 5622.4 5650.7 5655.6 5660.9 5661.7 5663.5 5442.0 5576.3 5623.0 5631.5 5635.4 5501.6 5610.0 5660.5 5671.0 5706.0 4371.6 4390.1 4394.8 4396.2 4449.1 3924.7 3930.9 3967.2 3988.5 3994.8 5232.1 5282.6 5290.7 5334.8 5344.7 5675.9 5687.3 5690.8 5691.9 5743.8 5261.7 5300.8 5301.5 5302.9 5438.9 4748.0 4749.7 4780.2 4794.3 4859.9 5744.3 5814.3 5849.2 5853.5 5867.7 5627.4 5635.0 5636.1 5640.4 5644.0 5782.9 5785.9 5786.2 5787.5 5788.4 5369.1 5471.3 5473.8 5506.5 5518.7 5560.6 5637.5 5640.8 5649.0 5702.0 5487.2 5501.7 5502.9 5505.8 5509.8 5295.0 5394.6 5454.9 5478.6 5530.2 5462.3 5478.7 5481.3 5525.9 5549.8 5546.6 5553.5 5558.4 5564.2 5564.4 5324.2 5363.7 5404.0 5408.3 5475.3 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#1] ext.html Cycles:180 Average:47296.36 Median:18323.22 stddev:80018.06 (436.7%) stddev-sans-first:80165.65 06:50:49 INFO - PROCESS | 8399 | Values: 577.6 606.1 619.7 620.8 630.9 32148.4 43410.3 44182.8 44290.3 44377.0 45137.0 45472.3 45519.0 45542.0 45561.8 7970.4 8795.4 8929.1 8939.3 8940.6 7875.9 10311.0 10541.4 10555.7 10911.5 10638.8 10672.3 10678.9 10688.4 10737.2 10576.4 10640.0 10644.8 10657.9 10666.5 10117.9 10171.9 10206.1 10242.6 10254.4 43194.6 43426.0 43445.3 43529.0 43541.8 3247.8 3253.7 3264.2 3337.6 3377.7 30689.1 32650.8 32721.8 32770.8 34330.1 4348.5 4392.6 4412.1 4506.5 4560.9 322080.0 322433.0 323302.0 323877.4 324643.0 59316.4 59781.7 59865.9 59906.4 59955.0 36620.5 37719.2 37787.8 39346.2 61900.0 16396.8 16986.0 16986.4 16989.7 16989.8 11859.2 12086.5 12569.0 12864.9 12948.9 18552.3 18972.4 19119.6 19198.4 19314.5 7079.1 7172.2 7289.4 7329.9 7537.8 956.7 1029.9 1074.5 1082.9 1087.8 31557.2 32053.5 32289.0 32539.8 32584.8 1072.3 1073.3 1074.7 1093.9 1118.8 16601.1 17132.0 17205.7 17292.4 17646.0 157760.0 158402.0 158513.0 158615.0 159736.0 58575.4 58741.0 58779.4 58851.4 58949.4 1188.2 1256.2 1287.7 1292.7 1323.2 30031.5 32824.3 33048.4 33213.8 33308.8 49834.8 50404.0 50446.5 50567.2 50610.7 383882.0 384186.0 384197.0 384358.0 386550.0 27219.6 28213.4 28421.6 28473.1 30229.4 46984.0 47137.3 47204.0 47373.5 47845.5 39312.0 40711.4 40722.6 40886.6 42971.4 40079.4 40810.6 41306.6 41403.4 41924.0 39935.0 39997.0 40159.8 40291.0 40603.4 33630.0 36285.9 36559.8 36700.0 37021.4 27175.3 27874.2 27881.0 27888.7 27973.4 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#2] jquery.html Cycles:180 Average:28153.67 Median:42752.47 stddev:76171.09 (178.2%) stddev-sans-first:76356.21 06:50:49 INFO - PROCESS | 8399 | Values: 371.6 376.5 377.5 378.2 381.8 14278.7 18225.3 19676.9 20495.4 20676.8 18439.4 18902.2 19178.8 19369.9 19389.7 5674.7 5950.4 5951.0 5951.9 5953.3 5662.9 5772.5 5786.7 5798.0 5851.4 5757.9 5760.5 5767.3 5768.3 5769.1 5561.5 5697.5 5734.0 5747.7 5752.0 5117.6 5124.8 5126.9 5134.8 5139.8 14006.6 15926.4 21203.9 22051.2 22088.3 2181.3 2337.0 2715.5 2772.4 2854.9 9740.6 10331.8 10402.0 10671.3 10761.9 1953.3 1958.6 1963.9 1986.6 2004.0 82302.6 83609.0 84445.0 86784.6 86942.0 10517.2 10613.7 10778.5 10922.7 11231.0 15584.8 15591.8 15604.8 15606.7 15620.0 7466.3 7742.4 7839.5 8000.4 8003.1 7380.8 7380.9 7429.4 7524.8 7582.9 4759.6 4760.3 4783.4 4809.6 4954.3 1945.6 1979.0 1995.5 2025.8 2051.8 709.9 883.4 915.3 937.3 954.5 17584.6 17776.3 18795.3 19569.7 20053.8 908.8 918.1 952.6 974.9 1006.2 10240.2 10760.9 10763.4 10803.5 10840.9 438410.0 453694.0 465661.0 469530.0 471721.0 90055.0 92144.0 93228.0 94885.0 95347.0 921.8 954.9 971.3 977.8 981.2 16503.7 16726.7 17122.5 17438.4 17686.0 42654.6 42850.4 42978.4 43604.6 44350.8 54275.0 58694.7 59858.1 60032.7 60443.7 5876.3 6375.9 8238.0 8482.6 8749.6 12597.0 12980.0 13371.1 13395.1 13514.9 11086.9 11479.9 11824.9 11833.3 12116.0 11043.1 11226.0 11518.7 11615.2 11689.6 11712.1 11713.4 11784.1 11800.9 12112.2 8182.3 8461.0 8568.6 8860.9 8904.5 10656.0 11081.8 11708.6 11740.8 11996.2 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#3] mootools.html Cycles:180 Average:5718.49 Median:2787.77 stddev:3268.34 (117.2%) stddev-sans-first:3261.74 06:50:49 INFO - PROCESS | 8399 | Values: 1446.2 1474.8 1609.3 1780.1 1796.4 7736.3 7974.4 8298.5 8969.7 8988.2 8410.0 8716.1 8718.7 8971.1 8984.6 2341.4 2370.7 2372.9 2374.8 2381.0 1995.6 2273.8 2334.6 2348.2 2349.4 2017.1 2264.3 2346.9 2355.4 2359.3 2322.7 2343.5 2356.4 2359.8 2366.2 2298.8 2314.8 2325.0 2335.9 2339.4 8703.9 8761.1 8769.8 8773.9 8782.9 5098.2 5251.8 5288.8 5291.8 5295.7 3301.4 3426.2 3500.9 3505.5 3536.4 1119.5 1146.9 1163.9 1178.3 1194.4 12140.2 12431.9 12450.2 12489.5 12530.2 4408.4 4571.2 4743.9 4749.9 4776.9 10506.6 10508.8 10512.3 10521.1 10534.0 5309.8 5376.5 5384.2 5389.3 5389.4 4694.0 4779.9 4911.6 4928.3 4928.4 3693.6 3702.8 3744.9 3775.6 3815.4 1098.9 1126.3 1126.6 1129.8 1136.6 799.1 812.8 822.5 872.3 886.7 5496.8 5578.1 5682.9 5917.2 6099.4 506.5 510.7 516.8 518.4 653.8 3847.4 4083.7 4099.7 4126.3 4129.6 10296.3 10703.3 10738.2 10745.8 10747.6 10556.4 10557.3 10560.2 10571.0 10596.4 7581.3 7889.4 7941.5 7984.4 8002.0 5773.7 5857.1 5872.1 5884.8 6213.4 9362.6 9454.6 9800.2 9846.9 9848.8 9806.9 9880.2 10119.7 10179.3 10284.4 7611.6 7688.6 7756.7 7765.2 7807.0 8305.3 8450.4 8454.6 8469.2 8472.9 7442.1 7516.7 7550.6 7592.3 7802.3 7298.7 7501.0 7501.6 7643.4 7662.8 6797.1 6860.0 6868.3 6872.4 6872.7 4981.0 5069.1 5107.2 5146.9 5154.5 5023.2 5077.0 5084.5 5183.8 5191.3 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#4] prototype.html Cycles:180 Average:4368.95 Median:4851.13 stddev:1236.72 (25.5%) stddev-sans-first:1202.01 06:50:49 INFO - PROCESS | 8399 | Values: 306.5 316.2 318.4 321.0 323.5 5162.9 5324.9 5333.1 5360.7 5388.6 5105.2 5238.4 5284.5 5284.6 5293.1 4070.7 4103.5 4112.0 4121.6 4127.6 3951.8 4105.5 4112.8 4121.6 4121.7 4095.4 4100.5 4108.1 4109.9 4110.7 4108.9 4126.2 4132.8 4142.7 4169.4 3630.1 3646.7 3659.5 3661.2 3667.2 5168.3 5174.5 5179.9 5182.5 5234.6 4674.0 4681.3 4685.3 4696.4 4705.5 5338.4 5520.3 5526.6 5533.8 5538.5 3906.2 3923.9 3929.4 3953.0 3960.3 5837.9 5838.2 5842.0 5842.5 5861.4 4096.5 4101.5 4107.0 4110.4 4114.0 4049.7 4094.5 4104.6 4107.7 4124.8 4672.8 4682.9 4687.9 4695.6 4722.5 5571.3 5584.7 5589.4 5602.5 5649.7 1300.2 1326.3 1380.9 1394.2 1397.7 891.4 898.9 900.3 905.4 917.8 4708.8 4720.1 4735.2 4735.6 4747.3 4968.7 4971.0 4971.6 4977.3 4982.2 4500.3 4665.4 4699.7 4747.3 4751.8 2639.0 2644.4 2664.7 2675.4 2684.3 5098.6 5109.1 5115.5 5119.8 5149.4 4912.4 5034.9 5065.2 5091.6 5204.2 5094.9 5117.6 5118.6 5122.8 5152.8 4998.1 5006.7 5032.6 5033.6 5051.4 4704.3 4783.6 4950.8 4983.7 4985.4 5093.5 5096.0 5124.0 5141.8 5147.3 3643.8 3648.3 3660.2 3681.2 3713.9 4812.3 5027.1 5106.3 5113.3 5139.8 4881.9 4899.2 4919.8 4924.4 4926.7 4867.1 4883.6 4885.0 4890.8 4901.5 4533.6 4816.9 4839.9 4846.2 4860.4 4911.6 4931.2 4936.4 4939.7 4946.4 4824.0 4824.3 4845.2 4845.9 4856.1 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - PROCESS | 8399 | [#5] yui.html Cycles:180 Average:20891.22 Median:544.05 stddev:31579.09 (5804.4%) stddev-sans-first:31631.37 06:50:49 INFO - PROCESS | 8399 | Values: 724.9 731.2 768.7 775.6 818.9 16289.7 17224.7 17263.9 17268.8 17299.0 14611.2 14672.1 14730.2 14748.4 14752.1 658.9 676.2 771.7 789.9 792.3 770.3 792.0 797.4 805.3 806.0 841.0 841.6 845.3 845.6 847.3 703.3 842.5 843.5 844.2 844.7 526.1 600.1 616.9 620.8 622.0 15178.7 15187.8 15224.8 15229.8 15241.2 13511.2 14014.5 14299.1 14483.2 14493.6 12802.5 12941.7 13182.7 13452.3 14081.4 4241.1 4264.4 4337.6 4348.2 4406.8 77275.0 77771.2 79250.0 89246.6 90713.0 11123.3 11193.4 11235.7 11721.8 11865.1 21774.6 21922.9 21959.8 21972.9 21975.2 8316.6 8345.5 8398.2 8612.4 8639.5 4419.9 4445.2 4476.0 4499.0 4549.4 3220.3 3308.7 3312.5 3345.5 3350.4 538.1 542.4 543.3 543.7 544.4 584.9 606.9 608.3 632.9 663.2 8198.4 8428.9 8646.4 8806.9 8849.2 553.6 573.4 575.5 576.0 614.2 3945.5 4259.4 4259.5 4262.3 4278.7 72354.6 72822.6 121404.8 122796.4 130822.0 110468.0 110961.0 112579.4 116516.0 116899.0 57830.1 82333.0 96004.0 97386.5 97922.5 7898.8 7948.4 7950.6 7958.9 8225.4 55019.4 56624.0 56739.7 57335.1 57980.0 74800.0 79583.0 80824.2 81839.6 84287.6 9968.5 10151.0 10185.5 10422.2 12003.5 11188.2 11527.8 12094.8 12103.7 12584.2 11005.1 11095.6 11162.9 11540.7 11823.6 10169.8 10436.3 10520.5 10836.7 10857.2 9544.5 10164.4 11068.0 11117.5 11203.7 8948.9 8977.3 9015.3 9114.0 9416.5 8724.2 8925.8 8975.9 8991.0 9017.5 06:50:49 INFO - PROCESS | 8399 | -------- Summary: end -------- 06:50:49 INFO - PROCESS | 8399 | 06:50:49 INFO - TEST-INFO | 8399: exit 0 06:50:49 INFO - TEST-OK | dromaeo_css | took 1115633ms 06:50:49 INFO - TEST-START | kraken 06:50:49 INFO - operating with platform_type : linux_ 06:50:49 INFO - Initialising browser for kraken test... 06:50:49 INFO - TEST-INFO | started process 8709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54iXwr/profile http://localhost:35949/getInfo.html) 06:50:54 INFO - PROCESS | 8709 | __metrics Screen width/height:1600/1200 06:50:54 INFO - PROCESS | 8709 | colorDepth:24 06:50:54 INFO - PROCESS | 8709 | Browser inner width/height: 1024/697 06:50:54 INFO - PROCESS | 8709 | __metrics 06:50:54 INFO - PROCESS | 8709 | 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" 06:50:54 INFO - PROCESS | 8709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:55 INFO - PROCESS | 8709 | console.error: PushService: 06:50:55 INFO - PROCESS | 8709 | stateChangeProcessEnqueue: Error transitioning state 06:50:55 INFO - PROCESS | 8709 | UnknownError 06:50:56 INFO - TEST-INFO | 8709: exit 0 06:50:56 INFO - Browser initialized. 06:50:56 INFO - Running cycle 1/1 for kraken test... 06:50:56 INFO - TEST-INFO | started process 8792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54iXwr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:08 INFO - PROCESS | 8792 | RSS: Main: 173776896 06:51:08 INFO - PROCESS | 8792 | 06:51:10 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35949/tests/kraken/driver.html?testName=audio-beat-detection) 06:51:11 INFO - PROCESS | 8792 | RSS: Main: 232263680 06:51:11 INFO - PROCESS | 8792 | 06:51:14 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35949/tests/kraken/driver.html?testName=audio-dft) 06:51:14 INFO - PROCESS | 8792 | RSS: Main: 217812992 06:51:14 INFO - PROCESS | 8792 | 06:51:17 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35949/tests/kraken/driver.html?testName=audio-fft) 06:51:18 INFO - PROCESS | 8792 | RSS: Main: 298778624 06:51:18 INFO - PROCESS | 8792 | 06:51:20 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35949/tests/kraken/driver.html?testName=audio-oscillator) 06:51:21 INFO - PROCESS | 8792 | RSS: Main: 209084416 06:51:21 INFO - PROCESS | 8792 | 06:51:23 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:23 INFO - PROCESS | 8792 | RSS: Main: 212975616 06:51:23 INFO - PROCESS | 8792 | 06:51:26 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35949/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:27 INFO - PROCESS | 8792 | RSS: Main: 249536512 06:51:27 INFO - PROCESS | 8792 | 06:51:30 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35949/tests/kraken/driver.html?testName=imaging-desaturate) 06:51:31 INFO - PROCESS | 8792 | RSS: Main: 248516608 06:51:31 INFO - PROCESS | 8792 | 06:51:34 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35949/tests/kraken/driver.html?testName=json-parse-financial) 06:51:34 INFO - PROCESS | 8792 | RSS: Main: 248459264 06:51:34 INFO - PROCESS | 8792 | 06:51:36 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:36 INFO - PROCESS | 8792 | RSS: Main: 210333696 06:51:36 INFO - PROCESS | 8792 | 06:51:38 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:39 INFO - PROCESS | 8792 | RSS: Main: 217710592 06:51:39 INFO - PROCESS | 8792 | 06:51:41 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:42 INFO - PROCESS | 8792 | RSS: Main: 222142464 06:51:42 INFO - PROCESS | 8792 | 06:51:44 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:45 INFO - PROCESS | 8792 | RSS: Main: 223604736 06:51:45 INFO - PROCESS | 8792 | 06:51:47 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:48 INFO - PROCESS | 8792 | RSS: Main: 221536256 06:51:48 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | Cycle 1(1): loaded http://localhost:35949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35949/tests/kraken/driver.html?testName=ai-astar) 06:51:50 INFO - PROCESS | 8792 | RSS: Main: 272658432 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | __start_tp_report 06:51:50 INFO - PROCESS | 8792 | _x_x_mozilla_page_load 06:51:50 INFO - PROCESS | 8792 | _x_x_mozilla_page_load_details 06:51:50 INFO - PROCESS | 8792 | |i|pagename|runs| 06:51:50 INFO - PROCESS | 8792 | |0;ai-astar;111;111;113;111;111;112;112;113;111;113 06:51:50 INFO - PROCESS | 8792 | |1;audio-beat-detection;149;118;126;163;121;124;124;119;158;125 06:51:50 INFO - PROCESS | 8792 | |2;audio-dft;161;161;162;162;161;162;161;162;161;161 06:51:50 INFO - PROCESS | 8792 | |3;audio-fft;75;76;76;107;76;76;75;75;103;77 06:51:50 INFO - PROCESS | 8792 | |4;audio-oscillator;82;83;112;83;83;83;103;84;83;119 06:51:50 INFO - PROCESS | 8792 | |5;imaging-gaussian-blur;117;117;116;117;118;117;117;116;116;117 06:51:50 INFO - PROCESS | 8792 | |6;imaging-darkroom;145;145;145;146;146;146;145;146;145;146 06:51:50 INFO - PROCESS | 8792 | |7;imaging-desaturate;94;96;95;94;94;95;95;95;95;95 06:51:50 INFO - PROCESS | 8792 | |8;json-parse-financial;50;49;50;50;51;51;51;50;52;50 06:51:50 INFO - PROCESS | 8792 | |9;json-stringify-tinderbox;62;62;61;61;62;61;61;61;61;62 06:51:50 INFO - PROCESS | 8792 | |10;stanford-crypto-aes;78;78;78;78;79;79;79;81;77;79 06:51:50 INFO - PROCESS | 8792 | |11;stanford-crypto-ccm;125;127;136;124;129;123;139;128;165;123 06:51:50 INFO - PROCESS | 8792 | |12;stanford-crypto-pbkdf2;163;167;168;168;160;163;162;162;160;162 06:51:50 INFO - PROCESS | 8792 | |13;stanford-crypto-sha256-iterative;65;64;66;64;65;66;64;64;64;67 06:51:50 INFO - PROCESS | 8792 | __end_tp_report 06:51:50 INFO - PROCESS | 8792 | __start_cc_report 06:51:50 INFO - PROCESS | 8792 | _x_x_mozilla_cycle_collect,1625 06:51:50 INFO - PROCESS | 8792 | __end_cc_report 06:51:50 INFO - PROCESS | 8792 | __startTimestamp1474984310495__endTimestamp 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | ------- Summary: start ------- 06:51:50 INFO - PROCESS | 8792 | Number of tests: 14 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 06:51:50 INFO - PROCESS | 8792 | Values: 111.0 111.0 113.0 111.0 111.0 112.0 112.0 113.0 111.0 113.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:125.50 stddev:17.06 (13.6%) stddev-sans-first:17.05 06:51:50 INFO - PROCESS | 8792 | Values: 149.0 118.0 126.0 163.0 121.0 124.0 124.0 119.0 158.0 125.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:51:50 INFO - PROCESS | 8792 | Values: 161.0 161.0 162.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.38 (16.3%) stddev-sans-first:12.90 06:51:50 INFO - PROCESS | 8792 | Values: 75.0 76.0 76.0 107.0 76.0 76.0 75.0 75.0 103.0 77.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.00 stddev:14.21 (17.1%) stddev-sans-first:14.65 06:51:50 INFO - PROCESS | 8792 | Values: 82.0 83.0 112.0 83.0 83.0 83.0 103.0 84.0 83.0 119.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 06:51:50 INFO - PROCESS | 8792 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:51:50 INFO - PROCESS | 8792 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:51:50 INFO - PROCESS | 8792 | Values: 94.0 96.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.88 06:51:50 INFO - PROCESS | 8792 | Values: 50.0 49.0 50.0 50.0 51.0 51.0 51.0 50.0 52.0 50.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:51:50 INFO - PROCESS | 8792 | Values: 62.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 62.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:1.07 (1.4%) stddev-sans-first:1.12 06:51:50 INFO - PROCESS | 8792 | Values: 78.0 78.0 78.0 78.0 79.0 79.0 79.0 81.0 77.0 79.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:128.50 stddev:12.82 (10.0%) stddev-sans-first:13.35 06:51:50 INFO - PROCESS | 8792 | Values: 125.0 127.0 136.0 124.0 129.0 123.0 139.0 128.0 165.0 123.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 06:51:50 INFO - PROCESS | 8792 | Values: 163.0 167.0 168.0 168.0 160.0 163.0 162.0 162.0 160.0 162.0 06:51:50 INFO - PROCESS | 8792 | 06:51:50 INFO - PROCESS | 8792 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 06:51:50 INFO - PROCESS | 8792 | Values: 65.0 64.0 66.0 64.0 65.0 66.0 64.0 64.0 64.0 67.0 06:51:50 INFO - PROCESS | 8792 | -------- Summary: end -------- 06:51:50 INFO - PROCESS | 8792 | 06:51:51 INFO - TEST-INFO | 8792: exit 0 06:51:51 INFO - TEST-OK | kraken | took 61891ms 06:51:51 INFO - SUITE-END | took 1177s 06:51:52 INFO - Completed test suite (00:19:37) 06:51:52 INFO - javascript benchmark 06:51:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.2801213702637, 2998.5502174673798, 3025.636923569172, 3052.9084127476185, 3074.8001379910306, 5189.247559103927, 5199.662021968574, 5271.4464981177, 5287.154055351145, 5329.813456529022, 5259.9474005259935, 5283.471652834714, 5295.549878260353, 5296.232046353286, 5316.362036555619, 4722.598579120761, 4736.763161841911, 4774.832880849171, 4814.566688997998, 4833.226683730604, 4734.857954261378, 4820.662553621248, 4840.056189043138, 4853.441854186761, 4856.514348565151, 4798.5201479852085, 4811.4707382187935, 4843.225083986563, 4848.418189817209, 4898.24077268024, 4718.032803275355, 4725.574698277172, 4768.73771942543, 4770.76146192689, 4810.013947140863, 4729.172394830891, 4732.905341893177, 4769.976150119262, 4801.1117943180625, 4803.327534145223, 5274.841754747364, 5293.814716484943, 5298.735063246861, 5303.204519322094, 5309.5752339812725, 5472.288602481692, 5531.032069387841, 5543.362513310981, 5553.278073850373, 5570.0, 5591.524720398771, 5592.6085174037835, 5611.270534830446, 5629.380768115504, 5703.885922281573, 5272.1300985337375, 5277.736113194402, 5284.7886084556185, 5285.550728188108, 5341.759620817073, 5638.35158956717, 5688.715564221855, 5844.415558444121, 5845.240118784531, 5853.678047707332, 5516.172574113915, 5545.140503222007, 5560.555155587544, 5574.16387541872, 5622.353429355595, 5650.660960342392, 5655.604107712421, 5660.85847853807, 5661.688607126647, 5663.461971112738, 5441.96602645504, 5576.330840299109, 5623.044082505902, 5631.521320687705, 5635.3519345275, 5501.559875209973, 5610.0, 5660.490555849993, 5670.971645141748, 5705.971470142706, 4371.584699453547, 4390.143921935256, 4394.846180383671, 4396.208682437128, 4449.1101779644205, 3924.7056470764237, 3930.9213815724097, 3967.1867267210155, 3988.4615576897327, 3994.7603143811466, 5232.084385232569, 5282.577393808486, 5290.65610735301, 5334.839954801362, 5344.652597581223, 5675.914861277084, 5687.260656114761, 5690.829275121753, 5691.9146212806845, 5743.770249189985, 5261.710605916712, 5300.814471493479, 5301.469853014745, 5302.92045619316, 5438.864028399322, 4747.976260118678, 4749.667523273338, 4780.235162374073, 4794.2808578713475, 4859.927101093415, 5744.310682718101, 5814.302283726064, 5849.181114643953, 5853.473187413153, 5867.706614669164, 5627.409122042291, 5635.0, 5636.126400407943, 5640.435956404327, 5644.0, 5782.913256301074, 5785.855353616025, 5786.161006653927, 5787.479126878601, 5788.392218816964, 5369.0872551665525, 5471.316085489314, 5473.753681084281, 5506.531944784738, 5518.668879867221, 5560.5551555876245, 5637.492625663546, 5640.802571909963, 5649.039663257338, 5701.9736447439855, 5487.231787549826, 5501.697406642673, 5502.944970550403, 5505.779768809363, 5509.752061157177, 5294.97352513235, 5394.595405344537, 5454.91817622728, 5478.643888147258, 5530.225768392348, 5462.289902312674, 5478.726063696879, 5481.260029895913, 5525.861853453695, 5549.833504994856, 5546.611737178358, 5553.4724201200825, 5558.416366281483, 5564.165375193753, 5564.415736347625, 5324.227986941794, 5363.678179309254, 5404.040153920108, 5408.296921400193, 5475.288212532345], "value": 5194.021603912259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5841394196177, 606.1362558354346, 619.7366119399254, 620.7920346683861, 630.9432151106399, 32148.35703285933, 43410.348844767315, 44182.77908610452, 44290.33564496535, 44377.0, 45137.0, 45472.317915231295, 45519.0, 45542.0, 45561.77219113908, 7970.442069055169, 8795.42829716068, 8929.107089291052, 8939.284857211407, 8940.64237430502, 7875.881861772078, 10310.968903109666, 10541.36751794891, 10555.683329500089, 10911.454427278604, 10638.840417393707, 10672.252942294042, 10678.946605266963, 10688.412137332443, 10737.194710396712, 10576.36541807494, 10640.0, 10644.840327395095, 10657.946710266477, 10666.466676666174, 10117.949410252902, 10171.949140254252, 10206.132478739317, 10242.617246671678, 10254.436006019667, 43194.56805431937, 43426.0, 43445.34831977523, 43529.0, 43541.78229108866, 3247.8376081195847, 3253.723433508131, 3264.1513206566465, 3337.599488061424, 3377.712894403954, 30689.079327620206, 32650.83674581612, 32721.83639081813, 32770.836145819354, 34330.14174645629, 4348.543402942677, 4392.648588112943, 4412.0955204183065, 4506.4817545982305, 4560.931586026212, 322080.0, 322433.0, 323302.0, 323877.3806130978, 324643.0, 59316.40683593195, 59781.701091494266, 59865.911397531694, 59906.400935990954, 59955.0, 36620.450693239625, 37719.245615087544, 37787.84333723288, 39346.21307573833, 61900.0, 16396.75404868928, 16986.0, 16986.405475808286, 16989.745153822703, 16989.830101699074, 11859.169858110023, 12086.456109475095, 12569.0, 12864.935675321563, 12948.935255323662, 18552.25790968346, 18972.430827075208, 19119.617607647768, 19198.424047278604, 19314.517137071685, 7079.141867682126, 7172.175199852084, 7289.380402665727, 7329.926700733031, 7537.773866784005, 956.712986104166, 1029.9330543514648, 1074.4788777442934, 1082.8971247731454, 1087.8259478483562, 31557.21106972298, 32053.51919721206, 32289.0, 32539.83730081382, 32584.837075814943, 1072.3190773858655, 1073.3398959639765, 1074.693712291993, 1093.94530273486, 1118.7706520163347, 16601.05444651532, 17132.0, 17205.7419138713, 17292.394766183123, 17646.0, 157760.0, 158402.0, 158513.0, 158615.0, 159736.0, 58575.41424585785, 58741.0, 58779.41220587825, 58851.41148588545, 58949.41050589525, 1188.2217147768226, 1256.2462522486435, 1287.7488889666613, 1292.6962163891667, 1323.2259128409987, 30031.484861899477, 32824.34351313008, 33048.37322774861, 33213.833930830195, 33308.833455832566, 49834.75082624564, 50404.0, 50446.49553504418, 50567.241491376924, 50610.74694626503, 383882.0, 384186.0, 384197.0, 384358.0, 386550.0, 27219.59170612403, 28213.43573128567, 28421.57367639446, 28473.145805625034, 30229.395412092075, 46984.0, 47137.292940605235, 47204.0, 47373.52626473691, 47845.521544784104, 39312.0, 40711.38932916068, 40722.59277407188, 40886.59113408828, 42971.35542966796, 40079.39880901731, 40810.59189408068, 41306.586934130275, 41403.378949316386, 41924.0, 39935.0, 39997.0, 40159.79920100381, 40291.0, 40603.390949136374, 33630.0, 36285.86259907794, 36559.81720091382, 36700.0, 37021.44467833039, 27175.320616984733, 27874.16377508678, 27881.0, 27888.72111278861, 27973.44053118967], "value": 19448.924408495383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.57640290069327, 376.4936160863638, 377.54128733588686, 378.22841403536785, 381.7976472469591, 14278.71442571148, 18225.270989160435, 19676.9016154919, 20495.385138445832, 20676.793232067674, 18439.354622588213, 18902.243910243607, 19178.808211917876, 19369.903150484228, 19389.709154362696, 5674.659520428777, 5950.37521060289, 5951.0, 5951.9107213391835, 5953.255843019622, 5662.943370566283, 5772.509336706385, 5786.652800831943, 5797.971010144944, 5851.414858514136, 5757.942420575803, 5760.4815566599, 5767.279090113736, 5768.250127483421, 5769.076947688371, 5561.5272701820195, 5697.487226149646, 5733.971330143364, 5747.655140691551, 5752.0, 5117.5650069744115, 5124.769385377667, 5126.897462050775, 5134.768935397916, 5139.8458046258675, 14006.649833754238, 15926.362945482168, 21203.893980530152, 22051.22820701284, 22088.33734987953, 2181.2910803988607, 2337.0, 2715.5383584790434, 2772.4400245646657, 2854.885804567815, 9740.610375584969, 10331.845022324596, 10401.994359886789, 10671.306365086322, 10761.892381076168, 1953.2870502266712, 1958.6082783443226, 1963.882167069966, 1986.6093734385843, 2004.0480771633358, 82302.58848705718, 83609.0, 84445.0, 86784.56607716985, 86942.0, 10517.158627309796, 10613.681589552325, 10778.514966826511, 10922.72693182661, 11231.0, 15584.844151558565, 15591.844081559266, 15604.843951560339, 15606.687866242839, 15620.0, 7466.328030477283, 7742.419318551131, 7839.45123841337, 8000.4399692021, 8003.079645840803, 7380.815479613053, 7380.9261907381315, 7429.36850367714, 7524.811879703051, 7582.924170758332, 4759.6430267729365, 4760.33355330254, 4783.425988881287, 4809.567138957511, 4954.256861470808, 1945.562248494106, 1978.9505262368268, 1995.5410255640993, 2025.7670367907585, 2051.8153366197116, 709.9361057504849, 883.4081165619051, 915.2677857713802, 937.3063932689761, 954.5227386306847, 17584.560385990197, 17776.288948442176, 18795.34216302423, 19569.706454403196, 20053.799462005485, 908.7773495493647, 918.1186061381148, 952.5806548243067, 974.907383798538, 1006.1849901579744, 10240.180785537139, 10760.892391076146, 10763.3541987481, 10803.459827008619, 10840.945795270973, 438410.0, 453694.0, 465661.0, 469530.0, 471721.0, 90055.0, 92144.0, 93228.0, 94885.0, 95347.0, 921.755734730297, 954.8567714842691, 971.2618410008304, 977.8093271812071, 981.1954197557934, 16503.66992660164, 16726.66546669084, 17122.486325410257, 17438.389656361967, 17686.0, 42654.57345426506, 42850.35724464198, 42978.35532467078, 43604.56395436132, 44350.778246108566, 54275.0, 58694.7065264671, 59858.10212846724, 60032.699836500535, 60443.69778151257, 5876.324222714272, 6375.904361434675, 8238.0, 8482.571154461026, 8749.562521874008, 12597.0, 12980.0, 13371.06402551812, 13395.062345635712, 13514.85123764491, 11086.889131108586, 11479.942600286946, 11824.940875295568, 11833.290002599872, 12116.030717542399, 11043.116550676088, 11226.0, 11518.654440366803, 11615.245009074382, 11689.649310520357, 11712.063034957353, 11713.41432928333, 11784.057275417774, 11800.940995294968, 12112.21270617407, 8182.304504117216, 8461.0, 8568.614412351584, 8860.86708699357, 8904.510251935946, 10656.0, 11081.778364432828, 11708.590199342982, 11740.765184696429, 11996.220245684002], "value": 9061.632990948574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.2334962469888, 1474.8230212374513, 1609.3482139733405, 1780.0832571225812, 1796.3622913865577, 7736.303732664059, 7974.401919856019, 8298.543580103093, 8969.730908072761, 8988.191062804346, 8410.0, 8716.08481109484, 8718.73843784686, 8971.05803890592, 8984.595693193805, 2341.438054866828, 2370.6681064650875, 2372.8694921779297, 2374.76252374762, 2380.9642855357183, 1995.5510010247724, 2273.7726227377298, 2334.579775640384, 2348.154664320843, 2349.4361353275176, 2017.1124705129696, 2264.286749673856, 2346.9061237550477, 2355.4346956730346, 2359.327591636384, 2322.7096612923383, 2343.4961483281177, 2356.4211977974715, 2359.775821296974, 2366.2428023032635, 2298.816094712419, 2314.7685231476885, 2324.9651255231183, 2335.9182428615086, 2339.3683705399617, 8703.868497095336, 8761.123887611251, 8769.7807554811, 8773.868391974125, 8782.912170878337, 5098.1842905135, 5251.842444726664, 5288.762005709714, 5291.761870715827, 5295.655782374133, 3301.4387554115856, 3426.229098452853, 3500.929981400383, 3505.544279243682, 3536.416491278936, 1119.5074167366415, 1146.9311841289466, 1163.941802909851, 1178.3106882473762, 1194.4266751959108, 12140.15018948674, 12431.937840310831, 12450.190737602026, 12489.50041998319, 12530.185537940004, 4408.448943882015, 4571.177188106173, 4743.857684269477, 4749.857504274877, 4776.880577985508, 10506.579736810594, 10508.842367364496, 10512.26414151002, 10521.053105220413, 10534.0, 5309.761060752276, 5376.516113549799, 5384.165454354581, 5389.326334208224, 5389.380221274525, 4694.0, 4779.928301075487, 4911.607071434348, 4928.260760885896, 4928.408590969035, 3693.593704692482, 3702.7963462009848, 3744.8689295874515, 3775.622437756257, 3815.3895376740143, 1098.9285696429706, 1126.2566705974018, 1126.6480223731555, 1129.7740451909651, 1136.6078702847503, 799.1249581708021, 812.8171161488737, 822.5393779483388, 872.3326655108847, 886.742844575079, 5496.780128794883, 5578.079616863253, 5682.886342273131, 5917.171595976567, 6099.359567245464, 506.4682083811983, 510.7114480318608, 516.7752027867889, 518.4064246437807, 653.8300041989022, 3847.442120892511, 4083.693722970789, 4099.692523060723, 4126.257273690764, 4129.607687269705, 10296.330738501973, 10703.250772445854, 10738.194635402377, 10745.83881241782, 10747.570097196025, 10556.419396933088, 10557.313774604627, 10560.155187584975, 10571.04860562553, 10596.364218146937, 7581.279778421152, 7889.408294377829, 7941.523508589503, 7984.441089123706, 8002.0, 5773.74018169175, 5857.092150716475, 5872.060470324727, 5884.823455296348, 6213.440790328892, 9362.578683959102, 9454.621815127319, 9800.215982721507, 9846.852297215404, 9848.753781155528, 9806.901930980599, 9880.16018638395, 10119.696409107739, 10179.287449878437, 10284.382937023802, 7611.619419028915, 7688.615569221628, 7756.68973241064, 7765.1846556110795, 7807.0, 8305.294050005818, 8450.408471406943, 8454.619542120496, 8469.153084691481, 8472.915270847212, 7442.144153422426, 7516.661750221362, 7550.622468876424, 7592.316691497792, 7802.258785415376, 7298.6715597797165, 7500.962495187489, 7501.62491875415, 7643.350315223046, 7662.770116896502, 6797.082393876961, 6859.965700171667, 6868.278830722702, 6872.381485666314, 6872.6907289173105, 4980.975095124501, 5069.062223488519, 5107.208382700687, 5146.8970620588125, 5154.484551544815, 5023.2214006829, 5076.974615126901, 5084.542391184811, 5183.81856635016, 5191.299174611379], "value": 4507.391447302109, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.5386593177269, 316.2205164270074, 318.4396457358939, 321.04649191900046, 323.4743541744665, 5162.922556161651, 5324.920126198101, 5333.146696528552, 5360.65155764875, 5388.649737767048, 5105.18317069269, 5238.397584277809, 5284.497972692598, 5284.630075894689, 5293.100172970595, 4070.7354021988626, 4103.507579090498, 4112.0, 4121.649659778923, 4127.587241275878, 3951.8221680024326, 4105.486814148231, 4112.753234805907, 4121.5672354402805, 4121.660460350398, 4095.4471146395153, 4100.5489396166395, 4108.096218831867, 4109.903948986009, 4110.650594699439, 4108.931677763788, 4126.236646220444, 4132.793360332002, 4142.689298302639, 4169.353750168699, 3630.09247688078, 3646.7082633389264, 3659.4876717259604, 3661.157933675243, 3667.174885650734, 5168.250603662448, 5174.508421699932, 5179.922301165486, 5182.53357197854, 5234.607404444682, 4673.953260467386, 4681.250999840044, 4685.344051832746, 4696.3894693689945, 4705.458872229703, 5338.425164576459, 5520.254765606632, 5526.585506087019, 5533.778648854081, 5538.529225015878, 3906.199229158016, 3923.9215215695526, 3929.4105884117325, 3952.960470395288, 3960.3069462843887, 5837.883242335172, 5838.2118414013985, 5842.0, 5842.4741773240185, 5861.413858614147, 4096.467459230281, 4101.52832424269, 4106.979465102715, 4110.424540564323, 4113.958860411358, 4049.6962727794944, 4094.549599544048, 4104.589541045872, 4107.67138628909, 4124.835006599762, 4672.789724462407, 4682.906341873144, 4687.929681054787, 4695.624350052056, 4722.480527142012, 5571.303587051619, 5584.692841893735, 5589.441055894378, 5602.495775380154, 5649.661020338793, 1300.174389262806, 1326.2771789374815, 1380.861913808611, 1394.187556176966, 1397.73443045823, 891.4339394484549, 898.898848910093, 900.2887718702283, 905.4295793649958, 917.8347897378536, 4708.835190768306, 4720.12677654635, 4735.224290890916, 4735.644826637947, 4747.335373047776, 4968.701877887338, 4970.950290497049, 4971.6271279654175, 4977.303177555145, 4982.188625701269, 4500.279955207151, 4665.4168228971375, 4699.718016918996, 4747.264174053027, 4751.762411879392, 2639.0, 2644.378571035805, 2664.6535950326333, 2675.3846615278594, 2684.2886635041727, 5098.643094983389, 5109.080365534165, 5115.5396014358885, 5119.769610367468, 5149.407818100892, 4912.410510738734, 5034.874128146753, 5065.164247899129, 5091.567216786615, 5204.245384419238, 5094.898102037939, 5117.590592752571, 5118.641695081308, 5122.795088196431, 5152.758550030674, 4998.125328067501, 5006.749662516787, 5032.597392208541, 5033.597312214941, 5051.393832740095, 4704.317873908332, 4783.617310615212, 4950.801967921387, 4983.6760610560195, 4985.401751789808, 5093.4651861554, 5095.980803839173, 5124.0, 5141.794328226979, 5147.3308469898675, 3643.7813731176216, 3648.3068217038676, 3660.194757153422, 3681.208540163878, 3713.9071523212137, 4812.326274321667, 5027.069992051483, 5106.336176297058, 5113.284140220298, 5139.815578379099, 4881.877953051202, 4899.216125419915, 4919.810684245476, 4924.384451943507, 4926.679765815211, 4867.10183028612, 4883.560479556857, 4885.0, 4890.804367825247, 4901.534354236342, 4533.637309015205, 4816.8795780105775, 4839.854804355875, 4846.17615005457, 4860.3681521401995, 4911.557959783637, 4931.235658472942, 4936.358273424432, 4939.654224204415, 4946.406431228275, 4823.97393094908, 4824.34871292371, 4845.224764037737, 4845.903081938271, 4856.077345304381], "value": 3975.6191489385437, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9166345870224, 731.1993367262847, 768.7232596265344, 775.647080578337, 818.9262966333031, 16289.674206515863, 17224.65550688987, 17263.913680431597, 17268.82731172688, 17299.0, 14611.196384198865, 14672.119672819612, 14730.18983955882, 14748.410063597443, 14752.114873107594, 658.9110470086525, 676.245985725917, 771.6720393832627, 789.9012623422072, 792.2592376128309, 770.3298130626335, 792.0139426414094, 797.3581267079999, 805.3235282362814, 806.0166596751953, 841.0370126205491, 841.5960339037266, 845.2561745663808, 845.6406027438314, 847.326375531454, 703.2967032967033, 842.4566154830162, 843.5360551696604, 844.2444012608712, 844.6621351459404, 526.1240035341152, 600.1058422949817, 616.8704572039832, 620.8230654263558, 621.9813405597839, 15178.696426071527, 15187.772183417257, 15224.771628425582, 15229.847701522955, 15241.16173610451, 13511.189328640314, 14014.509492167725, 14299.142051476945, 14483.203423811687, 14493.565193044225, 12802.48790048397, 12941.741165176738, 13182.67043323915, 13452.32738363078, 14081.436742530286, 4241.088166044285, 4264.424302719155, 4337.63130133939, 4348.21732088224, 4406.823727050914, 77275.0, 77771.22228777697, 79250.0, 89246.55376723075, 90713.0, 11123.27698699582, 11193.440327983568, 11235.719107022227, 11721.824172637418, 11865.110116741278, 21774.564508709736, 21922.89038554797, 21959.83943773212, 21972.89013554922, 21975.23086691958, 8316.584170791437, 8345.499270043816, 8398.202170793766, 8612.354073444392, 8639.524826134622, 4419.867403977886, 4445.1998640245065, 4476.001079276893, 4498.977505112453, 4549.363089167519, 3220.2593403516853, 3308.6856748608843, 3312.5362449257123, 3345.5483509725877, 3350.3801796667694, 538.0933127679793, 542.3762672926088, 543.2882923370397, 543.6982474726485, 544.4093158922534, 584.8888711144868, 606.8634557224589, 608.3095686395973, 632.9208848893888, 663.177659701966, 8198.38512111594, 8428.915710842935, 8646.437981531306, 8806.91193088061, 8849.159329863653, 553.6235359955189, 573.4208449465985, 575.4705670782889, 576.049518294817, 614.173936056004, 3945.506811648544, 4259.42497762798, 4259.510156332061, 4262.339337402707, 4278.679099067583, 72354.63822680958, 72822.63588682128, 121404.78595214112, 122796.38601806934, 130822.0, 110468.0, 110961.0, 112579.4371028156, 116516.0, 116899.0, 57830.13254801181, 82332.9999999988, 96004.0, 97386.51306743563, 97922.5103874476, 7898.842023159619, 7948.443608947318, 7950.602469876599, 7958.880616790869, 8225.42422030476, 55019.449805501434, 56624.0, 56739.71630141823, 57335.139972899604, 57980.0, 74800.0, 79583.0, 80824.19175808167, 81839.59080204561, 84287.57856210679, 9968.451735154345, 10151.0, 10185.541650625888, 10422.166226701695, 12003.459844306852, 11188.216824822184, 11527.8270825936, 12094.818577721517, 12103.697407564881, 12584.244945302946, 11005.119590432907, 11095.5561777528, 11162.944185279022, 11540.711482213012, 11823.645290641294, 10169.79660406773, 10436.269461137648, 10520.526576303932, 10836.67489975302, 10857.185711071543, 9544.475053871825, 10164.390136591828, 11068.0, 11117.499712512794, 11203.719907002063, 8948.86576701363, 8977.28181745472, 9015.2787776979, 9113.989844468413, 9416.482093484925, 8724.214820666171, 8925.750394944584, 8975.865362019706, 8990.955045224731, 9017.458952462874], "value": 7126.658828651394, "unit": "score"}], "name": "dromaeo_css", "value": 6992.700523182522, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 113.0, 111.0, 111.0, 112.0, 112.0, 113.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 126.0, 163.0, 121.0, 124.0, 124.0, 119.0, 158.0, 125.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 76.0, 76.0, 75.0, 75.0, 103.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 112.0, 83.0, 83.0, 83.0, 103.0, 84.0, 83.0, 119.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 51.0, 51.0, 51.0, 50.0, 52.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 81.0, 77.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 136.0, 124.0, 129.0, 123.0, 139.0, 128.0, 165.0, 123.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 168.0, 168.0, 160.0, 163.0, 162.0, 162.0, 160.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 65.0, 66.0, 64.0, 64.0, 64.0, 67.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1486.8, "alertThreshold": 2.0}]} 06:51:52 INFO - Return code: 0 06:51:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:51:52 INFO - # TBPL SUCCESS # 06:51:52 INFO - Running post-action listener: _resource_record_post_action 06:51:52 INFO - [mozharness: 2016-09-27 13:51:52.306489Z] Finished run-tests step (success) 06:51:52 INFO - Running post-run listener: _resource_record_post_run 06:51:52 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392847360; Read time: 12; Write time: 277032 06:51:52 INFO - TinderboxPrint: CPU usage
13.2% 06:51:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:51:52 INFO - TinderboxPrint: I/O write bytes / time
392,847,360 / 277,032 06:51:52 INFO - TinderboxPrint: CPU idle
8,277.8 (86.8%) 06:51:52 INFO - TinderboxPrint: CPU user
1,206.8 (12.7%) 06:51:52 INFO - TinderboxPrint: Swap in / out
0 / 0 06:51:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103337984; Read time: 0; Write time: 71380 06:51:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288894976; Read time: 0; Write time: 205652 06:51:52 INFO - Running post-run listener: _upload_blobber_files 06:51:52 INFO - Blob upload gear active. 06:51:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:52 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 06:51:52 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:51:52 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:51:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:58 INFO - (blobuploader) - INFO - Done attempting. 06:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:59 INFO - (blobuploader) - INFO - Done attempting. 06:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:00 INFO - (blobuploader) - INFO - Done attempting. 06:52:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:52:00 INFO - Return code: 0 06:52:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:52:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:52:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aebea432ffbea27e90a9dd85c67524259d8858a278317aff0ea65039081feaf7a5f2ecac1a85e428fda9f2ca40bea43dd6da08dfbbf0372ffb38157a7a1ad89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a4bf70c3be3559d70c5644afa4f6f3f93a7a89f2e93ffa33bf8a08801e6a7f220c4ec00483fc06598f691b332bd4a8d990cfedf0b1f4bc9a0ee86bb92fc54d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7b297ac7c0c5e578b47bb6f140a342983aab0e87390f6d6dbdee94371685a316035901e37773eeeb70ca449adaf2d44448e43afdc26a74f8615e2c366001e5a"} 06:52:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:52:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:52:00 INFO - Contents: 06:52:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aebea432ffbea27e90a9dd85c67524259d8858a278317aff0ea65039081feaf7a5f2ecac1a85e428fda9f2ca40bea43dd6da08dfbbf0372ffb38157a7a1ad89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a4bf70c3be3559d70c5644afa4f6f3f93a7a89f2e93ffa33bf8a08801e6a7f220c4ec00483fc06598f691b332bd4a8d990cfedf0b1f4bc9a0ee86bb92fc54d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7b297ac7c0c5e578b47bb6f140a342983aab0e87390f6d6dbdee94371685a316035901e37773eeeb70ca449adaf2d44448e43afdc26a74f8615e2c366001e5a"} 06:52:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:52:00 INFO - Copying logs to upload dir... 06:52:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:52:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.509068 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-27 06:51:59.958541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:51:59.964075) ========= 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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 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/sha512/6aebea432ffbea27e90a9dd85c67524259d8858a278317aff0ea65039081feaf7a5f2ecac1a85e428fda9f2ca40bea43dd6da08dfbbf0372ffb38157a7a1ad89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a4bf70c3be3559d70c5644afa4f6f3f93a7a89f2e93ffa33bf8a08801e6a7f220c4ec00483fc06598f691b332bd4a8d990cfedf0b1f4bc9a0ee86bb92fc54d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7b297ac7c0c5e578b47bb6f140a342983aab0e87390f6d6dbdee94371685a316035901e37773eeeb70ca449adaf2d44448e43afdc26a74f8615e2c366001e5a"} build_url:https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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/sha512/6aebea432ffbea27e90a9dd85c67524259d8858a278317aff0ea65039081feaf7a5f2ecac1a85e428fda9f2ca40bea43dd6da08dfbbf0372ffb38157a7a1ad89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a4bf70c3be3559d70c5644afa4f6f3f93a7a89f2e93ffa33bf8a08801e6a7f220c4ec00483fc06598f691b332bd4a8d990cfedf0b1f4bc9a0ee86bb92fc54d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7b297ac7c0c5e578b47bb6f140a342983aab0e87390f6d6dbdee94371685a316035901e37773eeeb70ca449adaf2d44448e43afdc26a74f8615e2c366001e5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:51:59.994121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:51:59.994966) ========= 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=03627c79f6bb3d1578c4a402000001ba-1474978336.113677-2024687744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004355 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:52:00.076764) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:52:00.077117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:52:00.077443) ========= ========= Total master_lag: 0.21 =========