builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1489759020.51 results: success (0) revision: 9a95ade0ec97a871f97c397261fc7297e897331f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.513398) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.513865) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.514137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.528430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.528707) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-17 06:57:00-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-03-17 06:57:00 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.661036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.661380) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.711311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:00.711659) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a95ade0ec97a871f97c397261fc7297e897331f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9a95ade0ec97a871f97c397261fc7297e897331f --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=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-17 06:57:00,928 truncating revision to first 12 chars 2017-03-17 06:57:00,928 Setting DEBUG logging. 2017-03-17 06:57:00,928 attempt 1/10 2017-03-17 06:57:00,928 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a95ade0ec97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 06:57:01,477 unpacking tar archive at: mozilla-central-9a95ade0ec97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837559 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:01.562232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:01.562575) ========= script_repo_revision: 9a95ade0ec97a871f97c397261fc7297e897331f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:01.562989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:01.563248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 06:57:01.572565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-17 06:57:01.572850) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:01 INFO - MultiFileLogger online at 20170317 06:57:01 in /builds/slave/test 06:57:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:57:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:01 INFO - {'append_to_log': False, 06:57:01 INFO - 'base_work_dir': '/builds/slave/test', 06:57:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:57:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:01 INFO - 'branch': 'Firefox-Non-PGO', 06:57:01 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:01 INFO - 'config_files': ('talos/linux_config.py',), 06:57:01 INFO - 'default_actions': ('clobber', 06:57:01 INFO - 'read-buildbot-config', 06:57:01 INFO - 'download-and-extract', 06:57:01 INFO - 'populate-webroot', 06:57:01 INFO - 'create-virtualenv', 06:57:01 INFO - 'install', 06:57:01 INFO - 'run-tests'), 06:57:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:01 INFO - 'download_minidump_stackwalk': True, 06:57:01 INFO - 'download_symbols': 'ondemand', 06:57:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:01 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:01 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:01 INFO - 'gecko_profile': False, 06:57:01 INFO - 'gecko_profile_interval': 0, 06:57:01 INFO - 'installer_path': 'installer.exe', 06:57:01 INFO - 'log_level': 'info', 06:57:01 INFO - 'log_name': 'talos', 06:57:01 INFO - 'log_to_console': True, 06:57:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:01 INFO - 'opt_config_files': (), 06:57:01 INFO - 'pip_index': False, 06:57:01 INFO - 'suite': 'dromaeojs', 06:57:01 INFO - 'system_bits': '32', 06:57:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:01 INFO - 'title': 'talos-linux64-ix-061', 06:57:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:01 INFO - 'use_talos_json': True, 06:57:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:01 INFO - 'work_dir': 'build'} 06:57:01 INFO - [mozharness: 2017-03-17 13:57:01.892173Z] Running clobber step. 06:57:01 INFO - Running pre-action listener: _resource_record_pre_action 06:57:01 INFO - Running main action method: clobber 06:57:01 INFO - rmtree: /builds/slave/test/build 06:57:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:02 INFO - Running post-action listener: _resource_record_post_action 06:57:02 INFO - [mozharness: 2017-03-17 13:57:02.827225Z] Finished clobber step (success) 06:57:02 INFO - [mozharness: 2017-03-17 13:57:02.827334Z] Running read-buildbot-config step. 06:57:02 INFO - Running pre-action listener: _resource_record_pre_action 06:57:02 INFO - Running main action method: read_buildbot_config 06:57:02 INFO - Using buildbot properties: 06:57:02 INFO - { 06:57:02 INFO - "project": "", 06:57:02 INFO - "product": "firefox", 06:57:02 INFO - "who": "cbook@mozilla.com", 06:57:02 INFO - "installer_path": "public/build/target.tar.bz2", 06:57:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:57:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:57:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:57:02 INFO - "stage_platform": "linux64", 06:57:02 INFO - "basedir": "/builds/slave/test", 06:57:02 INFO - "buildnumber": 498, 06:57:02 INFO - "platform": "ubuntu64_hw", 06:57:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:02 INFO - "slavebuilddir": "test", 06:57:02 INFO - "taskId": "XeeIDWZISIOFs-GbJR5q4Q", 06:57:02 INFO - "branch": "mozilla-central", 06:57:02 INFO - "script_repo_revision": "production", 06:57:02 INFO - "revision": "9a95ade0ec97a871f97c397261fc7297e897331f", 06:57:02 INFO - "slavename": "talos-linux64-ix-061", 06:57:02 INFO - "repo_path": "mozilla-central" 06:57:02 INFO - } 06:57:02 INFO - Finding installer, test and symbols from parent task. 06:57:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeeIDWZISIOFs-GbJR5q4Q'}, attempt #1 06:57:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeeIDWZISIOFs-GbJR5q4Q'}, attempt #1 06:57:03 INFO - Task dependencies: Q8PywIQ9RZ6kiSJewt7OIg 06:57:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg'}, attempt #1 06:57:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 06:57:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/test_packages.json 06:57:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.crashreporter-symbols.zip 06:57:04 INFO - Running post-action listener: _resource_record_post_action 06:57:04 INFO - [mozharness: 2017-03-17 13:57:04.298172Z] Finished read-buildbot-config step (success) 06:57:04 INFO - [mozharness: 2017-03-17 13:57:04.298392Z] Running download-and-extract step. 06:57:04 INFO - Running pre-action listener: _resource_record_pre_action 06:57:04 INFO - Running main action method: download_and_extract 06:57:04 INFO - mkdir: /builds/slave/test/build/tests 06:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:04 INFO - trying https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.test_packages.json 06:57:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:57:04 INFO - Downloaded 986 bytes. 06:57:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:57:04 INFO - Using the following test package requirements: 06:57:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:57:04 INFO - u'common': [u'target.common.tests.zip'], 06:57:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:57:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:57:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:57:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:57:04 INFO - u'mozbase': [u'target.common.tests.zip'], 06:57:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:57:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:57:04 INFO - u'web-platform': [u'target.common.tests.zip', 06:57:04 INFO - u'target.web-platform.tests.zip'], 06:57:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:57:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:57:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip 06:57:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip into memory 06:57:05 INFO - Expected file size: 58185907 06:57:05 INFO - Obtained file size: 58185907 06:57:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:57:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip 06:57:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.common.tests.zip into memory 06:57:16 INFO - Expected file size: 58185907 06:57:16 INFO - Obtained file size: 58185907 06:57:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.talos.tests.zip 06:57:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:57:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.talos.tests.zip into memory 06:57:28 INFO - Expected file size: 14404171 06:57:28 INFO - Obtained file size: 14404171 06:57:28 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:57:28 INFO - trying https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 06:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:57:29 INFO - Downloaded 61749839 bytes. 06:57:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 06:57:29 INFO - mkdir: /builds/slave/test/properties 06:57:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:29 INFO - Contents: 06:57:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 06:57:29 INFO - Running post-action listener: _resource_record_post_action 06:57:29 INFO - Running post-action listener: set_extra_try_arguments 06:57:29 INFO - [mozharness: 2017-03-17 13:57:29.845740Z] Finished download-and-extract step (success) 06:57:29 INFO - [mozharness: 2017-03-17 13:57:29.845837Z] Running populate-webroot step. 06:57:29 INFO - Running pre-action listener: _resource_record_pre_action 06:57:29 INFO - Running main action method: populate_webroot 06:57:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:29 INFO - '--tppagecycles', 06:57:29 INFO - '7'], 06:57:29 INFO - 'tests': ['tsvgm']}}, 06:57:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['damp', 'tps']}, 06:57:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'tests': ['damp', 'tps']}, 06:57:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['dromaeo_dom']}, 06:57:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['basic_compositor_video']}, 06:57:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:57:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['a11yr', 06:57:29 INFO - 'ts_paint', 06:57:29 INFO - 'tpaint', 06:57:29 INFO - 'sessionrestore', 06:57:29 INFO - 'sessionrestore_no_auto_restore', 06:57:29 INFO - 'tabpaint']}, 06:57:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['tsvgx', 06:57:29 INFO - 'tsvgr_opacity', 06:57:29 INFO - 'tart', 06:57:29 INFO - 'tscrollx', 06:57:29 INFO - 'cart', 06:57:29 INFO - 'tsvg_static']}, 06:57:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:29 INFO - 'tsvgr_opacity', 06:57:29 INFO - 'tart', 06:57:29 INFO - 'tscrollx', 06:57:29 INFO - 'cart', 06:57:29 INFO - 'tsvg_static']}, 06:57:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'talos_options': ['--disable-e10s'], 06:57:29 INFO - 'tests': ['tp5o']}, 06:57:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:57:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'talos_options': ['--disable-e10s', 06:57:29 INFO - '--xperf_path', 06:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:29 INFO - 'tests': ['tp5n']}, 06:57:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:57:29 INFO - 'talos_options': ['--xperf_path', 06:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:29 INFO - 'tests': ['tp5n']}}, 06:57:29 INFO - 'talos.zip': {'path': '', 06:57:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:29 INFO - Running post-action listener: _resource_record_post_action 06:57:29 INFO - [mozharness: 2017-03-17 13:57:29.859043Z] Finished populate-webroot step (success) 06:57:29 INFO - [mozharness: 2017-03-17 13:57:29.859132Z] Running create-virtualenv step. 06:57:29 INFO - Running pre-action listener: _resource_record_pre_action 06:57:29 INFO - Running main action method: create_virtualenv 06:57:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:29 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:57:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:29 INFO - Using real prefix '/usr' 06:57:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:32 INFO - Installing pip.................done. 06:57:32 INFO - Return code: 0 06:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:57:32 INFO - Reading from file tmpfile_stdout 06:57:32 INFO - Output received: 06:57:32 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:57:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57:32 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:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 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:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:32 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:57:32 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:57:32 INFO - Using env: {'DISPLAY': ':0', 06:57:32 INFO - 'HOME': '/home/cltbld', 06:57:32 INFO - 'LANG': 'en_US.UTF-8', 06:57:32 INFO - 'LANGUAGE': 'en_US:en', 06:57:32 INFO - 'LOGNAME': 'cltbld', 06:57:32 INFO - 'MAIL': '/var/mail/cltbld', 06:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:32 INFO - 'MOZ_NO_REMOTE': '1', 06:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:32 INFO - 'NO_EM_RESTART': '1', 06:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:32 INFO - 'PWD': '/builds/slave/test', 06:57:32 INFO - 'SHELL': '/bin/bash', 06:57:32 INFO - 'SHLVL': '1', 06:57:32 INFO - 'TERM': 'linux', 06:57:32 INFO - 'TMOUT': '86400', 06:57:32 INFO - 'USER': 'cltbld', 06:57:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:32 INFO - '_': '/tools/buildbot/bin/python'} 06:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:32 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:57:32 INFO - Cleaning up... 06:57:32 INFO - Return code: 0 06:57:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:57:32 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:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 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:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:32 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:32 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:57:32 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:57:32 INFO - Using env: {'DISPLAY': ':0', 06:57:32 INFO - 'HOME': '/home/cltbld', 06:57:32 INFO - 'LANG': 'en_US.UTF-8', 06:57:32 INFO - 'LANGUAGE': 'en_US:en', 06:57:32 INFO - 'LOGNAME': 'cltbld', 06:57:32 INFO - 'MAIL': '/var/mail/cltbld', 06:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:32 INFO - 'MOZ_NO_REMOTE': '1', 06:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:32 INFO - 'NO_EM_RESTART': '1', 06:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:32 INFO - 'PWD': '/builds/slave/test', 06:57:32 INFO - 'SHELL': '/bin/bash', 06:57:32 INFO - 'SHLVL': '1', 06:57:32 INFO - 'TERM': 'linux', 06:57:32 INFO - 'TMOUT': '86400', 06:57:32 INFO - 'USER': 'cltbld', 06:57:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:32 INFO - '_': '/tools/buildbot/bin/python'} 06:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:33 INFO - Downloading/unpacking psutil>=3.1.1 06:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:33 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:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:35 INFO - Installing collected packages: psutil 06:57:35 INFO - Running setup.py install for psutil 06:57:35 INFO - building 'psutil._psutil_linux' extension 06:57:35 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:57:35 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:57:35 INFO - building 'psutil._psutil_posix' extension 06:57:35 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:57:35 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:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:35 INFO - Successfully installed psutil 06:57:35 INFO - Cleaning up... 06:57:35 INFO - Return code: 0 06:57:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:35 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:35 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:57:35 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:57:35 INFO - Using env: {'DISPLAY': ':0', 06:57:35 INFO - 'HOME': '/home/cltbld', 06:57:35 INFO - 'LANG': 'en_US.UTF-8', 06:57:35 INFO - 'LANGUAGE': 'en_US:en', 06:57:35 INFO - 'LOGNAME': 'cltbld', 06:57:35 INFO - 'MAIL': '/var/mail/cltbld', 06:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:35 INFO - 'MOZ_NO_REMOTE': '1', 06:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:35 INFO - 'NO_EM_RESTART': '1', 06:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:35 INFO - 'PWD': '/builds/slave/test', 06:57:35 INFO - 'SHELL': '/bin/bash', 06:57:35 INFO - 'SHLVL': '1', 06:57:35 INFO - 'TERM': 'linux', 06:57:35 INFO - 'TMOUT': '86400', 06:57:35 INFO - 'USER': 'cltbld', 06:57:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:35 INFO - '_': '/tools/buildbot/bin/python'} 06:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:57:36 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:57:36 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:57:36 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:57:36 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:57:36 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:57:36 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:57:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:57:38 INFO - Installing collected packages: mozsystemmonitor 06:57:38 INFO - Running setup.py install for mozsystemmonitor 06:57:38 INFO - Successfully installed mozsystemmonitor 06:57:38 INFO - Cleaning up... 06:57:38 INFO - Return code: 0 06:57:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:57:38 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:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:38 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:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:38 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:38 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:57:38 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:57:38 INFO - Using env: {'DISPLAY': ':0', 06:57:38 INFO - 'HOME': '/home/cltbld', 06:57:38 INFO - 'LANG': 'en_US.UTF-8', 06:57:38 INFO - 'LANGUAGE': 'en_US:en', 06:57:38 INFO - 'LOGNAME': 'cltbld', 06:57:38 INFO - 'MAIL': '/var/mail/cltbld', 06:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:38 INFO - 'MOZ_NO_REMOTE': '1', 06:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:38 INFO - 'NO_EM_RESTART': '1', 06:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:38 INFO - 'PWD': '/builds/slave/test', 06:57:38 INFO - 'SHELL': '/bin/bash', 06:57:38 INFO - 'SHLVL': '1', 06:57:38 INFO - 'TERM': 'linux', 06:57:38 INFO - 'TMOUT': '86400', 06:57:38 INFO - 'USER': 'cltbld', 06:57:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:38 INFO - '_': '/tools/buildbot/bin/python'} 06:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:38 INFO - Downloading/unpacking jsonschema==2.5.1 06:57: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:57: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:57: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:57: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:57: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:57: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:57:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:57:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:57: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:57: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:57: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:57: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:57: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:57: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:57:40 INFO - Downloading functools32-3.2.3-2.tar.gz 06:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:57:40 INFO - warning: no files found matching '*.txt' 06:57:40 INFO - no previously-included directories found matching 'build' 06:57:40 INFO - no previously-included directories found matching 'dist' 06:57:40 INFO - no previously-included directories found matching '.git*' 06:57:40 INFO - Installing collected packages: jsonschema, functools32 06:57:40 INFO - Running setup.py install for functools32 06:57:40 INFO - warning: no files found matching '*.txt' 06:57:40 INFO - no previously-included directories found matching 'build' 06:57:40 INFO - no previously-included directories found matching 'dist' 06:57:40 INFO - no previously-included directories found matching '.git*' 06:57:40 INFO - Successfully installed jsonschema functools32 06:57:40 INFO - Cleaning up... 06:57:41 INFO - Return code: 0 06:57:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:41 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:41 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:57:41 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:57:41 INFO - Using env: {'DISPLAY': ':0', 06:57:41 INFO - 'HOME': '/home/cltbld', 06:57:41 INFO - 'LANG': 'en_US.UTF-8', 06:57:41 INFO - 'LANGUAGE': 'en_US:en', 06:57:41 INFO - 'LOGNAME': 'cltbld', 06:57:41 INFO - 'MAIL': '/var/mail/cltbld', 06:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:41 INFO - 'MOZ_NO_REMOTE': '1', 06:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:41 INFO - 'NO_EM_RESTART': '1', 06:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:41 INFO - 'PWD': '/builds/slave/test', 06:57:41 INFO - 'SHELL': '/bin/bash', 06:57:41 INFO - 'SHLVL': '1', 06:57:41 INFO - 'TERM': 'linux', 06:57:41 INFO - 'TMOUT': '86400', 06:57:41 INFO - 'USER': 'cltbld', 06:57:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:41 INFO - '_': '/tools/buildbot/bin/python'} 06:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:57:41 INFO - Cleaning up... 06:57:41 INFO - Return code: 0 06:57:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:41 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:41 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:57:41 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:57:41 INFO - Using env: {'DISPLAY': ':0', 06:57:41 INFO - 'HOME': '/home/cltbld', 06:57:41 INFO - 'LANG': 'en_US.UTF-8', 06:57:41 INFO - 'LANGUAGE': 'en_US:en', 06:57:41 INFO - 'LOGNAME': 'cltbld', 06:57:41 INFO - 'MAIL': '/var/mail/cltbld', 06:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:41 INFO - 'MOZ_NO_REMOTE': '1', 06:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:41 INFO - 'NO_EM_RESTART': '1', 06:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:41 INFO - 'PWD': '/builds/slave/test', 06:57:41 INFO - 'SHELL': '/bin/bash', 06:57:41 INFO - 'SHLVL': '1', 06:57:41 INFO - 'TERM': 'linux', 06:57:41 INFO - 'TMOUT': '86400', 06:57:41 INFO - 'USER': 'cltbld', 06:57:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:41 INFO - '_': '/tools/buildbot/bin/python'} 06:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:41 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:57:41 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:57:41 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:57:41 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:57:41 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:57:41 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:57:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57: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:57: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:57: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:57: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:57: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:57: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:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57: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:57: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:57: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:57: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:57: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:57: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:57:44 INFO - Downloading docopt-0.6.1.tar.gz 06:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:44 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:44 INFO - Running setup.py install for blobuploader 06:57:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:44 INFO - Running setup.py install for requests 06:57:44 INFO - Running setup.py install for docopt 06:57:44 INFO - Successfully installed blobuploader requests docopt 06:57:44 INFO - Cleaning up... 06:57:44 INFO - Return code: 0 06:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:44 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:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:44 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:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:44 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:44 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:57:44 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:57:44 INFO - Using env: {'DISPLAY': ':0', 06:57:44 INFO - 'HOME': '/home/cltbld', 06:57:44 INFO - 'LANG': 'en_US.UTF-8', 06:57:44 INFO - 'LANGUAGE': 'en_US:en', 06:57:44 INFO - 'LOGNAME': 'cltbld', 06:57:44 INFO - 'MAIL': '/var/mail/cltbld', 06:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:44 INFO - 'MOZ_NO_REMOTE': '1', 06:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:44 INFO - 'NO_EM_RESTART': '1', 06:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:44 INFO - 'PWD': '/builds/slave/test', 06:57:44 INFO - 'SHELL': '/bin/bash', 06:57:44 INFO - 'SHLVL': '1', 06:57:44 INFO - 'TERM': 'linux', 06:57:44 INFO - 'TMOUT': '86400', 06:57:44 INFO - 'USER': 'cltbld', 06:57:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:44 INFO - '_': '/tools/buildbot/bin/python'} 06:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:45 INFO - Running setup.py (path:/tmp/pip-bVgYZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:45 INFO - Running setup.py (path:/tmp/pip-6I69xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:45 INFO - Running setup.py (path:/tmp/pip-Tvu6HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:45 INFO - Running setup.py (path:/tmp/pip-g17xYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:45 INFO - Running setup.py (path:/tmp/pip-D9icVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:45 INFO - Running setup.py (path:/tmp/pip-IA_pDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:45 INFO - Running setup.py (path:/tmp/pip-2dOeZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:45 INFO - Running setup.py (path:/tmp/pip-CAO3Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:45 INFO - Running setup.py (path:/tmp/pip-KkgdFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:45 INFO - Running setup.py (path:/tmp/pip-Ogk51k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:45 INFO - Running setup.py (path:/tmp/pip-ZglUhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:45 INFO - Running setup.py (path:/tmp/pip-RQYXdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:46 INFO - Running setup.py (path:/tmp/pip-am1n2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:46 INFO - Running setup.py (path:/tmp/pip-ECDAyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:46 INFO - Running setup.py (path:/tmp/pip-jmPsMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:46 INFO - Running setup.py (path:/tmp/pip-CSZwkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:46 INFO - Running setup.py (path:/tmp/pip-egycho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:46 INFO - Running setup.py install for manifestparser 06:57:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:46 INFO - Running setup.py install for mozcrash 06:57:46 INFO - Running setup.py install for mozdebug 06:57:46 INFO - Running setup.py install for mozdevice 06:57:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:46 INFO - Running setup.py install for mozfile 06:57:46 INFO - Running setup.py install for mozhttpd 06:57:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozinfo 06:57:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozInstall 06:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozleak 06:57:47 INFO - Running setup.py install for mozlog 06:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for moznetwork 06:57:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozprocess 06:57:47 INFO - Running setup.py install for mozprofile 06:57:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozrunner 06:57:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:47 INFO - Running setup.py install for mozscreenshot 06:57:47 INFO - Running setup.py install for moztest 06:57:48 INFO - Running setup.py install for mozversion 06:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:48 INFO - Cleaning up... 06:57:48 INFO - Return code: 0 06:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:48 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:48 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:57:48 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:57:48 INFO - Using env: {'DISPLAY': ':0', 06:57:48 INFO - 'HOME': '/home/cltbld', 06:57:48 INFO - 'LANG': 'en_US.UTF-8', 06:57:48 INFO - 'LANGUAGE': 'en_US:en', 06:57:48 INFO - 'LOGNAME': 'cltbld', 06:57:48 INFO - 'MAIL': '/var/mail/cltbld', 06:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:48 INFO - 'MOZ_NO_REMOTE': '1', 06:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:48 INFO - 'NO_EM_RESTART': '1', 06:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:48 INFO - 'PWD': '/builds/slave/test', 06:57:48 INFO - 'SHELL': '/bin/bash', 06:57:48 INFO - 'SHLVL': '1', 06:57:48 INFO - 'TERM': 'linux', 06:57:48 INFO - 'TMOUT': '86400', 06:57:48 INFO - 'USER': 'cltbld', 06:57:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:48 INFO - '_': '/tools/buildbot/bin/python'} 06:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:48 INFO - Running setup.py (path:/tmp/pip-3_zpha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:48 INFO - Running setup.py (path:/tmp/pip-eEV5Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:48 INFO - Running setup.py (path:/tmp/pip-7NhOvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:48 INFO - Running setup.py (path:/tmp/pip-hq2iEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:48 INFO - Running setup.py (path:/tmp/pip-mSiQzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:48 INFO - Running setup.py (path:/tmp/pip-319yVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:48 INFO - Running setup.py (path:/tmp/pip-_0MwTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:48 INFO - Running setup.py (path:/tmp/pip-yBB4Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:48 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:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:48 INFO - Running setup.py (path:/tmp/pip-jiTOT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:49 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:49 INFO - Running setup.py (path:/tmp/pip-opXQwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:49 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:49 INFO - Running setup.py (path:/tmp/pip-JIbgbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:49 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:49 INFO - Running setup.py (path:/tmp/pip-dgkcB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:49 INFO - Running setup.py (path:/tmp/pip-14pbsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:49 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:49 INFO - Running setup.py (path:/tmp/pip-H31wRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:49 INFO - Running setup.py (path:/tmp/pip-6OtzA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:49 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:49 INFO - Running setup.py (path:/tmp/pip-T1Y6Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:49 INFO - Running setup.py (path:/tmp/pip-0LE3Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:49 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:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:57:49 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:57:49 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:49 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:57:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:49 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:57:49 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:57:49 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:57:49 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:57:49 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:57:49 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:57:51 INFO - Downloading blessings-1.6.tar.gz 06:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:51 INFO - Installing collected packages: blessings 06:57:51 INFO - Running setup.py install for blessings 06:57:51 INFO - Successfully installed blessings 06:57:51 INFO - Cleaning up... 06:57:51 INFO - Return code: 0 06:57:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:52 INFO - Reading from file tmpfile_stdout 06:57:52 INFO - Current package versions: 06:57:52 INFO - argparse == 1.2.1 06:57:52 INFO - blessings == 1.6 06:57:52 INFO - blobuploader == 1.2.4 06:57:52 INFO - docopt == 0.6.1 06:57:52 INFO - functools32 == 3.2.3-2 06:57:52 INFO - jsonschema == 2.5.1 06:57:52 INFO - manifestparser == 1.1 06:57:52 INFO - mozInstall == 1.12 06:57:52 INFO - mozcrash == 1.0 06:57:52 INFO - mozdebug == 0.1 06:57:52 INFO - mozdevice == 0.49 06:57:52 INFO - mozfile == 1.2 06:57:52 INFO - mozhttpd == 0.7 06:57:52 INFO - mozinfo == 0.9 06:57:52 INFO - mozleak == 0.1 06:57:52 INFO - mozlog == 3.4 06:57:52 INFO - moznetwork == 0.27 06:57:52 INFO - mozprocess == 0.25 06:57:52 INFO - mozprofile == 0.28 06:57:52 INFO - mozrunner == 6.13 06:57:52 INFO - mozscreenshot == 0.1 06:57:52 INFO - mozsystemmonitor == 0.3 06:57:52 INFO - moztest == 0.8 06:57:52 INFO - mozversion == 1.4 06:57:52 INFO - psutil == 3.1.1 06:57:52 INFO - requests == 1.2.3 06:57:52 INFO - wsgiref == 0.1.2 06:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57: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:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:52 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:52 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:57:52 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:57:52 INFO - Using env: {'DISPLAY': ':0', 06:57:52 INFO - 'HOME': '/home/cltbld', 06:57:52 INFO - 'LANG': 'en_US.UTF-8', 06:57:52 INFO - 'LANGUAGE': 'en_US:en', 06:57:52 INFO - 'LOGNAME': 'cltbld', 06:57:52 INFO - 'MAIL': '/var/mail/cltbld', 06:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:52 INFO - 'MOZ_NO_REMOTE': '1', 06:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:52 INFO - 'NO_EM_RESTART': '1', 06:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:52 INFO - 'PWD': '/builds/slave/test', 06:57:52 INFO - 'SHELL': '/bin/bash', 06:57:52 INFO - 'SHLVL': '1', 06:57:52 INFO - 'TERM': 'linux', 06:57:52 INFO - 'TMOUT': '86400', 06:57:52 INFO - 'USER': 'cltbld', 06:57:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:52 INFO - '_': '/tools/buildbot/bin/python'} 06:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 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:57:52 INFO - Cleaning up... 06:57:52 INFO - Return code: 0 06:57:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57: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:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:52 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 0x23001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259db10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', '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:57:52 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:57:52 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:57:52 INFO - Using env: {'DISPLAY': ':0', 06:57:52 INFO - 'HOME': '/home/cltbld', 06:57:52 INFO - 'LANG': 'en_US.UTF-8', 06:57:52 INFO - 'LANGUAGE': 'en_US:en', 06:57:52 INFO - 'LOGNAME': 'cltbld', 06:57:52 INFO - 'MAIL': '/var/mail/cltbld', 06:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:52 INFO - 'MOZ_NO_REMOTE': '1', 06:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:52 INFO - 'NO_EM_RESTART': '1', 06:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:52 INFO - 'PWD': '/builds/slave/test', 06:57:52 INFO - 'SHELL': '/bin/bash', 06:57:52 INFO - 'SHLVL': '1', 06:57:52 INFO - 'TERM': 'linux', 06:57:52 INFO - 'TMOUT': '86400', 06:57:52 INFO - 'USER': 'cltbld', 06:57:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:52 INFO - '_': '/tools/buildbot/bin/python'} 06:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:57:52 INFO - Cleaning up... 06:57:52 INFO - Return code: 0 06:57:52 INFO - Running post-action listener: _resource_record_post_action 06:57:52 INFO - Running post-action listener: _start_resource_monitoring 06:57:52 INFO - Starting resource monitoring. 06:57:52 INFO - [mozharness: 2017-03-17 13:57:52.592859Z] Finished create-virtualenv step (success) 06:57:52 INFO - [mozharness: 2017-03-17 13:57:52.593335Z] Running install step. 06:57:52 INFO - Running pre-action listener: _resource_record_pre_action 06:57:52 INFO - Running main action method: install 06:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:52 INFO - Reading from file tmpfile_stdout 06:57:52 INFO - Detecting whether we're running mozinstall >=1.0... 06:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:57:52 INFO - Reading from file tmpfile_stdout 06:57:52 INFO - Output received: 06:57:52 INFO - Usage: mozinstall [options] installer 06:57:52 INFO - Options: 06:57:52 INFO - -h, --help show this help message and exit 06:57:52 INFO - -d DEST, --destination=DEST 06:57:52 INFO - Directory to install application into. [default: 06:57:52 INFO - "/builds/slave/test"] 06:57:52 INFO - --app=APP Application being installed. [default: firefox] 06:57:52 INFO - mkdir: /builds/slave/test/build/application 06:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:58:08 INFO - Reading from file tmpfile_stdout 06:58:08 INFO - Output received: 06:58:08 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:08 INFO - Running post-action listener: _resource_record_post_action 06:58:08 INFO - [mozharness: 2017-03-17 13:58:08.964525Z] Finished install step (success) 06:58:08 INFO - [mozharness: 2017-03-17 13:58:08.964811Z] Running run-tests step. 06:58:08 INFO - Running pre-action listener: _resource_record_pre_action 06:58:08 INFO - Running main action method: run_tests 06:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:08 INFO - Python 2.7.3 06:58:08 INFO - Return code: 0 06:58:08 INFO - grabbing minidump binary from tooltool 06:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:08 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 0x259b290>, '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 0x259bb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259c040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:08 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:58:08 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:58:08 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:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:09 INFO - Return code: 0 06:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:09 INFO - ENV: RUST_BACKTRACE is now 1 06:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:58:09 INFO - Using env: {'DISPLAY': ':0', 06:58:09 INFO - 'HOME': '/home/cltbld', 06:58:09 INFO - 'LANG': 'en_US.UTF-8', 06:58:09 INFO - 'LANGUAGE': 'en_US:en', 06:58:09 INFO - 'LOGNAME': 'cltbld', 06:58:09 INFO - 'MAIL': '/var/mail/cltbld', 06:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:09 INFO - 'MOZ_NO_REMOTE': '1', 06:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:09 INFO - 'NO_EM_RESTART': '1', 06:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:09 INFO - 'PWD': '/builds/slave/test', 06:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:09 INFO - 'RUST_BACKTRACE': '1', 06:58:09 INFO - 'SHELL': '/bin/bash', 06:58:09 INFO - 'SHLVL': '1', 06:58:09 INFO - 'TERM': 'linux', 06:58:09 INFO - 'TMOUT': '86400', 06:58:09 INFO - 'USER': 'cltbld', 06:58:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515', 06:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:09 INFO - '_': '/tools/buildbot/bin/python'} 06:58:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:58:09 INFO - mozversion application_buildid: 20170317132824 06:58:09 INFO - mozversion application_changeset: 9a95ade0ec97a871f97c397261fc7297e897331f 06:58:09 INFO - mozversion application_display_name: Nightly 06:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:09 INFO - mozversion application_name: Firefox 06:58:09 INFO - mozversion application_remotingname: firefox 06:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:58:09 INFO - mozversion application_vendor: Mozilla 06:58:09 INFO - mozversion application_version: 55.0a1 06:58:09 INFO - mozversion platform_buildid: 20170317132824 06:58:09 INFO - mozversion platform_changeset: 9a95ade0ec97a871f97c397261fc7297e897331f 06:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:58:09 INFO - mozversion platform_version: 55.0a1 06:58:09 INFO - using testdate: 1489759089 06:58:09 INFO - actual date: 1489759089 06:58:09 INFO - starting webserver on 'localhost:34501' 06:58:09 INFO - SUITE-START | Running 2 tests 06:58:09 INFO - TEST-START | dromaeo_css 06:58:09 INFO - operating with platform_type : linux_ 06:58:09 INFO - Initialising browser for dromaeo_css test... 06:58:09 INFO - TEST-INFO | started process 25095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1egtEb/profile http://localhost:34501/getInfo.html) 06:58:13 INFO - PID 25095 | __metrics Screen width/height:1600/1200 06:58:13 INFO - PID 25095 | colorDepth:24 06:58:13 INFO - PID 25095 | Browser inner width/height: 1024/697 06:58:13 INFO - PID 25095 | __metrics 06:58:14 INFO - PID 25095 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:58:14 INFO - PID 25095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:58:15 INFO - TEST-INFO | 25095: exit 0 06:58:15 INFO - Browser initialized. 06:58:15 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:15 INFO - TEST-INFO | started process 25187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1egtEb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:27 INFO - PID 25187 | RSS: Main: 148635648 06:58:27 INFO - PID 25187 | 07:01:33 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34501/tests/dromaeo/cssquery-ext.html) 07:01:34 INFO - PID 25187 | RSS: Main: 271949824 07:01:34 INFO - PID 25187 | 07:03:17 INFO - PID 25187 | ************************* 07:03:17 INFO - PID 25187 | A coding exception was thrown and uncaught in a Task. 07:03:17 INFO - PID 25187 | 07:03:17 ERROR - PID 25187 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:03:17 INFO - PID 25187 | Full stack: 07:03:17 INFO - PID 25187 | ************************* 07:04:37 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-ext.html (next: http://localhost:34501/tests/dromaeo/cssquery-jquery.html) 07:04:37 INFO - PID 25187 | RSS: Main: 239529984 07:04:37 INFO - PID 25187 | 07:07:40 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34501/tests/dromaeo/cssquery-mootools.html) 07:07:40 INFO - PID 25187 | RSS: Main: 178728960 07:07:40 INFO - PID 25187 | 07:10:42 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34501/tests/dromaeo/cssquery-prototype.html) 07:10:43 INFO - PID 25187 | RSS: Main: 192397312 07:10:43 INFO - PID 25187 | 07:13:46 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34501/tests/dromaeo/cssquery-yui.html) 07:13:47 INFO - PID 25187 | RSS: Main: 187158528 07:13:47 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | Cycle 1(1): loaded http://localhost:34501/tests/dromaeo/cssquery-yui.html (next: http://localhost:34501/tests/dromaeo/cssquery-dojo.html) 07:16:50 INFO - PID 25187 | RSS: Main: 276447232 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | __start_tp_report 07:16:50 INFO - PID 25187 | _x_x_mozilla_page_load 07:16:50 INFO - PID 25187 | _x_x_mozilla_page_load_details 07:16:50 INFO - PID 25187 | |i|pagename|runs| 07:16:50 INFO - PID 25187 | |0;dojo.html;2639.247814372904;2655.2698008047796;2684.9865750671242;2685.959710604341;2692.919212423628;4798.47216806151;4873.195922672764;4993.7003779773195;5000.074986127564;5040.823571175009;4868.196747536652;4884.609231261499;4892.681975671579;4898.461169271377;4898.608111351093;4462.509123996358;4471.3293006049025;4497.055618320141;4505.819767209324;4538.341940418637;4513.074819661978;4568.771561421932;4605.516420775821;4614.538546145375;4661.953380466186;4536.342230376594;4542.182407166709;4543.204939135655;4570.702904311226;4580.702254353473;619.6073688373777;4441.467023957113;4453.755043472608;4566;4594.448666160066;4019.9397009044887;4460.219461594241;4493.168763778712;4495.2133376659285;4512.210363186462;4847.975760121177;4852.150873597142;4852.927206091911;4863.440704319013;4903.63222758291;5103.387593488768;5223.242629818655;5240.528352448298;5244.108501554745;5254.238135470374;5248.029114613809;5338.145896656516;5400.378956420022;5409.540189083933;5432.483914028161;4999.500049995007;5022.547970682656;5023.196288593807;5025.170846810235;5072.898542029138;5485.149801780731;5488.643238189505;5490.423505531861;5500.944990550123;5504.532114770209;5088.516590923857;5146.614003949719;5148.459411761711;5149.356330458692;5151.4333423323405;5151.562117220078;5190.2214667800135;5196.350456192976;5213.661112027706;5323.733813309319;5270.341207349082;5271.499207575274;5281.366236051698;5289.603279754034;5338.679679219259;5217.060929032735;5243.711595862264;5264.15773476242;5268.683878967274;5300.92048619271;4346.891327716832;4401.801918913657;4403.757793321398;4439.578240067189;4448.266036104072;3841.7310788245113;3879.282332768447;3905.37513997759;3906.882793516199;3915.451836742858;4556.612687921497;4564.109998550317;4567.2007398705755;4573.862784116482;4580.290055041407;5364.9731751341;5368.677879327252;5369.865753356197;5370.865728356823;5410.404855465896;4383.517813040563;4495.662825288116;4538.160440318552;4584.037352156084;4590.380298659638;4787.760611969387;4797;4797.232442809134;4812.614990800727;4813.03739252151;4997.700137991732;5014.2979982802435;5016.272640467185;5022.949770502394;5069.467705890828;5175.378954525481;5241.397239317374;5242.318498595311;5244.711540865289;5326;4877.780499877443;4896.730679812645;4927.408710954565;4929;4929.2359684248995;5170.482951704799;5271.894562108813;5317.760700768397;5322.414534401135;5332.386775520865;5365.785368585213;5374.7581358839725;5379.273798037215;5382.381026181883;5384.9192262116885;5160.200168973815;5163.173892177234;5228.869278268074;5229.869253268699;5279.788808447619;4995.800167993385;5058.696478211319;5154.587632989277;5202.3497062867145;5216.843494695166;5138.8715282116755;5142.434332223527;5142.742862856768;5153.098207813692;5160.561352285098;5181.5595674368105;5209.921851172159;5226.712530810842;5228.37259528859;5280.841574752763;4916.82791102324;4972.105021096238;5080.644354895122;5088.5674717647935;5131.409887862944 07:16:50 INFO - PID 25187 | |1;ext.html;653.74177200006;698.2214830464033;723.7466886589692;778.544551437409;787.7361084036847;25584.616230756532;30976.380472390567;31103.222419439524;31201;31319.530207046857;34984.30031399377;35269.11827204321;35274.64725352746;35332.64667353326;35401.46897796528;6541.836454088639;7228.204897461275;7397.075365579302;7410.147832999221;7415.443841711866;6705.865882682368;8721.60752766124;8884.955575222115;8892.110788921122;8894.688685895995;9102;9209.125133112344;9214.815703685923;9227.031161728022;9235.353525253235;9152.130547597968;9155.67955121571;9209.493477858716;9229.953850230773;9236.399634023766;9043.457392556467;9089.772755681095;9101.135392137736;9108.635654573874;9108.8633670495;33629.66370336314;33866;33916.321673566636;33972.83013584916;33987.83006084978;3446.9827650861835;3484.285721427101;3493.63316851732;3532.205253817896;3563.625819288989;23412.414689632726;23768.762312377;23874;23916;24032.759672403226;2940.1032685031055;2968.807027543203;3007.8646460909313;3134.059782065371;3135.5923729914966;148145.25927370295;148414;148589;148891.25554372268;148962;42289.57710422918;42501;42524.25922500485;42586.361204581954;42650;44003.559964399945;44319.77840110779;44430;44430.55569444264;44473.77763111164;13053.086283960032;13370.064095513415;13401.128926619738;13418;13424.463021479227;8559.272461840814;8700.390972631854;10907.454627268606;10917.39954302521;10939.945300273448;11362.602308919313;11387.772244555063;11512.251703639404;11569.88430115705;11600.941995290139;4805.951940480551;4833.927491087637;4875.488073752205;4970.975145124251;4979.178435558165;886.0696268917611;895.7626229049307;900.7207765592688;901.7114523352465;920.3695468604028;20157.899210504147;21836.23573174963;21920.45198870009;21942.670859937112;22177.006104176053;950.2255661635745;950.296780382512;954.5275088830934;959.7168835193635;974.5370948799264;11408.600698975662;11777.470013849397;11883.70290742721;11885.524579016743;11942.104342174373;206946;207633;207801;207839;207935;39570.60429395669;39658;39664.60335396667;39741.801290993935;39855.80072099621;1211.1037832004254;1246.7506498700295;1248.3009514671812;1252.311228824143;1261.9369031548385;19613.41159765209;19928.90035549813;20618.896905515376;20778.06498707592;20950.790492094882;30117.548236776027;30145.246368840955;30199;30234.24414389658;30250;195656;195794;196108;196255;196259.46756655417;26836.463270734086;27247.86376068107;27283.72716272812;27340.316492087855;27452.588211177248;27471;28004.719952800213;28047.43905121927;32367.190820229684;32893.835530822194;27067;27909.860450697615;28273.293167670974;30503.389932201677;32115.67884321127;28644.43262428969;28983.710162898944;29415;29870.402591948474;30083.699163008965;30294.242643934078;30910.69089309078;30988.69011309858;31049.379012419173;31158.844205778827;24655.753442465346;25776.226713198634;27200.727992719818;27436.17691469259;27478.607958089062;21606.243781467572;21990.340289791333;22025;22043.559128817655;22156.446088847908 07:16:50 INFO - PID 25187 | |2;jquery.html;405.87620775663413;407.2262700868351;407.5801924018262;418.1782796804279;419.5175548119662;11544.422778861066;18024.909875450605;18284.542886427847;19054.42836714899;19060.23759049638;16721;16993.150342482888;17752.28990840368;18575;18737.718934215998;5642.830715078534;5793.246877905887;5801.564882633819;5837.737301821428;5857.033589457735;5587.972060139694;5797.420257974211;5807.5934684571885;5808.4481974212595;5816.098504731774;5790.971045144768;6365.777197798078;6626.403623673868;6650.268470468244;6662.533622646417;6467.967660161716;6605.108310378109;6639.900401493957;6645.8338541536605;6699.430548403391;6555.868882622369;6558.508111891627;6563.474922006228;6564.967175164142;6565.310642382528;20634.896825515778;21843.781562184493;22446.551068978693;22491.21280755182;22692.546149076927;2362.090595120874;2397.30478161333;2433.707955045388;2464.9507009859703;2478.3804048987754;14273.572642735748;14285;14372;14419.495317663832;14905.254737263202;1868.2340240501464;1927.8457723382237;1935.8257756801816;1958.3145898935402;1958.6670266054805;89452.55273723655;91694;93467.99999999932;93698.5315073427;93996.53001735016;16067.517974460785;16114.516564502848;16221.675566488604;16283.59291017734;16394.508164755076;21730.78269217319;27900.30249243785;28011.579826302623;28121.57817632737;28276.293092672848;7329.52358096722;8714.69498567547;8717.825643487095;9063.13900179482;9138.451692898447;7255.746048888263;7298.416126709851;7377.77866664001;7484.962575187089;7501.774946751606;8198.672053117927;8354.958225208835;8498.957505212558;8635.611397487128;9091.499967501719;3299.2081900343746;3308.966910330866;3353.916152096217;3414.5390372299917;3768.2840260350445;772.97681069568;789.6328207383594;799.5442597719244;806.6652339279134;820.8399362124447;18105.275788968294;18425.355112570996;19424;19438.902805486166;19684.212631494865;794.1899262752077;802.1857814318471;817.1624085312484;819.2299238715589;822.198356602308;9806.762319651527;9922.801543969224;10048.346857454242;10625.681229563126;10626.46867656614;239513;246592;461003;467689;470997;90263;91806;92076.53961730149;95458;95754;1127.1884243344778;1132.4790596325618;1170.8594968603823;1173.6831055614937;1175.3183153770792;16319.83680163183;16626.418075367303;16653.167341632627;17701.911490442464;18022.459326220236;31421.371572568878;32904.177395565304;36298;37158.07104822401;43936.34095488506;47306.763466183824;48911.5108848907;48921.75539122424;55011.44988550063;57095.429045710676;10037.247206459399;10434.895651043393;10453.216008799218;10867.13062954946;10987.340759554452;11456.255343402652;11602.129840261845;11861.466234019317;11956.76086478283;12212.450439730412;10784;11194.384308863091;11210.775784484102;11233.38216398106;11613.59352422695;11071.280366776135;11098.667039988813;11115.555377784798;11155;11178;11102.555897764321;11179.161562882979;11259.49332280033;11310.83033754478;11582.420878956187;11089.611863584736;11111.944440277746;11245.606403775828;11276.436178191221;11576.305421674726;9820.214382849212;9982.500874956368;10130.315466401262;10450.68647940563;11028.669139925814 07:16:50 INFO - PID 25187 | |3;mootools.html;1436.83476400214;1444.7327244459775;1459.9343029563668;1461.2839708542813;1520.0575643101276;8674.479531228122;9016.99999999999;9023.458592484456;9023.548822558878;9032.367734258605;8913.777155571113;9006.369554131214;9360.157585817275;9362.297827662918;9374.671886483975;2030.9999999999964;2069.213698794456;2071.264701031135;2071.347525529461;2072.450800537859;1970.330087770158;1988.721578978944;1996.17158879065;2002.8597998140135;2010.497375656086;1957.4519134642323;1960.362882063335;1972.1914015253749;1976.6837306031039;1984.7717512486033;1930.6717857964109;1934.6324198402258;1935.400025991947;1938.9709154362695;1938.9723446573198;1904.523869032742;1933.8162874526897;1977.2684106880547;1996.2015193922548;2001.1095062697107;9374.29692773038;9442.858357124649;9445.905540944572;9455.432674039579;9464.432134071978;4677.789499472532;4854.732989685566;4857.73282469464;4861.173600487926;4865.610751139936;2540.3649087728068;2661.095227622598;2705.0397109026408;2714.294283486288;2764.654418197725;914.2229105260542;976.2287792643803;1002.2533212756471;1034.017683200962;1038.2576457832686;11815.409229538574;12151.392430378446;12846.486140554367;12887.097903146783;12964;3842.7502212356667;3925.097227637659;4039.6566291864933;4060.451839001756;4061.289274376972;9899.455529945923;10014.54934527948;10027.448490333101;10028.247881408923;10040.246981476419;4708.81164753406;4713.128071306819;4719.457262414798;4721.079389519011;4744.169770290255;4315.09383029561;4319.762413067248;4355.433793606874;4381.671374646914;4381.780910954503;3138.5135304027913;3205.2627895584146;3224.8387580620874;3225.935481290408;3279.1638132276116;806.4395245304457;806.6571707024608;825.1748251748252;829.2785276809215;843.35904712419;747.4170147285126;753.9208383119693;768.239442951474;776.8912352270687;783.7570353190529;5453.590980676465;5462.672239665632;5514.28314319144;5604.187392828017;5663.065594176915;861.5089399042486;862.8015556422058;866.8006358537572;868.6959564152496;873.1530415496958;3475.58293004841;3504.5093686883856;3515.4199557072798;3539.592946811098;3598.7300952428673;11623.65129046113;12077.577284795167;12115.273083614835;12130.5147794089;12143.089268304913;11791.88208117925;11909.940450297692;12013.399330033464;12019;12033.217840840318;8567.614457349435;8680.262177714838;8694.391392602583;8698.565071746387;8700.390972631982;4298.290782021057;5326;5341.679499230058;5359.624826262124;5442.809501667422;9190.35667503295;9192.080791921022;9258.814823703353;9261.212796912068;9345.953270233877;9741.464219467998;9810.411375317504;9905.950470247602;10048.949755251177;10053.346532475365;6834.658267086726;6938.479614028867;6943.895841562279;6945.687444064928;6948.5483443576;8144.511329320259;8409.95795021021;8456.027556830797;8469.491830490191;8470.322374209925;7432.925670743223;7632.771016869503;7639.427042971688;7699.499532530368;7827.295543401121;7347.889781653386;7359.043324367798;7450.515716478411;7483.625818709152;7491.587962662106;5768.307803063659;5773;5777.480026797609;5780.161876527964;5844.853878652898;4841.612670986383;4915.926261106158;4921.803127874845;4934.580560652241;4949.6287778416045;4745.359376484269;4746.0745154694505;4844.539768721966;4863.148948933993;4936.160852654985 07:16:50 INFO - PID 25187 | |4;prototype.html;357.64771699875615;361.39285999520797;364.9799261040642;380.6402949212993;382.3519135066063;5235.50262725041;5309.123994540906;5315.3887302960175;5323.574114070875;5334.946650533493;4980.32765576647;5181.507756763111;5185.481451854813;5193.974030129853;5221.112410890149;4319.827206911736;4341.696081274312;4343.739375637456;4350.390945267665;4359.585839345273;4335.761533115678;4340.587644173815;4341.110072435144;4366.148601022802;4405.7356558606425;4244.214820258247;4264.42430271914;4326.84856030039;4330.090680957002;4355.216061108999;4292.549282325342;4294.957050429518;4298.806553705075;4308.526062133163;4339.891502712458;3983.541892682321;3991.820368083443;4001.099752555681;4016.4176194451934;4036.9596304037173;4871.196252618349;5084.79660813567;5106.361704786902;5112;5143.974280128613;5025.497450254982;5029.849104526834;5035.320231768701;5038.269450929632;5048;5527.39198688148;5543.8891222175735;5547.583931205136;5555.611107222496;5588.916166257469;4284.357346398066;4416.602505774464;4424.889377765549;4430;4449.510553839107;5433.673979561239;5578.330600327987;5620.747066382022;5771.105478650816;5838.64968101911;4543.477500087466;4548.067646132535;4563.543645635476;4564.246899261585;4571.519990401027;4336.176126535948;4447.466304043471;4467.7319360838455;4620.884477888079;4641.373414589055;4961.305417241589;4978.278149668277;5000.424951130593;5000.449860543244;5007.499250074963;5526.447355264441;5528.9723551381985;5534.169874518854;5538.6122971391615;5540.864122854805;1577.6765763018784;1597.297189236732;1603.5670369000304;1610.7664388663577;1617.7219996202869;1165.0330225912471;1192.3382522699985;1208.697825543614;1212.2665787198794;1214.6295379909213;4772.331873537708;4781.115493633689;4791.329213910055;4802.423709154924;4809.158397280462;5663.1505274208375;5664;5664.801731939362;5700.743466544015;5717.885642287131;4628;4767.880802979884;4785.138675038526;4787.42550893888;4794.376731024944;3006.3085490337344;3011.7200189919195;3019.5923550320863;3024.2137044368183;3040.4071206114595;5284.735763211901;5293.153095504777;5310;5310.973445132827;5320.893582128336;5515.917261241085;5805.69371891321;5835.124731290341;5873.295204575478;5880.911786323209;5333.919991200135;5337.919931201035;5348.384935732441;5348.893022139536;5375.247465354853;5471.398146203994;5652.491275785199;5673.801416950552;5690.658560486384;5704.458076482728;5612.130119831432;5650.23721797552;5658;5680.6875621839545;5706.942930570641;5305.65513241638;5321.3348331458565;5326.520613144836;5330.173823057432;5366.704831234163;4433.955660443355;4527;4546.61353784932;4555.316702494652;4574.702644328108;5674.773009079756;5687.7724891005555;5701.971490142523;5714.314282285986;5723.627964182315;5519.199716041232;5537.701853730657;5542.695151766691;5549;5552.972235138798;5229.477052294892;5482.2873026506295;5488.259085023471;5512.3660779010925;5527.695976721319;5424.294841670558;5449.858107837992;5475;5480.862978425571;5490.693908558335;5432.59255555827;5588.329400471969;5592.665684094696;5603.80386686464;5606.495415412633;5345.518903298722;5374.307093265609;5391.487808658171;5398.865028374322;5433.7774000849495 07:16:50 INFO - PID 25187 | |5;yui.html;711.4273010226765;723.5369363607292;746.1568427676724;752.9759527043224;761.136110514566;13232.338383080843;13671.248081355521;13686.178829270251;13713.588592342234;13716.862831371684;12506.062045346613;12596.622101336974;12602.117851750358;12617.747645047093;12620.68448288791;836.6402446947825;850.5449584472309;851.7231899632613;854.0520022774715;855.9443636163661;848.4697064334791;848.6138806842903;848.7326492154982;849.4266370200121;852.2755657690975;880.9427387219843;881.7310720230328;881.9162179592928;883.0992387764477;890.185480285538;864.9654013839407;882.7881308485981;887.2591386192537;887.3389324952886;888.3603805260202;653.5588477777528;656.8817612829689;657.1096164696862;659.261626977788;659.6009414304373;12411.255324680547;12466.314352710597;13784.517541885985;13878.097923634932;13883.37524811386;12320.568780092653;12524.686882827911;13614.978876584197;13627.863721362857;13981.510647127301;9504.334696571243;10038.247131465168;10263.589456421734;10269.486525673761;10278.640247591298;3309.338132373535;3323.1525960880062;3351.3632409842053;3356.194513316811;3467.7225821934185;59677;59907.70046149785;60357;60359.69820150871;60400.69799651018;9990.900090999143;10384.844227336596;10402.635907743193;10441.477926103664;10924.563017479211;19588.118534665973;19775.901120494305;19784.505387365432;19822.801771982096;19832.305869294505;6253.7185826637915;6333.986562150126;6349.772939100034;6577.14497115372;6592.80221593353;3636.290923269937;3666.211764470652;3705.0922523981258;3769.6795772359656;3838.9424158637644;2730.440259746747;2767.5433553463854;2807.5086859799453;2807.620971168907;2809.522381195202;432.84481821505716;440.6849102891448;444.5754304639062;445.1319926144032;445.5900571474187;642.6369101457661;657.135866335767;660.5013215022627;668.4585485756553;689.5207830557714;8788.560571971504;8939.329550283755;9094.636214551476;9183.16336732656;9298;489.13911515731854;517.8710411303394;531.8271561742372;556.3296228045195;667.4693618573245;3828.9234215315537;4143.875683729493;4326.372675961968;4353.717008394444;4381.9123617527475;55738.16392754112;56556.15165772517;57470.42529574734;57567.13649295264;57651;39627.009324766535;48638.270425943636;51272;51798.48201518012;52788.472115279124;46066.539334606896;46564.76717616458;46575;47490.76254618843;48383.75808121007;7971.72098976533;8159.46963447374;8166.387664979391;8190.1400352964465;8422.494650321001;30901.69098308988;31247.687523125387;31414.371712566077;31755;32269;36224.27551449009;37223.25553488969;39758.60241397549;40555.79722101371;42701.35947960721;11670.649880503599;12149.757004859677;12391.75216495683;12447.751044979232;12826.743465130832;12376.81434778497;12466.937665311978;12686.619401417973;13238.270927855534;13357.265350405822;12001;12085.15403921717;12162.513499460276;12630.684232894251;12863.099583029098;11442.053661268645;12001.279923204636;12191.451384687887;12205.572804951784;12318.384080796104;11578.4771170457;11723.765524689628;12291.938540307241;12321.691957701129;12400.56598019065;9784.559694813894;9941.25440591944;10195.184385249015;10669.306495077795;10776.730581735519;9493.905060949302;10257.74355641115;10336.586536538754;10338.328008679411;10338.586456541954 07:16:50 INFO - PID 25187 | __end_tp_report 07:16:50 INFO - PID 25187 | __start_cc_report 07:16:50 INFO - PID 25187 | _x_x_mozilla_cycle_collect,1275 07:16:50 INFO - PID 25187 | __end_cc_report 07:16:50 INFO - PID 25187 | __startTimestamp1489760210660__endTimestamp 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | ------- Summary: start ------- 07:16:50 INFO - PID 25187 | Number of tests: 6 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#0] dojo.html Cycles:165 Average:4857.46 Median:5023.20 stddev:632.99 (12.6%) stddev-sans-first:610.55 07:16:50 INFO - PID 25187 | Values: 2639.2 2655.3 2685.0 2686.0 2692.9 4798.5 4873.2 4993.7 5000.1 5040.8 4868.2 4884.6 4892.7 4898.5 4898.6 4462.5 4471.3 4497.1 4505.8 4538.3 4513.1 4568.8 4605.5 4614.5 4662.0 4536.3 4542.2 4543.2 4570.7 4580.7 619.6 4441.5 4453.8 4566.0 4594.4 4019.9 4460.2 4493.2 4495.2 4512.2 4848.0 4852.2 4852.9 4863.4 4903.6 5103.4 5223.2 5240.5 5244.1 5254.2 5248.0 5338.1 5400.4 5409.5 5432.5 4999.5 5022.5 5023.2 5025.2 5072.9 5485.1 5488.6 5490.4 5500.9 5504.5 5088.5 5146.6 5148.5 5149.4 5151.4 5151.6 5190.2 5196.4 5213.7 5323.7 5270.3 5271.5 5281.4 5289.6 5338.7 5217.1 5243.7 5264.2 5268.7 5300.9 4346.9 4401.8 4403.8 4439.6 4448.3 3841.7 3879.3 3905.4 3906.9 3915.5 4556.6 4564.1 4567.2 4573.9 4580.3 5365.0 5368.7 5369.9 5370.9 5410.4 4383.5 4495.7 4538.2 4584.0 4590.4 4787.8 4797.0 4797.2 4812.6 4813.0 4997.7 5014.3 5016.3 5022.9 5069.5 5175.4 5241.4 5242.3 5244.7 5326.0 4877.8 4896.7 4927.4 4929.0 4929.2 5170.5 5271.9 5317.8 5322.4 5332.4 5365.8 5374.8 5379.3 5382.4 5384.9 5160.2 5163.2 5228.9 5229.9 5279.8 4995.8 5058.7 5154.6 5202.3 5216.8 5138.9 5142.4 5142.7 5153.1 5160.6 5181.6 5209.9 5226.7 5228.4 5280.8 4916.8 4972.1 5080.6 5088.6 5131.4 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#1] ext.html Cycles:180 Average:32605.95 Median:30943.54 stddev:48096.30 (155.4%) stddev-sans-first:48171.38 07:16:50 INFO - PID 25187 | Values: 653.7 698.2 723.7 778.5 787.7 25584.6 30976.4 31103.2 31201.0 31319.5 34984.3 35269.1 35274.6 35332.6 35401.5 6541.8 7228.2 7397.1 7410.1 7415.4 6705.9 8721.6 8885.0 8892.1 8894.7 9102.0 9209.1 9214.8 9227.0 9235.4 9152.1 9155.7 9209.5 9230.0 9236.4 9043.5 9089.8 9101.1 9108.6 9108.9 33629.7 33866.0 33916.3 33972.8 33987.8 3447.0 3484.3 3493.6 3532.2 3563.6 23412.4 23768.8 23874.0 23916.0 24032.8 2940.1 2968.8 3007.9 3134.1 3135.6 148145.3 148414.0 148589.0 148891.3 148962.0 42289.6 42501.0 42524.3 42586.4 42650.0 44003.6 44319.8 44430.0 44430.6 44473.8 13053.1 13370.1 13401.1 13418.0 13424.5 8559.3 8700.4 10907.5 10917.4 10939.9 11362.6 11387.8 11512.3 11569.9 11600.9 4806.0 4833.9 4875.5 4971.0 4979.2 886.1 895.8 900.7 901.7 920.4 20157.9 21836.2 21920.5 21942.7 22177.0 950.2 950.3 954.5 959.7 974.5 11408.6 11777.5 11883.7 11885.5 11942.1 206946.0 207633.0 207801.0 207839.0 207935.0 39570.6 39658.0 39664.6 39741.8 39855.8 1211.1 1246.8 1248.3 1252.3 1261.9 19613.4 19928.9 20618.9 20778.1 20950.8 30117.5 30145.2 30199.0 30234.2 30250.0 195656.0 195794.0 196108.0 196255.0 196259.5 26836.5 27247.9 27283.7 27340.3 27452.6 27471.0 28004.7 28047.4 32367.2 32893.8 27067.0 27909.9 28273.3 30503.4 32115.7 28644.4 28983.7 29415.0 29870.4 30083.7 30294.2 30910.7 30988.7 31049.4 31158.8 24655.8 25776.2 27200.7 27436.2 27478.6 21606.2 21990.3 22025.0 22043.6 22156.4 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#2] jquery.html Cycles:180 Average:26538.61 Median:28066.58 stddev:65685.46 (234.0%) stddev-sans-first:65840.42 07:16:50 INFO - PID 25187 | Values: 405.9 407.2 407.6 418.2 419.5 11544.4 18024.9 18284.5 19054.4 19060.2 16721.0 16993.2 17752.3 18575.0 18737.7 5642.8 5793.2 5801.6 5837.7 5857.0 5588.0 5797.4 5807.6 5808.4 5816.1 5791.0 6365.8 6626.4 6650.3 6662.5 6468.0 6605.1 6639.9 6645.8 6699.4 6555.9 6558.5 6563.5 6565.0 6565.3 20634.9 21843.8 22446.6 22491.2 22692.5 2362.1 2397.3 2433.7 2465.0 2478.4 14273.6 14285.0 14372.0 14419.5 14905.3 1868.2 1927.8 1935.8 1958.3 1958.7 89452.6 91694.0 93468.0 93698.5 93996.5 16067.5 16114.5 16221.7 16283.6 16394.5 21730.8 27900.3 28011.6 28121.6 28276.3 7329.5 8714.7 8717.8 9063.1 9138.5 7255.7 7298.4 7377.8 7485.0 7501.8 8198.7 8355.0 8499.0 8635.6 9091.5 3299.2 3309.0 3353.9 3414.5 3768.3 773.0 789.6 799.5 806.7 820.8 18105.3 18425.4 19424.0 19438.9 19684.2 794.2 802.2 817.2 819.2 822.2 9806.8 9922.8 10048.3 10625.7 10626.5 239513.0 246592.0 461003.0 467689.0 470997.0 90263.0 91806.0 92076.5 95458.0 95754.0 1127.2 1132.5 1170.9 1173.7 1175.3 16319.8 16626.4 16653.2 17701.9 18022.5 31421.4 32904.2 36298.0 37158.1 43936.3 47306.8 48911.5 48921.8 55011.4 57095.4 10037.2 10434.9 10453.2 10867.1 10987.3 11456.3 11602.1 11861.5 11956.8 12212.5 10784.0 11194.4 11210.8 11233.4 11613.6 11071.3 11098.7 11115.6 11155.0 11178.0 11102.6 11179.2 11259.5 11310.8 11582.4 11089.6 11111.9 11245.6 11276.4 11576.3 9820.2 9982.5 10130.3 10450.7 11028.7 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#3] mootools.html Cycles:180 Average:5574.31 Median:4856.23 stddev:3523.99 (72.6%) stddev-sans-first:3520.16 07:16:50 INFO - PID 25187 | Values: 1436.8 1444.7 1459.9 1461.3 1520.1 8674.5 9017.0 9023.5 9023.5 9032.4 8913.8 9006.4 9360.2 9362.3 9374.7 2031.0 2069.2 2071.3 2071.3 2072.5 1970.3 1988.7 1996.2 2002.9 2010.5 1957.5 1960.4 1972.2 1976.7 1984.8 1930.7 1934.6 1935.4 1939.0 1939.0 1904.5 1933.8 1977.3 1996.2 2001.1 9374.3 9442.9 9445.9 9455.4 9464.4 4677.8 4854.7 4857.7 4861.2 4865.6 2540.4 2661.1 2705.0 2714.3 2764.7 914.2 976.2 1002.3 1034.0 1038.3 11815.4 12151.4 12846.5 12887.1 12964.0 3842.8 3925.1 4039.7 4060.5 4061.3 9899.5 10014.5 10027.4 10028.2 10040.2 4708.8 4713.1 4719.5 4721.1 4744.2 4315.1 4319.8 4355.4 4381.7 4381.8 3138.5 3205.3 3224.8 3225.9 3279.2 806.4 806.7 825.2 829.3 843.4 747.4 753.9 768.2 776.9 783.8 5453.6 5462.7 5514.3 5604.2 5663.1 861.5 862.8 866.8 868.7 873.2 3475.6 3504.5 3515.4 3539.6 3598.7 11623.7 12077.6 12115.3 12130.5 12143.1 11791.9 11909.9 12013.4 12019.0 12033.2 8567.6 8680.3 8694.4 8698.6 8700.4 4298.3 5326.0 5341.7 5359.6 5442.8 9190.4 9192.1 9258.8 9261.2 9346.0 9741.5 9810.4 9906.0 10048.9 10053.3 6834.7 6938.5 6943.9 6945.7 6948.5 8144.5 8410.0 8456.0 8469.5 8470.3 7432.9 7632.8 7639.4 7699.5 7827.3 7347.9 7359.0 7450.5 7483.6 7491.6 5768.3 5773.0 5777.5 5780.2 5844.9 4841.6 4915.9 4921.8 4934.6 4949.6 4745.4 4746.1 4844.5 4863.1 4936.2 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#4] prototype.html Cycles:180 Average:4699.30 Median:5162.74 stddev:1263.95 (24.5%) stddev-sans-first:1224.77 07:16:50 INFO - PID 25187 | Values: 357.6 361.4 365.0 380.6 382.4 5235.5 5309.1 5315.4 5323.6 5334.9 4980.3 5181.5 5185.5 5194.0 5221.1 4319.8 4341.7 4343.7 4350.4 4359.6 4335.8 4340.6 4341.1 4366.1 4405.7 4244.2 4264.4 4326.8 4330.1 4355.2 4292.5 4295.0 4298.8 4308.5 4339.9 3983.5 3991.8 4001.1 4016.4 4037.0 4871.2 5084.8 5106.4 5112.0 5144.0 5025.5 5029.8 5035.3 5038.3 5048.0 5527.4 5543.9 5547.6 5555.6 5588.9 4284.4 4416.6 4424.9 4430.0 4449.5 5433.7 5578.3 5620.7 5771.1 5838.6 4543.5 4548.1 4563.5 4564.2 4571.5 4336.2 4447.5 4467.7 4620.9 4641.4 4961.3 4978.3 5000.4 5000.4 5007.5 5526.4 5529.0 5534.2 5538.6 5540.9 1577.7 1597.3 1603.6 1610.8 1617.7 1165.0 1192.3 1208.7 1212.3 1214.6 4772.3 4781.1 4791.3 4802.4 4809.2 5663.2 5664.0 5664.8 5700.7 5717.9 4628.0 4767.9 4785.1 4787.4 4794.4 3006.3 3011.7 3019.6 3024.2 3040.4 5284.7 5293.2 5310.0 5311.0 5320.9 5515.9 5805.7 5835.1 5873.3 5880.9 5333.9 5337.9 5348.4 5348.9 5375.2 5471.4 5652.5 5673.8 5690.7 5704.5 5612.1 5650.2 5658.0 5680.7 5706.9 5305.7 5321.3 5326.5 5330.2 5366.7 4434.0 4527.0 4546.6 4555.3 4574.7 5674.8 5687.8 5702.0 5714.3 5723.6 5519.2 5537.7 5542.7 5549.0 5553.0 5229.5 5482.3 5488.3 5512.4 5527.7 5424.3 5449.9 5475.0 5480.9 5490.7 5432.6 5588.3 5592.7 5603.8 5606.5 5345.5 5374.3 5391.5 5398.9 5433.8 07:16:50 INFO - PID 25187 | 07:16:50 INFO - PID 25187 | [#5] yui.html Cycles:180 Average:13972.01 Median:22349.84 stddev:16298.29 (72.9%) stddev-sans-first:16313.59 07:16:50 INFO - PID 25187 | Values: 711.4 723.5 746.2 753.0 761.1 13232.3 13671.2 13686.2 13713.6 13716.9 12506.1 12596.6 12602.1 12617.7 12620.7 836.6 850.5 851.7 854.1 855.9 848.5 848.6 848.7 849.4 852.3 880.9 881.7 881.9 883.1 890.2 865.0 882.8 887.3 887.3 888.4 653.6 656.9 657.1 659.3 659.6 12411.3 12466.3 13784.5 13878.1 13883.4 12320.6 12524.7 13615.0 13627.9 13981.5 9504.3 10038.2 10263.6 10269.5 10278.6 3309.3 3323.2 3351.4 3356.2 3467.7 59677.0 59907.7 60357.0 60359.7 60400.7 9990.9 10384.8 10402.6 10441.5 10924.6 19588.1 19775.9 19784.5 19822.8 19832.3 6253.7 6334.0 6349.8 6577.1 6592.8 3636.3 3666.2 3705.1 3769.7 3838.9 2730.4 2767.5 2807.5 2807.6 2809.5 432.8 440.7 444.6 445.1 445.6 642.6 657.1 660.5 668.5 689.5 8788.6 8939.3 9094.6 9183.2 9298.0 489.1 517.9 531.8 556.3 667.5 3828.9 4143.9 4326.4 4353.7 4381.9 55738.2 56556.2 57470.4 57567.1 57651.0 39627.0 48638.3 51272.0 51798.5 52788.5 46066.5 46564.8 46575.0 47490.8 48383.8 7971.7 8159.5 8166.4 8190.1 8422.5 30901.7 31247.7 31414.4 31755.0 32269.0 36224.3 37223.3 39758.6 40555.8 42701.4 11670.6 12149.8 12391.8 12447.8 12826.7 12376.8 12466.9 12686.6 13238.3 13357.3 12001.0 12085.2 12162.5 12630.7 12863.1 11442.1 12001.3 12191.5 12205.6 12318.4 11578.5 11723.8 12291.9 12321.7 12400.6 9784.6 9941.3 10195.2 10669.3 10776.7 9493.9 10257.7 10336.6 10338.3 10338.6 07:16:50 INFO - PID 25187 | -------- Summary: end -------- 07:16:50 INFO - PID 25187 | 07:16:51 INFO - TEST-INFO | 25187: exit 0 07:16:51 INFO - TEST-OK | dromaeo_css | took 1122375ms 07:16:51 INFO - TEST-START | kraken 07:16:51 INFO - operating with platform_type : linux_ 07:16:51 INFO - Initialising browser for kraken test... 07:16:51 INFO - TEST-INFO | started process 25509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXmnuE/profile http://localhost:34501/getInfo.html) 07:16:56 INFO - PID 25509 | __metrics Screen width/height:1600/1200 07:16:56 INFO - PID 25509 | colorDepth:24 07:16:56 INFO - PID 25509 | Browser inner width/height: 1024/697 07:16:56 INFO - PID 25509 | __metrics 07:16:57 INFO - PID 25509 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:16:57 INFO - PID 25509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:16:58 INFO - TEST-INFO | 25509: exit 0 07:16:58 INFO - Browser initialized. 07:16:58 INFO - Running cycle 1/1 for kraken test... 07:16:58 INFO - TEST-INFO | started process 25605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXmnuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:10 INFO - PID 25605 | RSS: Main: 148680704 07:17:10 INFO - PID 25605 | 07:17:13 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34501/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:14 INFO - PID 25605 | RSS: Main: 203026432 07:17:14 INFO - PID 25605 | 07:17:16 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34501/tests/kraken/driver.html?testName=audio-dft) 07:17:17 INFO - PID 25605 | RSS: Main: 183635968 07:17:17 INFO - PID 25605 | 07:17:20 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34501/tests/kraken/driver.html?testName=audio-fft) 07:17:21 INFO - PID 25605 | RSS: Main: 266715136 07:17:21 INFO - PID 25605 | 07:17:23 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34501/tests/kraken/driver.html?testName=audio-oscillator) 07:17:23 INFO - PID 25605 | RSS: Main: 176537600 07:17:23 INFO - PID 25605 | 07:17:26 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:26 INFO - PID 25605 | RSS: Main: 180809728 07:17:26 INFO - PID 25605 | 07:17:29 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34501/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:30 INFO - PID 25605 | RSS: Main: 219824128 07:17:30 INFO - PID 25605 | 07:17:34 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34501/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:34 INFO - PID 25605 | RSS: Main: 214585344 07:17:34 INFO - PID 25605 | 07:17:37 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34501/tests/kraken/driver.html?testName=json-parse-financial) 07:17:38 INFO - PID 25605 | RSS: Main: 216948736 07:17:38 INFO - PID 25605 | 07:17:40 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:40 INFO - PID 25605 | RSS: Main: 180150272 07:17:40 INFO - PID 25605 | 07:17:42 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:43 INFO - PID 25605 | RSS: Main: 187547648 07:17:43 INFO - PID 25605 | 07:17:45 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:45 INFO - PID 25605 | RSS: Main: 196268032 07:17:45 INFO - PID 25605 | 07:17:48 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:49 INFO - PID 25605 | RSS: Main: 205766656 07:17:49 INFO - PID 25605 | 07:17:52 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:53 INFO - PID 25605 | RSS: Main: 201433088 07:17:53 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | Cycle 1(1): loaded http://localhost:34501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34501/tests/kraken/driver.html?testName=ai-astar) 07:17:55 INFO - PID 25605 | RSS: Main: 270606336 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | __start_tp_report 07:17:55 INFO - PID 25605 | _x_x_mozilla_page_load 07:17:55 INFO - PID 25605 | _x_x_mozilla_page_load_details 07:17:55 INFO - PID 25605 | |i|pagename|runs| 07:17:55 INFO - PID 25605 | |0;ai-astar;110;121;120;122;119;119;118;120;122;120 07:17:55 INFO - PID 25605 | |1;audio-beat-detection;151;125;123;165;125;126;124;124;142;126 07:17:55 INFO - PID 25605 | |2;audio-dft;162;163;164;162;163;163;162;164;159;161 07:17:55 INFO - PID 25605 | |3;audio-fft;74;74;76;110;76;77;76;76;90;75 07:17:55 INFO - PID 25605 | |4;audio-oscillator;85;85;110;85;84;84;106;85;84;106 07:17:55 INFO - PID 25605 | |5;imaging-gaussian-blur;113;113;114;113;113;113;114;113;113;114 07:17:55 INFO - PID 25605 | |6;imaging-darkroom;149;149;149;149;150;149;149;149;149;149 07:17:55 INFO - PID 25605 | |7;imaging-desaturate;93;94;94;94;94;94;94;94;94;94 07:17:55 INFO - PID 25605 | |8;json-parse-financial;65;65;65;66;67;66;65;66;66;66 07:17:55 INFO - PID 25605 | |9;json-stringify-tinderbox;56;55;56;55;55;55;55;55;56;56 07:17:55 INFO - PID 25605 | |10;stanford-crypto-aes;81;82;81;81;81;80;82;82;81;82 07:17:55 INFO - PID 25605 | |11;stanford-crypto-ccm;138;136;136;132;137;133;133;133;186;139 07:17:55 INFO - PID 25605 | |12;stanford-crypto-pbkdf2;189;195;192;201;194;198;193;192;190;190 07:17:55 INFO - PID 25605 | |13;stanford-crypto-sha256-iterative;72;72;71;70;73;71;74;70;72;70 07:17:55 INFO - PID 25605 | __end_tp_report 07:17:55 INFO - PID 25605 | __start_cc_report 07:17:55 INFO - PID 25605 | _x_x_mozilla_cycle_collect,2014 07:17:55 INFO - PID 25605 | __end_cc_report 07:17:55 INFO - PID 25605 | __startTimestamp1489760275342__endTimestamp 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | ------- Summary: start ------- 07:17:55 INFO - PID 25605 | Number of tests: 14 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#0] ai-astar Cycles:10 Average:119.10 Median:120.00 stddev:3.45 (2.9%) stddev-sans-first:1.36 07:17:55 INFO - PID 25605 | Values: 110.0 121.0 120.0 122.0 119.0 119.0 118.0 120.0 122.0 120.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:126.00 stddev:14.59 (11.6%) stddev-sans-first:13.97 07:17:55 INFO - PID 25605 | Values: 151.0 125.0 123.0 165.0 125.0 126.0 124.0 124.0 142.0 126.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 07:17:55 INFO - PID 25605 | Values: 162.0 163.0 164.0 162.0 163.0 163.0 162.0 164.0 159.0 161.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:11.39 (15.0%) stddev-sans-first:11.85 07:17:55 INFO - PID 25605 | Values: 74.0 74.0 76.0 110.0 76.0 77.0 76.0 76.0 90.0 75.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.50 stddev:11.06 (13.1%) stddev-sans-first:11.48 07:17:55 INFO - PID 25605 | Values: 85.0 85.0 110.0 85.0 84.0 84.0 106.0 85.0 84.0 106.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:17:55 INFO - PID 25605 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:17:55 INFO - PID 25605 | Values: 149.0 149.0 149.0 149.0 150.0 149.0 149.0 149.0 149.0 149.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:17:55 INFO - PID 25605 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 07:17:55 INFO - PID 25605 | Values: 65.0 65.0 65.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 07:17:55 INFO - PID 25605 | Values: 56.0 55.0 56.0 55.0 55.0 55.0 55.0 55.0 56.0 56.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 07:17:55 INFO - PID 25605 | Values: 81.0 82.0 81.0 81.0 81.0 80.0 82.0 82.0 81.0 82.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:136.50 stddev:16.23 (11.9%) stddev-sans-first:17.20 07:17:55 INFO - PID 25605 | Values: 138.0 136.0 136.0 132.0 137.0 133.0 133.0 133.0 186.0 139.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:193.50 stddev:3.78 (2.0%) stddev-sans-first:3.66 07:17:55 INFO - PID 25605 | Values: 189.0 195.0 192.0 201.0 194.0 198.0 193.0 192.0 190.0 190.0 07:17:55 INFO - PID 25605 | 07:17:55 INFO - PID 25605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.35 (1.9%) stddev-sans-first:1.42 07:17:55 INFO - PID 25605 | Values: 72.0 72.0 71.0 70.0 73.0 71.0 74.0 70.0 72.0 70.0 07:17:55 INFO - PID 25605 | -------- Summary: end -------- 07:17:55 INFO - PID 25605 | 07:17:56 INFO - TEST-INFO | 25605: exit 0 07:17:56 INFO - TEST-OK | kraken | took 64928ms 07:17:56 INFO - SUITE-END | took 1187s 07:17:56 INFO - Completed test suite (00:19:47) 07:17:56 INFO - javascript benchmark 07:17:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6585.4801617127005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.247814372904, 2655.2698008047796, 2684.9865750671242, 2685.959710604341, 2692.919212423628, 4798.47216806151, 4873.195922672764, 4993.7003779773195, 5000.074986127564, 5040.823571175009, 4868.196747536652, 4884.609231261499, 4892.681975671579, 4898.461169271377, 4898.608111351093, 4462.509123996358, 4471.3293006049025, 4497.055618320141, 4505.819767209324, 4538.341940418637, 4513.074819661978, 4568.771561421932, 4605.516420775821, 4614.538546145375, 4661.953380466186, 4536.342230376594, 4542.182407166709, 4543.204939135655, 4570.702904311226, 4580.702254353473, 619.6073688373777, 4441.467023957113, 4453.755043472608, 4566.0, 4594.448666160066, 4019.9397009044887, 4460.219461594241, 4493.168763778712, 4495.2133376659285, 4512.210363186462, 4847.975760121177, 4852.150873597142, 4852.927206091911, 4863.440704319013, 4903.63222758291, 5103.387593488768, 5223.242629818655, 5240.528352448298, 5244.108501554745, 5254.238135470374, 5248.029114613809, 5338.145896656516, 5400.378956420022, 5409.540189083933, 5432.483914028161, 4999.500049995007, 5022.547970682656, 5023.196288593807, 5025.170846810235, 5072.898542029138, 5485.149801780731, 5488.643238189505, 5490.423505531861, 5500.944990550123, 5504.532114770209, 5088.516590923857, 5146.614003949719, 5148.459411761711, 5149.356330458692, 5151.4333423323405, 5151.562117220078, 5190.2214667800135, 5196.350456192976, 5213.661112027706, 5323.733813309319, 5270.341207349082, 5271.499207575274, 5281.366236051698, 5289.603279754034, 5338.679679219259, 5217.060929032735, 5243.711595862264, 5264.15773476242, 5268.683878967274, 5300.92048619271, 4346.891327716832, 4401.801918913657, 4403.757793321398, 4439.578240067189, 4448.266036104072, 3841.7310788245113, 3879.282332768447, 3905.37513997759, 3906.882793516199, 3915.451836742858, 4556.612687921497, 4564.109998550317, 4567.2007398705755, 4573.862784116482, 4580.290055041407, 5364.9731751341, 5368.677879327252, 5369.865753356197, 5370.865728356823, 5410.404855465896, 4383.517813040563, 4495.662825288116, 4538.160440318552, 4584.037352156084, 4590.380298659638, 4787.760611969387, 4797.0, 4797.232442809134, 4812.614990800727, 4813.03739252151, 4997.700137991732, 5014.2979982802435, 5016.272640467185, 5022.949770502394, 5069.467705890828, 5175.378954525481, 5241.397239317374, 5242.318498595311, 5244.711540865289, 5326.0, 4877.780499877443, 4896.730679812645, 4927.408710954565, 4929.0, 4929.2359684248995, 5170.482951704799, 5271.894562108813, 5317.760700768397, 5322.414534401135, 5332.386775520865, 5365.785368585213, 5374.7581358839725, 5379.273798037215, 5382.381026181883, 5384.9192262116885, 5160.200168973815, 5163.173892177234, 5228.869278268074, 5229.869253268699, 5279.788808447619, 4995.800167993385, 5058.696478211319, 5154.587632989277, 5202.3497062867145, 5216.843494695166, 5138.8715282116755, 5142.434332223527, 5142.742862856768, 5153.098207813692, 5160.561352285098, 5181.5595674368105, 5209.921851172159, 5226.712530810842, 5228.37259528859, 5280.841574752763, 4916.82791102324, 4972.105021096238, 5080.644354895122, 5088.5674717647935, 5131.409887862944], "value": 4816.803708151212, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.74177200006, 698.2214830464033, 723.7466886589692, 778.544551437409, 787.7361084036847, 25584.616230756532, 30976.380472390567, 31103.222419439524, 31201.0, 31319.530207046857, 34984.30031399377, 35269.11827204321, 35274.64725352746, 35332.64667353326, 35401.46897796528, 6541.836454088639, 7228.204897461275, 7397.075365579302, 7410.147832999221, 7415.443841711866, 6705.865882682368, 8721.60752766124, 8884.955575222115, 8892.110788921122, 8894.688685895995, 9102.0, 9209.125133112344, 9214.815703685923, 9227.031161728022, 9235.353525253235, 9152.130547597968, 9155.67955121571, 9209.493477858716, 9229.953850230773, 9236.399634023766, 9043.457392556467, 9089.772755681095, 9101.135392137736, 9108.635654573874, 9108.8633670495, 33629.66370336314, 33866.0, 33916.321673566636, 33972.83013584916, 33987.83006084978, 3446.9827650861835, 3484.285721427101, 3493.63316851732, 3532.205253817896, 3563.625819288989, 23412.414689632726, 23768.762312377, 23874.0, 23916.0, 24032.759672403226, 2940.1032685031055, 2968.807027543203, 3007.8646460909313, 3134.059782065371, 3135.5923729914966, 148145.25927370295, 148414.0, 148589.0, 148891.25554372268, 148962.0, 42289.57710422918, 42501.0, 42524.25922500485, 42586.361204581954, 42650.0, 44003.559964399945, 44319.77840110779, 44430.0, 44430.55569444264, 44473.77763111164, 13053.086283960032, 13370.064095513415, 13401.128926619738, 13418.0, 13424.463021479227, 8559.272461840814, 8700.390972631854, 10907.454627268606, 10917.39954302521, 10939.945300273448, 11362.602308919313, 11387.772244555063, 11512.251703639404, 11569.88430115705, 11600.941995290139, 4805.951940480551, 4833.927491087637, 4875.488073752205, 4970.975145124251, 4979.178435558165, 886.0696268917611, 895.7626229049307, 900.7207765592688, 901.7114523352465, 920.3695468604028, 20157.899210504147, 21836.23573174963, 21920.45198870009, 21942.670859937112, 22177.006104176053, 950.2255661635745, 950.296780382512, 954.5275088830934, 959.7168835193635, 974.5370948799264, 11408.600698975662, 11777.470013849397, 11883.70290742721, 11885.524579016743, 11942.104342174373, 206946.0, 207633.0, 207801.0, 207839.0, 207935.0, 39570.60429395669, 39658.0, 39664.60335396667, 39741.801290993935, 39855.80072099621, 1211.1037832004254, 1246.7506498700295, 1248.3009514671812, 1252.311228824143, 1261.9369031548385, 19613.41159765209, 19928.90035549813, 20618.896905515376, 20778.06498707592, 20950.790492094882, 30117.548236776027, 30145.246368840955, 30199.0, 30234.24414389658, 30250.0, 195656.0, 195794.0, 196108.0, 196255.0, 196259.46756655417, 26836.463270734086, 27247.86376068107, 27283.72716272812, 27340.316492087855, 27452.588211177248, 27471.0, 28004.719952800213, 28047.43905121927, 32367.190820229684, 32893.835530822194, 27067.0, 27909.860450697615, 28273.293167670974, 30503.389932201677, 32115.67884321127, 28644.43262428969, 28983.710162898944, 29415.0, 29870.402591948474, 30083.699163008965, 30294.242643934078, 30910.69089309078, 30988.69011309858, 31049.379012419173, 31158.844205778827, 24655.753442465346, 25776.226713198634, 27200.727992719818, 27436.17691469259, 27478.607958089062, 21606.243781467572, 21990.340289791333, 22025.0, 22043.559128817655, 22156.446088847908], "value": 15004.457851277295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.87620775663413, 407.2262700868351, 407.5801924018262, 418.1782796804279, 419.5175548119662, 11544.422778861066, 18024.909875450605, 18284.542886427847, 19054.42836714899, 19060.23759049638, 16721.0, 16993.150342482888, 17752.28990840368, 18575.0, 18737.718934215998, 5642.830715078534, 5793.246877905887, 5801.564882633819, 5837.737301821428, 5857.033589457735, 5587.972060139694, 5797.420257974211, 5807.5934684571885, 5808.4481974212595, 5816.098504731774, 5790.971045144768, 6365.777197798078, 6626.403623673868, 6650.268470468244, 6662.533622646417, 6467.967660161716, 6605.108310378109, 6639.900401493957, 6645.8338541536605, 6699.430548403391, 6555.868882622369, 6558.508111891627, 6563.474922006228, 6564.967175164142, 6565.310642382528, 20634.896825515778, 21843.781562184493, 22446.551068978693, 22491.21280755182, 22692.546149076927, 2362.090595120874, 2397.30478161333, 2433.707955045388, 2464.9507009859703, 2478.3804048987754, 14273.572642735748, 14285.0, 14372.0, 14419.495317663832, 14905.254737263202, 1868.2340240501464, 1927.8457723382237, 1935.8257756801816, 1958.3145898935402, 1958.6670266054805, 89452.55273723655, 91694.0, 93467.99999999932, 93698.5315073427, 93996.53001735016, 16067.517974460785, 16114.516564502848, 16221.675566488604, 16283.59291017734, 16394.508164755076, 21730.78269217319, 27900.30249243785, 28011.579826302623, 28121.57817632737, 28276.293092672848, 7329.52358096722, 8714.69498567547, 8717.825643487095, 9063.13900179482, 9138.451692898447, 7255.746048888263, 7298.416126709851, 7377.77866664001, 7484.962575187089, 7501.774946751606, 8198.672053117927, 8354.958225208835, 8498.957505212558, 8635.611397487128, 9091.499967501719, 3299.2081900343746, 3308.966910330866, 3353.916152096217, 3414.5390372299917, 3768.2840260350445, 772.97681069568, 789.6328207383594, 799.5442597719244, 806.6652339279134, 820.8399362124447, 18105.275788968294, 18425.355112570996, 19424.0, 19438.902805486166, 19684.212631494865, 794.1899262752077, 802.1857814318471, 817.1624085312484, 819.2299238715589, 822.198356602308, 9806.762319651527, 9922.801543969224, 10048.346857454242, 10625.681229563126, 10626.46867656614, 239513.0, 246592.0, 461003.0, 467689.0, 470997.0, 90263.0, 91806.0, 92076.53961730149, 95458.0, 95754.0, 1127.1884243344778, 1132.4790596325618, 1170.8594968603823, 1173.6831055614937, 1175.3183153770792, 16319.83680163183, 16626.418075367303, 16653.167341632627, 17701.911490442464, 18022.459326220236, 31421.371572568878, 32904.177395565304, 36298.0, 37158.07104822401, 43936.34095488506, 47306.763466183824, 48911.5108848907, 48921.75539122424, 55011.44988550063, 57095.429045710676, 10037.247206459399, 10434.895651043393, 10453.216008799218, 10867.13062954946, 10987.340759554452, 11456.255343402652, 11602.129840261845, 11861.466234019317, 11956.76086478283, 12212.450439730412, 10784.0, 11194.384308863091, 11210.775784484102, 11233.38216398106, 11613.59352422695, 11071.280366776135, 11098.667039988813, 11115.555377784798, 11155.0, 11178.0, 11102.555897764321, 11179.161562882979, 11259.49332280033, 11310.83033754478, 11582.420878956187, 11089.611863584736, 11111.944440277746, 11245.606403775828, 11276.436178191221, 11576.305421674726, 9820.214382849212, 9982.500874956368, 10130.315466401262, 10450.68647940563, 11028.669139925814], "value": 9769.979890445857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.83476400214, 1444.7327244459775, 1459.9343029563668, 1461.2839708542813, 1520.0575643101276, 8674.479531228122, 9016.99999999999, 9023.458592484456, 9023.548822558878, 9032.367734258605, 8913.777155571113, 9006.369554131214, 9360.157585817275, 9362.297827662918, 9374.671886483975, 2030.9999999999964, 2069.213698794456, 2071.264701031135, 2071.347525529461, 2072.450800537859, 1970.330087770158, 1988.721578978944, 1996.17158879065, 2002.8597998140135, 2010.497375656086, 1957.4519134642323, 1960.362882063335, 1972.1914015253749, 1976.6837306031039, 1984.7717512486033, 1930.6717857964109, 1934.6324198402258, 1935.400025991947, 1938.9709154362695, 1938.9723446573198, 1904.523869032742, 1933.8162874526897, 1977.2684106880547, 1996.2015193922548, 2001.1095062697107, 9374.29692773038, 9442.858357124649, 9445.905540944572, 9455.432674039579, 9464.432134071978, 4677.789499472532, 4854.732989685566, 4857.73282469464, 4861.173600487926, 4865.610751139936, 2540.3649087728068, 2661.095227622598, 2705.0397109026408, 2714.294283486288, 2764.654418197725, 914.2229105260542, 976.2287792643803, 1002.2533212756471, 1034.017683200962, 1038.2576457832686, 11815.409229538574, 12151.392430378446, 12846.486140554367, 12887.097903146783, 12964.0, 3842.7502212356667, 3925.097227637659, 4039.6566291864933, 4060.451839001756, 4061.289274376972, 9899.455529945923, 10014.54934527948, 10027.448490333101, 10028.247881408923, 10040.246981476419, 4708.81164753406, 4713.128071306819, 4719.457262414798, 4721.079389519011, 4744.169770290255, 4315.09383029561, 4319.762413067248, 4355.433793606874, 4381.671374646914, 4381.780910954503, 3138.5135304027913, 3205.2627895584146, 3224.8387580620874, 3225.935481290408, 3279.1638132276116, 806.4395245304457, 806.6571707024608, 825.1748251748252, 829.2785276809215, 843.35904712419, 747.4170147285126, 753.9208383119693, 768.239442951474, 776.8912352270687, 783.7570353190529, 5453.590980676465, 5462.672239665632, 5514.28314319144, 5604.187392828017, 5663.065594176915, 861.5089399042486, 862.8015556422058, 866.8006358537572, 868.6959564152496, 873.1530415496958, 3475.58293004841, 3504.5093686883856, 3515.4199557072798, 3539.592946811098, 3598.7300952428673, 11623.65129046113, 12077.577284795167, 12115.273083614835, 12130.5147794089, 12143.089268304913, 11791.88208117925, 11909.940450297692, 12013.399330033464, 12019.0, 12033.217840840318, 8567.614457349435, 8680.262177714838, 8694.391392602583, 8698.565071746387, 8700.390972631982, 4298.290782021057, 5326.0, 5341.679499230058, 5359.624826262124, 5442.809501667422, 9190.35667503295, 9192.080791921022, 9258.814823703353, 9261.212796912068, 9345.953270233877, 9741.464219467998, 9810.411375317504, 9905.950470247602, 10048.949755251177, 10053.346532475365, 6834.658267086726, 6938.479614028867, 6943.895841562279, 6945.687444064928, 6948.5483443576, 8144.511329320259, 8409.95795021021, 8456.027556830797, 8469.491830490191, 8470.322374209925, 7432.925670743223, 7632.771016869503, 7639.427042971688, 7699.499532530368, 7827.295543401121, 7347.889781653386, 7359.043324367798, 7450.515716478411, 7483.625818709152, 7491.587962662106, 5768.307803063659, 5773.0, 5777.480026797609, 5780.161876527964, 5844.853878652898, 4841.612670986383, 4915.926261106158, 4921.803127874845, 4934.580560652241, 4949.6287778416045, 4745.359376484269, 4746.0745154694505, 4844.539768721966, 4863.148948933993, 4936.160852654985], "value": 4251.1713376501975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.64771699875615, 361.39285999520797, 364.9799261040642, 380.6402949212993, 382.3519135066063, 5235.50262725041, 5309.123994540906, 5315.3887302960175, 5323.574114070875, 5334.946650533493, 4980.32765576647, 5181.507756763111, 5185.481451854813, 5193.974030129853, 5221.112410890149, 4319.827206911736, 4341.696081274312, 4343.739375637456, 4350.390945267665, 4359.585839345273, 4335.761533115678, 4340.587644173815, 4341.110072435144, 4366.148601022802, 4405.7356558606425, 4244.214820258247, 4264.42430271914, 4326.84856030039, 4330.090680957002, 4355.216061108999, 4292.549282325342, 4294.957050429518, 4298.806553705075, 4308.526062133163, 4339.891502712458, 3983.541892682321, 3991.820368083443, 4001.099752555681, 4016.4176194451934, 4036.9596304037173, 4871.196252618349, 5084.79660813567, 5106.361704786902, 5112.0, 5143.974280128613, 5025.497450254982, 5029.849104526834, 5035.320231768701, 5038.269450929632, 5048.0, 5527.39198688148, 5543.8891222175735, 5547.583931205136, 5555.611107222496, 5588.916166257469, 4284.357346398066, 4416.602505774464, 4424.889377765549, 4430.0, 4449.510553839107, 5433.673979561239, 5578.330600327987, 5620.747066382022, 5771.105478650816, 5838.64968101911, 4543.477500087466, 4548.067646132535, 4563.543645635476, 4564.246899261585, 4571.519990401027, 4336.176126535948, 4447.466304043471, 4467.7319360838455, 4620.884477888079, 4641.373414589055, 4961.305417241589, 4978.278149668277, 5000.424951130593, 5000.449860543244, 5007.499250074963, 5526.447355264441, 5528.9723551381985, 5534.169874518854, 5538.6122971391615, 5540.864122854805, 1577.6765763018784, 1597.297189236732, 1603.5670369000304, 1610.7664388663577, 1617.7219996202869, 1165.0330225912471, 1192.3382522699985, 1208.697825543614, 1212.2665787198794, 1214.6295379909213, 4772.331873537708, 4781.115493633689, 4791.329213910055, 4802.423709154924, 4809.158397280462, 5663.1505274208375, 5664.0, 5664.801731939362, 5700.743466544015, 5717.885642287131, 4628.0, 4767.880802979884, 4785.138675038526, 4787.42550893888, 4794.376731024944, 3006.3085490337344, 3011.7200189919195, 3019.5923550320863, 3024.2137044368183, 3040.4071206114595, 5284.735763211901, 5293.153095504777, 5310.0, 5310.973445132827, 5320.893582128336, 5515.917261241085, 5805.69371891321, 5835.124731290341, 5873.295204575478, 5880.911786323209, 5333.919991200135, 5337.919931201035, 5348.384935732441, 5348.893022139536, 5375.247465354853, 5471.398146203994, 5652.491275785199, 5673.801416950552, 5690.658560486384, 5704.458076482728, 5612.130119831432, 5650.23721797552, 5658.0, 5680.6875621839545, 5706.942930570641, 5305.65513241638, 5321.3348331458565, 5326.520613144836, 5330.173823057432, 5366.704831234163, 4433.955660443355, 4527.0, 4546.61353784932, 4555.316702494652, 4574.702644328108, 5674.773009079756, 5687.7724891005555, 5701.971490142523, 5714.314282285986, 5723.627964182315, 5519.199716041232, 5537.701853730657, 5542.695151766691, 5549.0, 5552.972235138798, 5229.477052294892, 5482.2873026506295, 5488.259085023471, 5512.3660779010925, 5527.695976721319, 5424.294841670558, 5449.858107837992, 5475.0, 5480.862978425571, 5490.693908558335, 5432.59255555827, 5588.329400471969, 5592.665684094696, 5603.80386686464, 5606.495415412633, 5345.518903298722, 5374.307093265609, 5391.487808658171, 5398.865028374322, 5433.7774000849495], "value": 4320.660324728092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4273010226765, 723.5369363607292, 746.1568427676724, 752.9759527043224, 761.136110514566, 13232.338383080843, 13671.248081355521, 13686.178829270251, 13713.588592342234, 13716.862831371684, 12506.062045346613, 12596.622101336974, 12602.117851750358, 12617.747645047093, 12620.68448288791, 836.6402446947825, 850.5449584472309, 851.7231899632613, 854.0520022774715, 855.9443636163661, 848.4697064334791, 848.6138806842903, 848.7326492154982, 849.4266370200121, 852.2755657690975, 880.9427387219843, 881.7310720230328, 881.9162179592928, 883.0992387764477, 890.185480285538, 864.9654013839407, 882.7881308485981, 887.2591386192537, 887.3389324952886, 888.3603805260202, 653.5588477777528, 656.8817612829689, 657.1096164696862, 659.261626977788, 659.6009414304373, 12411.255324680547, 12466.314352710597, 13784.517541885985, 13878.097923634932, 13883.37524811386, 12320.568780092653, 12524.686882827911, 13614.978876584197, 13627.863721362857, 13981.510647127301, 9504.334696571243, 10038.247131465168, 10263.589456421734, 10269.486525673761, 10278.640247591298, 3309.338132373535, 3323.1525960880062, 3351.3632409842053, 3356.194513316811, 3467.7225821934185, 59677.0, 59907.70046149785, 60357.0, 60359.69820150871, 60400.69799651018, 9990.900090999143, 10384.844227336596, 10402.635907743193, 10441.477926103664, 10924.563017479211, 19588.118534665973, 19775.901120494305, 19784.505387365432, 19822.801771982096, 19832.305869294505, 6253.7185826637915, 6333.986562150126, 6349.772939100034, 6577.14497115372, 6592.80221593353, 3636.290923269937, 3666.211764470652, 3705.0922523981258, 3769.6795772359656, 3838.9424158637644, 2730.440259746747, 2767.5433553463854, 2807.5086859799453, 2807.620971168907, 2809.522381195202, 432.84481821505716, 440.6849102891448, 444.5754304639062, 445.1319926144032, 445.5900571474187, 642.6369101457661, 657.135866335767, 660.5013215022627, 668.4585485756553, 689.5207830557714, 8788.560571971504, 8939.329550283755, 9094.636214551476, 9183.16336732656, 9298.0, 489.13911515731854, 517.8710411303394, 531.8271561742372, 556.3296228045195, 667.4693618573245, 3828.9234215315537, 4143.875683729493, 4326.372675961968, 4353.717008394444, 4381.9123617527475, 55738.16392754112, 56556.15165772517, 57470.42529574734, 57567.13649295264, 57651.0, 39627.009324766535, 48638.270425943636, 51272.0, 51798.48201518012, 52788.472115279124, 46066.539334606896, 46564.76717616458, 46575.0, 47490.76254618843, 48383.75808121007, 7971.72098976533, 8159.46963447374, 8166.387664979391, 8190.1400352964465, 8422.494650321001, 30901.69098308988, 31247.687523125387, 31414.371712566077, 31755.0, 32269.0, 36224.27551449009, 37223.25553488969, 39758.60241397549, 40555.79722101371, 42701.35947960721, 11670.649880503599, 12149.757004859677, 12391.75216495683, 12447.751044979232, 12826.743465130832, 12376.81434778497, 12466.937665311978, 12686.619401417973, 13238.270927855534, 13357.265350405822, 12001.0, 12085.15403921717, 12162.513499460276, 12630.684232894251, 12863.099583029098, 11442.053661268645, 12001.279923204636, 12191.451384687887, 12205.572804951784, 12318.384080796104, 11578.4771170457, 11723.765524689628, 12291.938540307241, 12321.691957701129, 12400.56598019065, 9784.559694813894, 9941.25440591944, 10195.184385249015, 10669.306495077795, 10776.730581735519, 9493.905060949302, 10257.74355641115, 10336.586536538754, 10338.328008679411, 10338.586456541954], "value": 6288.591960595539, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 120.0, 122.0, 119.0, 119.0, 118.0, 120.0, 122.0, 120.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 123.0, 165.0, 125.0, 126.0, 124.0, 124.0, 142.0, 126.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 163.0, 163.0, 162.0, 164.0, 159.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 110.0, 76.0, 77.0, 76.0, 76.0, 90.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 85.0, 84.0, 84.0, 106.0, 85.0, 84.0, 106.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 81.0, 81.0, 80.0, 82.0, 82.0, 81.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 136.0, 132.0, 137.0, 133.0, 133.0, 133.0, 186.0, 139.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 195.0, 192.0, 201.0, 194.0, 198.0, 193.0, 192.0, 190.0, 190.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 70.0, 73.0, 71.0, 74.0, 70.0, 72.0, 70.0], "value": 71.5, "unit": "score"}]}]} 07:17:57 INFO - Return code: 0 07:17:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:17:57 ERROR - # TBPL SUCCESS # 07:17:57 INFO - Running post-action listener: _resource_record_post_action 07:17:57 INFO - [mozharness: 2017-03-17 14:17:57.168379Z] Finished run-tests step (success) 07:17:57 INFO - Running post-run listener: _resource_record_post_run 07:17:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359501824; Read time: 20; Write time: 283960 07:17:57 INFO - TinderboxPrint: CPU usage
13.0% 07:17:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:17:57 INFO - TinderboxPrint: I/O write bytes / time
359,501,824 / 283,960 07:17:57 INFO - TinderboxPrint: CPU idle
8,364.1 (87.0%) 07:17:57 INFO - TinderboxPrint: CPU user
1,198.9 (12.5%) 07:17:57 INFO - TinderboxPrint: Swap in / out
0 / 0 07:17:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105959424; Read time: 0; Write time: 129816 07:17:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 253542400; Read time: 0; Write time: 154144 07:17:57 INFO - Running post-run listener: _upload_blobber_files 07:17:57 INFO - Blob upload gear active. 07:17:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:17:57 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 07:17:57 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:17:57 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:17:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:59 INFO - (blobuploader) - INFO - Done attempting. 07:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:00 INFO - (blobuploader) - INFO - Done attempting. 07:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:03 INFO - (blobuploader) - INFO - Done attempting. 07:18:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:04 INFO - (blobuploader) - INFO - Done attempting. 07:18:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:04 INFO - Return code: 0 07:18:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6fe4c9acca15eec1659cf1fb39307603ca21df620adf7e06189485548f113bf2ad5390fb790cd6d6fa083ec48d56b01cd0e6b0a7560f3cf1b1aa03377f9243d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c854c56e8f7fde5e164db966c01b6ad153eb0c76a98c85f71db28aa80ababbb2cf1bf20f210f7284fdb8d9619233c229432df60ac95cffa018537118b3d783be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9207edec37e2586e29ba25efa6bcf48a1fb0bf71677df11dfeeb4e2a1176fe3a91f170ca05a648094ef07f602a3ab7987aed7474e0a04a588bb8fc498599eb4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67f00505c8a08a73f4916979bd2e85fa998daa0c23b2a349ab57dedcf2a01edaa265b19412f537d1940ef4b9c467c46ce9586cade5ad7f2311353a7cd079f510"} 07:18:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:04 INFO - Contents: 07:18:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6fe4c9acca15eec1659cf1fb39307603ca21df620adf7e06189485548f113bf2ad5390fb790cd6d6fa083ec48d56b01cd0e6b0a7560f3cf1b1aa03377f9243d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c854c56e8f7fde5e164db966c01b6ad153eb0c76a98c85f71db28aa80ababbb2cf1bf20f210f7284fdb8d9619233c229432df60ac95cffa018537118b3d783be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9207edec37e2586e29ba25efa6bcf48a1fb0bf71677df11dfeeb4e2a1176fe3a91f170ca05a648094ef07f602a3ab7987aed7474e0a04a588bb8fc498599eb4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67f00505c8a08a73f4916979bd2e85fa998daa0c23b2a349ab57dedcf2a01edaa265b19412f537d1940ef4b9c467c46ce9586cade5ad7f2311353a7cd079f510"} 07:18:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:04 INFO - Copying logs to upload dir... 07:18:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.901884 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-17 07:18:04.478099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 07:18:04.481781) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6fe4c9acca15eec1659cf1fb39307603ca21df620adf7e06189485548f113bf2ad5390fb790cd6d6fa083ec48d56b01cd0e6b0a7560f3cf1b1aa03377f9243d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c854c56e8f7fde5e164db966c01b6ad153eb0c76a98c85f71db28aa80ababbb2cf1bf20f210f7284fdb8d9619233c229432df60ac95cffa018537118b3d783be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9207edec37e2586e29ba25efa6bcf48a1fb0bf71677df11dfeeb4e2a1176fe3a91f170ca05a648094ef07f602a3ab7987aed7474e0a04a588bb8fc498599eb4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67f00505c8a08a73f4916979bd2e85fa998daa0c23b2a349ab57dedcf2a01edaa265b19412f537d1940ef4b9c467c46ce9586cade5ad7f2311353a7cd079f510"} build_url:https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/Q8PywIQ9RZ6kiSJewt7OIg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6fe4c9acca15eec1659cf1fb39307603ca21df620adf7e06189485548f113bf2ad5390fb790cd6d6fa083ec48d56b01cd0e6b0a7560f3cf1b1aa03377f9243d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c854c56e8f7fde5e164db966c01b6ad153eb0c76a98c85f71db28aa80ababbb2cf1bf20f210f7284fdb8d9619233c229432df60ac95cffa018537118b3d783be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9207edec37e2586e29ba25efa6bcf48a1fb0bf71677df11dfeeb4e2a1176fe3a91f170ca05a648094ef07f602a3ab7987aed7474e0a04a588bb8fc498599eb4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67f00505c8a08a73f4916979bd2e85fa998daa0c23b2a349ab57dedcf2a01edaa265b19412f537d1940ef4b9c467c46ce9586cade5ad7f2311353a7cd079f510"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 07:18:04.506920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:18:04.507249) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489759019.958894-1276706515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 07:18:04.590415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 07:18:04.590745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 07:18:04.591104) ========= ========= Total master_lag: 0.15 =========