builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1488461550.45 results: success (0) revision: 180a160ae22a4d63867cfd02608e7621e8e697d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.454393) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.454940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.455236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.480300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.480688) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-02 05:32:32-- 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% 86.5M=0s 2017-03-02 05:32:32 (86.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.603243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.603549) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.653364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:30.653710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 180a160ae22a4d63867cfd02608e7621e8e697d1 --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 180a160ae22a4d63867cfd02608e7621e8e697d1 --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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-02 05:32:32,725 truncating revision to first 12 chars 2017-03-02 05:32:32,725 Setting DEBUG logging. 2017-03-02 05:32:32,725 attempt 1/10 2017-03-02 05:32:32,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/180a160ae22a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 05:32:33,013 unpacking tar archive at: mozilla-central-180a160ae22a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:31.200848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:31.201219) ========= script_repo_revision: 180a160ae22a4d63867cfd02608e7621e8e697d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:31.201606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:31.201879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 05:32:31.210231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-03-02 05:32:31.210619) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:33 INFO - MultiFileLogger online at 20170302 05:32:33 in /builds/slave/test 05:32:33 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 05:32:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:33 INFO - {'append_to_log': False, 05:32:33 INFO - 'base_work_dir': '/builds/slave/test', 05:32:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:32:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:33 INFO - 'branch': 'Firefox-Non-PGO', 05:32:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:33 INFO - 'config_files': ('talos/linux_config.py',), 05:32:33 INFO - 'default_actions': ('clobber', 05:32:33 INFO - 'read-buildbot-config', 05:32:33 INFO - 'download-and-extract', 05:32:33 INFO - 'populate-webroot', 05:32:33 INFO - 'create-virtualenv', 05:32:33 INFO - 'install', 05:32:33 INFO - 'run-tests'), 05:32:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:33 INFO - 'download_minidump_stackwalk': True, 05:32:33 INFO - 'download_symbols': 'ondemand', 05:32:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:33 INFO - 'gecko_profile': False, 05:32:33 INFO - 'gecko_profile_interval': 0, 05:32:33 INFO - 'installer_path': 'installer.exe', 05:32:33 INFO - 'log_level': 'info', 05:32:33 INFO - 'log_name': 'talos', 05:32:33 INFO - 'log_to_console': True, 05:32:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:33 INFO - 'opt_config_files': (), 05:32:33 INFO - 'pip_index': False, 05:32:33 INFO - 'suite': 'dromaeojs', 05:32:33 INFO - 'system_bits': '32', 05:32:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:33 INFO - 'title': 'talos-linux64-ix-064', 05:32:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:33 INFO - 'use_talos_json': True, 05:32:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:33 INFO - 'work_dir': 'build'} 05:32:33 INFO - [mozharness: 2017-03-02 13:32:33.386247Z] Running clobber step. 05:32:33 INFO - Running pre-action listener: _resource_record_pre_action 05:32:33 INFO - Running main action method: clobber 05:32:33 INFO - rmtree: /builds/slave/test/build 05:32:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:34 INFO - Running post-action listener: _resource_record_post_action 05:32:34 INFO - [mozharness: 2017-03-02 13:32:34.308706Z] Finished clobber step (success) 05:32:34 INFO - [mozharness: 2017-03-02 13:32:34.308806Z] Running read-buildbot-config step. 05:32:34 INFO - Running pre-action listener: _resource_record_pre_action 05:32:34 INFO - Running main action method: read_buildbot_config 05:32:34 INFO - Using buildbot properties: 05:32:34 INFO - { 05:32:34 INFO - "project": "", 05:32:34 INFO - "product": "firefox", 05:32:34 INFO - "who": "cbook@mozilla.com", 05:32:34 INFO - "installer_path": "public/build/target.tar.bz2", 05:32:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:32:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:32:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:32:34 INFO - "stage_platform": "linux64", 05:32:34 INFO - "basedir": "/builds/slave/test", 05:32:34 INFO - "buildnumber": 851, 05:32:34 INFO - "platform": "ubuntu64_hw", 05:32:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:32:34 INFO - "slavebuilddir": "test", 05:32:34 INFO - "taskId": "bk-aYNmVRymgJ4C-majtJA", 05:32:34 INFO - "branch": "mozilla-central", 05:32:34 INFO - "script_repo_revision": "production", 05:32:34 INFO - "revision": "180a160ae22a4d63867cfd02608e7621e8e697d1", 05:32:34 INFO - "slavename": "talos-linux64-ix-064", 05:32:34 INFO - "repo_path": "mozilla-central" 05:32:34 INFO - } 05:32:34 INFO - Finding installer, test and symbols from parent task. 05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bk-aYNmVRymgJ4C-majtJA'}, attempt #1 05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bk-aYNmVRymgJ4C-majtJA'}, attempt #1 05:32:35 INFO - Task dependencies: M9KVlWcUQ0KxQdxlqY4exQ 05:32:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ'}, attempt #1 05:32:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 05:32:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/test_packages.json 05:32:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.crashreporter-symbols.zip 05:32:35 INFO - Running post-action listener: _resource_record_post_action 05:32:35 INFO - [mozharness: 2017-03-02 13:32:35.691691Z] Finished read-buildbot-config step (success) 05:32:35 INFO - [mozharness: 2017-03-02 13:32:35.691908Z] Running download-and-extract step. 05:32:35 INFO - Running pre-action listener: _resource_record_pre_action 05:32:35 INFO - Running main action method: download_and_extract 05:32:35 INFO - mkdir: /builds/slave/test/build/tests 05:32: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')]} 05:32:35 INFO - trying https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.test_packages.json 05:32:35 INFO - Downloading https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:32:36 INFO - Downloaded 896 bytes. 05:32:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:32:36 INFO - Using the following test package requirements: 05:32:36 INFO - {u'common': [u'target.common.tests.zip'], 05:32:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:32:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:32:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:32:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:32:36 INFO - u'mozbase': [u'target.common.tests.zip'], 05:32:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:32:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:32:36 INFO - u'web-platform': [u'target.common.tests.zip', 05:32:36 INFO - u'target.web-platform.tests.zip'], 05:32:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:32:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:32:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip 05:32:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:36 INFO - Fetch https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip into memory 05:32:38 INFO - Expected file size: 57479337 05:32:38 INFO - Obtained file size: 57479337 05:32:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip 05:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.common.tests.zip into memory 05:32:48 INFO - Expected file size: 57479337 05:32:48 INFO - Obtained file size: 57479337 05:32:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.talos.tests.zip 05:32:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:32:59 INFO - Fetch https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.talos.tests.zip into memory 05:33:01 INFO - Expected file size: 14404424 05:33:01 INFO - Obtained file size: 14404424 05:33:01 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')]} 05:33:01 INFO - trying https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 05:33:01 INFO - Downloading https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:33:03 INFO - Downloaded 61667836 bytes. 05:33:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 05:33:03 INFO - mkdir: /builds/slave/test/properties 05:33:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:03 INFO - Contents: 05:33:03 INFO - build_url:https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 05:33:03 INFO - Running post-action listener: _resource_record_post_action 05:33:03 INFO - Running post-action listener: set_extra_try_arguments 05:33:03 INFO - [mozharness: 2017-03-02 13:33:03.274418Z] Finished download-and-extract step (success) 05:33:03 INFO - [mozharness: 2017-03-02 13:33:03.274517Z] Running populate-webroot step. 05:33:03 INFO - Running pre-action listener: _resource_record_pre_action 05:33:03 INFO - Running main action method: populate_webroot 05:33:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:03 INFO - '--tppagecycles', 05:33:03 INFO - '7'], 05:33:03 INFO - 'tests': ['tsvgm']}}, 05:33:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['damp', 'tps']}, 05:33:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'tests': ['damp', 'tps']}, 05:33:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['dromaeo_dom']}, 05:33:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['basic_compositor_video']}, 05:33:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:33:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['a11yr', 05:33:03 INFO - 'ts_paint', 05:33:03 INFO - 'tpaint', 05:33:03 INFO - 'sessionrestore', 05:33:03 INFO - 'sessionrestore_no_auto_restore', 05:33:03 INFO - 'tabpaint']}, 05:33:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['tsvgx', 05:33:03 INFO - 'tsvgr_opacity', 05:33:03 INFO - 'tart', 05:33:03 INFO - 'tscrollx', 05:33:03 INFO - 'cart', 05:33:03 INFO - 'tsvg_static']}, 05:33:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:03 INFO - 'tsvgr_opacity', 05:33:03 INFO - 'tart', 05:33:03 INFO - 'tscrollx', 05:33:03 INFO - 'cart', 05:33:03 INFO - 'tsvg_static']}, 05:33:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'talos_options': ['--disable-e10s'], 05:33:03 INFO - 'tests': ['tp5o']}, 05:33:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:33:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'talos_options': ['--disable-e10s', 05:33:03 INFO - '--xperf_path', 05:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:03 INFO - 'tests': ['tp5n']}, 05:33:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:33:03 INFO - 'talos_options': ['--xperf_path', 05:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:03 INFO - 'tests': ['tp5n']}}, 05:33:03 INFO - 'talos.zip': {'path': '', 05:33:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:03 INFO - Running post-action listener: _resource_record_post_action 05:33:03 INFO - [mozharness: 2017-03-02 13:33:03.287696Z] Finished populate-webroot step (success) 05:33:03 INFO - [mozharness: 2017-03-02 13:33:03.287789Z] Running create-virtualenv step. 05:33:03 INFO - Running pre-action listener: _resource_record_pre_action 05:33:03 INFO - Running main action method: create_virtualenv 05:33:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:03 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 05:33:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:03 INFO - Using real prefix '/usr' 05:33:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:05 INFO - Installing pip.................done. 05:33:05 INFO - Return code: 0 05:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:33:06 INFO - Reading from file tmpfile_stdout 05:33:06 INFO - Output received: 05:33:06 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) 05:33:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:06 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')]} 05:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:06 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')]} 05:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:06 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:06 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 05:33:06 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 05:33:06 INFO - Using env: {'DISPLAY': ':0', 05:33:06 INFO - 'HOME': '/home/cltbld', 05:33:06 INFO - 'LANG': 'en_US.UTF-8', 05:33:06 INFO - 'LANGUAGE': 'en_US:en', 05:33:06 INFO - 'LOGNAME': 'cltbld', 05:33:06 INFO - 'MAIL': '/var/mail/cltbld', 05:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:06 INFO - 'MOZ_NO_REMOTE': '1', 05:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:06 INFO - 'NO_EM_RESTART': '1', 05:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:06 INFO - 'PWD': '/builds/slave/test', 05:33:06 INFO - 'SHELL': '/bin/bash', 05:33:06 INFO - 'SHLVL': '1', 05:33:06 INFO - 'TERM': 'linux', 05:33:06 INFO - 'TMOUT': '86400', 05:33:06 INFO - 'USER': 'cltbld', 05:33:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:06 INFO - '_': '/tools/buildbot/bin/python'} 05:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:06 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 05:33:06 INFO - Cleaning up... 05:33:06 INFO - Return code: 0 05:33:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:06 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')]} 05:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:06 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')]} 05:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:06 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:06 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 05:33:06 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 05:33:06 INFO - Using env: {'DISPLAY': ':0', 05:33:06 INFO - 'HOME': '/home/cltbld', 05:33:06 INFO - 'LANG': 'en_US.UTF-8', 05:33:06 INFO - 'LANGUAGE': 'en_US:en', 05:33:06 INFO - 'LOGNAME': 'cltbld', 05:33:06 INFO - 'MAIL': '/var/mail/cltbld', 05:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:06 INFO - 'MOZ_NO_REMOTE': '1', 05:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:06 INFO - 'NO_EM_RESTART': '1', 05:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:06 INFO - 'PWD': '/builds/slave/test', 05:33:06 INFO - 'SHELL': '/bin/bash', 05:33:06 INFO - 'SHLVL': '1', 05:33:06 INFO - 'TERM': 'linux', 05:33:06 INFO - 'TMOUT': '86400', 05:33:06 INFO - 'USER': 'cltbld', 05:33:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:06 INFO - '_': '/tools/buildbot/bin/python'} 05:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:06 INFO - Downloading/unpacking psutil>=3.1.1 05:33:06 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 05:33:06 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 05:33:06 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 05:33:06 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 05:33:06 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 05:33:06 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 05:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:08 INFO - Installing collected packages: psutil 05:33:08 INFO - Running setup.py install for psutil 05:33:08 INFO - building 'psutil._psutil_linux' extension 05:33:08 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 05:33:08 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 05:33:08 INFO - building 'psutil._psutil_posix' extension 05:33:08 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 05:33:09 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 05:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:09 INFO - Successfully installed psutil 05:33:09 INFO - Cleaning up... 05:33:09 INFO - Return code: 0 05:33:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:09 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')]} 05:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:09 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')]} 05:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:09 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:09 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 05:33:09 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 05:33:09 INFO - Using env: {'DISPLAY': ':0', 05:33:09 INFO - 'HOME': '/home/cltbld', 05:33:09 INFO - 'LANG': 'en_US.UTF-8', 05:33:09 INFO - 'LANGUAGE': 'en_US:en', 05:33:09 INFO - 'LOGNAME': 'cltbld', 05:33:09 INFO - 'MAIL': '/var/mail/cltbld', 05:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:09 INFO - 'MOZ_NO_REMOTE': '1', 05:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:09 INFO - 'NO_EM_RESTART': '1', 05:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:09 INFO - 'PWD': '/builds/slave/test', 05:33:09 INFO - 'SHELL': '/bin/bash', 05:33:09 INFO - 'SHLVL': '1', 05:33:09 INFO - 'TERM': 'linux', 05:33:09 INFO - 'TMOUT': '86400', 05:33:09 INFO - 'USER': 'cltbld', 05:33:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:09 INFO - '_': '/tools/buildbot/bin/python'} 05:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:09 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 05:33:09 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 05:33:09 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 05:33:09 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 05:33:09 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 05:33:09 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 05:33:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:11 INFO - Installing collected packages: mozsystemmonitor 05:33:11 INFO - Running setup.py install for mozsystemmonitor 05:33:11 INFO - Successfully installed mozsystemmonitor 05:33:11 INFO - Cleaning up... 05:33:11 INFO - Return code: 0 05:33:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:33:11 INFO - Using env: {'DISPLAY': ':0', 05:33:11 INFO - 'HOME': '/home/cltbld', 05:33:11 INFO - 'LANG': 'en_US.UTF-8', 05:33:11 INFO - 'LANGUAGE': 'en_US:en', 05:33:11 INFO - 'LOGNAME': 'cltbld', 05:33:11 INFO - 'MAIL': '/var/mail/cltbld', 05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:11 INFO - 'MOZ_NO_REMOTE': '1', 05:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:11 INFO - 'NO_EM_RESTART': '1', 05:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:11 INFO - 'PWD': '/builds/slave/test', 05:33:11 INFO - 'SHELL': '/bin/bash', 05:33:11 INFO - 'SHLVL': '1', 05:33:11 INFO - 'TERM': 'linux', 05:33:11 INFO - 'TMOUT': '86400', 05:33:11 INFO - 'USER': 'cltbld', 05:33:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:11 INFO - '_': '/tools/buildbot/bin/python'} 05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:14 INFO - warning: no files found matching '*.txt' 05:33:14 INFO - no previously-included directories found matching 'build' 05:33:14 INFO - no previously-included directories found matching 'dist' 05:33:14 INFO - no previously-included directories found matching '.git*' 05:33:14 INFO - Installing collected packages: jsonschema, functools32 05:33:14 INFO - Running setup.py install for functools32 05:33:14 INFO - warning: no files found matching '*.txt' 05:33:14 INFO - no previously-included directories found matching 'build' 05:33:14 INFO - no previously-included directories found matching 'dist' 05:33:14 INFO - no previously-included directories found matching '.git*' 05:33:14 INFO - Successfully installed jsonschema functools32 05:33:14 INFO - Cleaning up... 05:33:14 INFO - Return code: 0 05:33:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:33:14 INFO - Using env: {'DISPLAY': ':0', 05:33:14 INFO - 'HOME': '/home/cltbld', 05:33:14 INFO - 'LANG': 'en_US.UTF-8', 05:33:14 INFO - 'LANGUAGE': 'en_US:en', 05:33:14 INFO - 'LOGNAME': 'cltbld', 05:33:14 INFO - 'MAIL': '/var/mail/cltbld', 05:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:14 INFO - 'MOZ_NO_REMOTE': '1', 05:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:14 INFO - 'NO_EM_RESTART': '1', 05:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:14 INFO - 'PWD': '/builds/slave/test', 05:33:14 INFO - 'SHELL': '/bin/bash', 05:33:14 INFO - 'SHLVL': '1', 05:33:14 INFO - 'TERM': 'linux', 05:33:14 INFO - 'TMOUT': '86400', 05:33:14 INFO - 'USER': 'cltbld', 05:33:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:14 INFO - '_': '/tools/buildbot/bin/python'} 05:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:14 INFO - Cleaning up... 05:33:14 INFO - Return code: 0 05:33:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:33:14 INFO - Using env: {'DISPLAY': ':0', 05:33:14 INFO - 'HOME': '/home/cltbld', 05:33:14 INFO - 'LANG': 'en_US.UTF-8', 05:33:14 INFO - 'LANGUAGE': 'en_US:en', 05:33:14 INFO - 'LOGNAME': 'cltbld', 05:33:14 INFO - 'MAIL': '/var/mail/cltbld', 05:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:14 INFO - 'MOZ_NO_REMOTE': '1', 05:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:14 INFO - 'NO_EM_RESTART': '1', 05:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:14 INFO - 'PWD': '/builds/slave/test', 05:33:14 INFO - 'SHELL': '/bin/bash', 05:33:14 INFO - 'SHLVL': '1', 05:33:14 INFO - 'TERM': 'linux', 05:33:14 INFO - 'TMOUT': '86400', 05:33:14 INFO - 'USER': 'cltbld', 05:33:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:14 INFO - '_': '/tools/buildbot/bin/python'} 05:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 INFO - Downloading docopt-0.6.1.tar.gz 05:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:17 INFO - Running setup.py install for blobuploader 05:33:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:17 INFO - Running setup.py install for requests 05:33:18 INFO - Running setup.py install for docopt 05:33:18 INFO - Successfully installed blobuploader requests docopt 05:33:18 INFO - Cleaning up... 05:33:18 INFO - Return code: 0 05:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:18 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:18 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 05:33:18 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 05:33:18 INFO - Using env: {'DISPLAY': ':0', 05:33:18 INFO - 'HOME': '/home/cltbld', 05:33:18 INFO - 'LANG': 'en_US.UTF-8', 05:33:18 INFO - 'LANGUAGE': 'en_US:en', 05:33:18 INFO - 'LOGNAME': 'cltbld', 05:33:18 INFO - 'MAIL': '/var/mail/cltbld', 05:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:18 INFO - 'MOZ_NO_REMOTE': '1', 05:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:18 INFO - 'NO_EM_RESTART': '1', 05:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:18 INFO - 'PWD': '/builds/slave/test', 05:33:18 INFO - 'SHELL': '/bin/bash', 05:33:18 INFO - 'SHLVL': '1', 05:33:18 INFO - 'TERM': 'linux', 05:33:18 INFO - 'TMOUT': '86400', 05:33:18 INFO - 'USER': 'cltbld', 05:33:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:18 INFO - '_': '/tools/buildbot/bin/python'} 05:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:18 INFO - Running setup.py (path:/tmp/pip-9WEi7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:18 INFO - Running setup.py (path:/tmp/pip-WzZDJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:18 INFO - Running setup.py (path:/tmp/pip-taoDA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:18 INFO - Running setup.py (path:/tmp/pip-o6Hh1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:18 INFO - Running setup.py (path:/tmp/pip-suUwCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:18 INFO - Running setup.py (path:/tmp/pip-LURd_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:18 INFO - Running setup.py (path:/tmp/pip-gahWIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:18 INFO - Running setup.py (path:/tmp/pip-nIFc7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:18 INFO - Running setup.py (path:/tmp/pip-2KlhFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:19 INFO - Running setup.py (path:/tmp/pip-FhEszP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:19 INFO - Running setup.py (path:/tmp/pip-g2FJO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:19 INFO - Running setup.py (path:/tmp/pip-hzj9uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:19 INFO - Running setup.py (path:/tmp/pip-4vI1JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:19 INFO - Running setup.py (path:/tmp/pip-Mm70Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:19 INFO - Running setup.py (path:/tmp/pip-6ojF5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:19 INFO - Running setup.py (path:/tmp/pip-CnaHyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:19 INFO - Running setup.py (path:/tmp/pip-bZUjqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:19 INFO - Running setup.py install for manifestparser 05:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:19 INFO - Running setup.py install for mozcrash 05:33:19 INFO - Running setup.py install for mozdebug 05:33:19 INFO - Running setup.py install for mozdevice 05:33:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozfile 05:33:20 INFO - Running setup.py install for mozhttpd 05:33:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozinfo 05:33:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozInstall 05:33:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozleak 05:33:20 INFO - Running setup.py install for mozlog 05:33:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for moznetwork 05:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:20 INFO - Running setup.py install for mozprocess 05:33:20 INFO - Running setup.py install for mozprofile 05:33:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Running setup.py install for mozrunner 05:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Running setup.py install for mozscreenshot 05:33:21 INFO - Running setup.py install for moztest 05:33:21 INFO - Running setup.py install for mozversion 05:33:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:21 INFO - Cleaning up... 05:33:21 INFO - Return code: 0 05:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:21 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 05:33:21 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 05:33:21 INFO - Using env: {'DISPLAY': ':0', 05:33:21 INFO - 'HOME': '/home/cltbld', 05:33:21 INFO - 'LANG': 'en_US.UTF-8', 05:33:21 INFO - 'LANGUAGE': 'en_US:en', 05:33:21 INFO - 'LOGNAME': 'cltbld', 05:33:21 INFO - 'MAIL': '/var/mail/cltbld', 05:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:21 INFO - 'MOZ_NO_REMOTE': '1', 05:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:21 INFO - 'NO_EM_RESTART': '1', 05:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:21 INFO - 'PWD': '/builds/slave/test', 05:33:21 INFO - 'SHELL': '/bin/bash', 05:33:21 INFO - 'SHLVL': '1', 05:33:21 INFO - 'TERM': 'linux', 05:33:21 INFO - 'TMOUT': '86400', 05:33:21 INFO - 'USER': 'cltbld', 05:33:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:21 INFO - '_': '/tools/buildbot/bin/python'} 05:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:21 INFO - Running setup.py (path:/tmp/pip-ndV88L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:21 INFO - Running setup.py (path:/tmp/pip-jOzobq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:21 INFO - Running setup.py (path:/tmp/pip-UwvCW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:21 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)) 05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:21 INFO - Running setup.py (path:/tmp/pip-W5TA58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:22 INFO - Running setup.py (path:/tmp/pip-Vz1C93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:22 INFO - Running setup.py (path:/tmp/pip-gHofwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:22 INFO - Running setup.py (path:/tmp/pip-4aZoDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:22 INFO - Running setup.py (path:/tmp/pip-Tl8BSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:22 INFO - Running setup.py (path:/tmp/pip-Ry6p3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:22 INFO - Running setup.py (path:/tmp/pip-8mrZJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:22 INFO - Running setup.py (path:/tmp/pip-H9r3BW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:22 INFO - Running setup.py (path:/tmp/pip-f1GsFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:22 INFO - Running setup.py (path:/tmp/pip-qbWnpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:22 INFO - Running setup.py (path:/tmp/pip-Uub2Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:22 INFO - Running setup.py (path:/tmp/pip-md4Z3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:22 INFO - Running setup.py (path:/tmp/pip-FD6V0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:22 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)) 05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:22 INFO - Running setup.py (path:/tmp/pip-6VNoux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 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)) 05:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:22 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 05:33:22 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 05:33:22 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 05:33:22 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 05:33:22 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 05:33:22 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 05:33:24 INFO - Downloading blessings-1.6.tar.gz 05:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:25 INFO - Installing collected packages: blessings 05:33:25 INFO - Running setup.py install for blessings 05:33:25 INFO - Successfully installed blessings 05:33:25 INFO - Cleaning up... 05:33:25 INFO - Return code: 0 05:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:25 INFO - Reading from file tmpfile_stdout 05:33:25 INFO - Current package versions: 05:33:25 INFO - argparse == 1.2.1 05:33:25 INFO - blessings == 1.6 05:33:25 INFO - blobuploader == 1.2.4 05:33:25 INFO - docopt == 0.6.1 05:33:25 INFO - functools32 == 3.2.3-2 05:33:25 INFO - jsonschema == 2.5.1 05:33:25 INFO - manifestparser == 1.1 05:33:25 INFO - mozInstall == 1.12 05:33:25 INFO - mozcrash == 1.0 05:33:25 INFO - mozdebug == 0.1 05:33:25 INFO - mozdevice == 0.49 05:33:25 INFO - mozfile == 1.2 05:33:25 INFO - mozhttpd == 0.7 05:33:25 INFO - mozinfo == 0.9 05:33:25 INFO - mozleak == 0.1 05:33:25 INFO - mozlog == 3.4 05:33:25 INFO - moznetwork == 0.27 05:33:25 INFO - mozprocess == 0.25 05:33:25 INFO - mozprofile == 0.28 05:33:25 INFO - mozrunner == 6.13 05:33:25 INFO - mozscreenshot == 0.1 05:33:25 INFO - mozsystemmonitor == 0.3 05:33:25 INFO - moztest == 0.8 05:33:25 INFO - mozversion == 1.4 05:33:25 INFO - psutil == 3.1.1 05:33:25 INFO - requests == 1.2.3 05:33:25 INFO - wsgiref == 0.1.2 05:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:25 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:25 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 05:33:25 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 05:33:25 INFO - Using env: {'DISPLAY': ':0', 05:33:25 INFO - 'HOME': '/home/cltbld', 05:33:25 INFO - 'LANG': 'en_US.UTF-8', 05:33:25 INFO - 'LANGUAGE': 'en_US:en', 05:33:25 INFO - 'LOGNAME': 'cltbld', 05:33:25 INFO - 'MAIL': '/var/mail/cltbld', 05:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:25 INFO - 'MOZ_NO_REMOTE': '1', 05:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:25 INFO - 'NO_EM_RESTART': '1', 05:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:25 INFO - 'PWD': '/builds/slave/test', 05:33:25 INFO - 'SHELL': '/bin/bash', 05:33:25 INFO - 'SHLVL': '1', 05:33:25 INFO - 'TERM': 'linux', 05:33:25 INFO - 'TMOUT': '86400', 05:33:25 INFO - 'USER': 'cltbld', 05:33:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:25 INFO - '_': '/tools/buildbot/bin/python'} 05:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 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)) 05:33:25 INFO - Cleaning up... 05:33:25 INFO - Return code: 0 05:33:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:25 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 0x16601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1758a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fdb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', '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 05:33:25 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 05:33:25 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 05:33:25 INFO - Using env: {'DISPLAY': ':0', 05:33:25 INFO - 'HOME': '/home/cltbld', 05:33:25 INFO - 'LANG': 'en_US.UTF-8', 05:33:25 INFO - 'LANGUAGE': 'en_US:en', 05:33:25 INFO - 'LOGNAME': 'cltbld', 05:33:25 INFO - 'MAIL': '/var/mail/cltbld', 05:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:25 INFO - 'MOZ_NO_REMOTE': '1', 05:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:25 INFO - 'NO_EM_RESTART': '1', 05:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:25 INFO - 'PWD': '/builds/slave/test', 05:33:25 INFO - 'SHELL': '/bin/bash', 05:33:25 INFO - 'SHLVL': '1', 05:33:25 INFO - 'TERM': 'linux', 05:33:25 INFO - 'TMOUT': '86400', 05:33:25 INFO - 'USER': 'cltbld', 05:33:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:25 INFO - '_': '/tools/buildbot/bin/python'} 05:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:25 INFO - Cleaning up... 05:33:25 INFO - Return code: 0 05:33:25 INFO - Running post-action listener: _resource_record_post_action 05:33:25 INFO - Running post-action listener: _start_resource_monitoring 05:33:25 INFO - Starting resource monitoring. 05:33:25 INFO - [mozharness: 2017-03-02 13:33:25.927656Z] Finished create-virtualenv step (success) 05:33:25 INFO - [mozharness: 2017-03-02 13:33:25.928167Z] Running install step. 05:33:25 INFO - Running pre-action listener: _resource_record_pre_action 05:33:25 INFO - Running main action method: install 05:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:26 INFO - Reading from file tmpfile_stdout 05:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:26 INFO - Reading from file tmpfile_stdout 05:33:26 INFO - Output received: 05:33:26 INFO - Usage: mozinstall [options] installer 05:33:26 INFO - Options: 05:33:26 INFO - -h, --help show this help message and exit 05:33:26 INFO - -d DEST, --destination=DEST 05:33:26 INFO - Directory to install application into. [default: 05:33:26 INFO - "/builds/slave/test"] 05:33:26 INFO - --app=APP Application being installed. [default: firefox] 05:33:26 INFO - mkdir: /builds/slave/test/build/application 05:33:26 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'] 05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:33:41 INFO - Reading from file tmpfile_stdout 05:33:41 INFO - Output received: 05:33:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:41 INFO - Running post-action listener: _resource_record_post_action 05:33:41 INFO - [mozharness: 2017-03-02 13:33:41.706388Z] Finished install step (success) 05:33:41 INFO - [mozharness: 2017-03-02 13:33:41.706699Z] Running run-tests step. 05:33:41 INFO - Running pre-action listener: _resource_record_pre_action 05:33:41 INFO - Running main action method: run_tests 05:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:41 INFO - Python 2.7.3 05:33:41 INFO - Return code: 0 05:33:41 INFO - grabbing minidump binary from tooltool 05:33: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')]} 05:33:41 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 0x18fb290>, '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 0x18fbb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fc040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:41 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 05:33:41 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 05:33:41 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 05:33:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:41 INFO - Return code: 0 05:33:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:41 INFO - ENV: RUST_BACKTRACE is now 1 05:33:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:41 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/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:33:41 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/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 05:33:41 INFO - Using env: {'DISPLAY': ':0', 05:33:41 INFO - 'HOME': '/home/cltbld', 05:33:41 INFO - 'LANG': 'en_US.UTF-8', 05:33:41 INFO - 'LANGUAGE': 'en_US:en', 05:33:41 INFO - 'LOGNAME': 'cltbld', 05:33:41 INFO - 'MAIL': '/var/mail/cltbld', 05:33:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:41 INFO - 'MOZ_NO_REMOTE': '1', 05:33:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:41 INFO - 'NO_EM_RESTART': '1', 05:33:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:41 INFO - 'PWD': '/builds/slave/test', 05:33:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:41 INFO - 'RUST_BACKTRACE': '1', 05:33:41 INFO - 'SHELL': '/bin/bash', 05:33:41 INFO - 'SHLVL': '1', 05:33:41 INFO - 'TERM': 'linux', 05:33:41 INFO - 'TMOUT': '86400', 05:33:41 INFO - 'USER': 'cltbld', 05:33:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902', 05:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:41 INFO - '_': '/tools/buildbot/bin/python'} 05:33:41 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/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:33:42 INFO - mozversion application_buildid: 20170302130004 05:33:42 INFO - mozversion application_changeset: 180a160ae22a4d63867cfd02608e7621e8e697d1 05:33:42 INFO - mozversion application_display_name: Nightly 05:33:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:42 INFO - mozversion application_name: Firefox 05:33:42 INFO - mozversion application_remotingname: firefox 05:33:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:42 INFO - mozversion application_vendor: Mozilla 05:33:42 INFO - mozversion application_version: 54.0a1 05:33:42 INFO - mozversion platform_buildid: 20170302130004 05:33:42 INFO - mozversion platform_changeset: 180a160ae22a4d63867cfd02608e7621e8e697d1 05:33:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:42 INFO - mozversion platform_version: 54.0a1 05:33:42 INFO - using testdate: 1488461622 05:33:42 INFO - actual date: 1488461622 05:33:42 INFO - starting webserver on 'localhost:35530' 05:33:42 INFO - SUITE-START | Running 2 tests 05:33:42 INFO - TEST-START | dromaeo_css 05:33:42 INFO - operating with platform_type : linux_ 05:33:42 INFO - Initialising browser for dromaeo_css test... 05:33:42 INFO - TEST-INFO | started process 15131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6S1thP/profile http://localhost:35530/getInfo.html) 05:33:46 INFO - PROCESS | 15131 | __metrics Screen width/height:1600/1200 05:33:46 INFO - PROCESS | 15131 | colorDepth:24 05:33:46 INFO - PROCESS | 15131 | Browser inner width/height: 1024/697 05:33:46 INFO - PROCESS | 15131 | __metrics 05:33:47 INFO - PROCESS | 15131 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:47 INFO - PROCESS | 15131 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:48 INFO - TEST-INFO | 15131: exit 0 05:33:48 INFO - Browser initialized. 05:33:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:48 INFO - TEST-INFO | started process 15219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6S1thP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:00 INFO - PROCESS | 15219 | RSS: Main: 148291584 05:34:00 INFO - PROCESS | 15219 | 05:37:06 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35530/tests/dromaeo/cssquery-ext.html) 05:37:09 INFO - PROCESS | 15219 | RSS: Main: 363995136 05:37:09 INFO - PROCESS | 15219 | 05:38:50 INFO - PROCESS | 15219 | ************************* 05:38:50 INFO - PROCESS | 15219 | A coding exception was thrown and uncaught in a Task. 05:38:50 INFO - PROCESS | 15219 | 05:38:50 ERROR - PROCESS | 15219 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:50 INFO - PROCESS | 15219 | Full stack: 05:38:50 INFO - PROCESS | 15219 | ************************* 05:40:12 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-ext.html (next: http://localhost:35530/tests/dromaeo/cssquery-jquery.html) 05:40:12 INFO - PROCESS | 15219 | RSS: Main: 239198208 05:40:12 INFO - PROCESS | 15219 | 05:43:15 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35530/tests/dromaeo/cssquery-mootools.html) 05:43:15 INFO - PROCESS | 15219 | RSS: Main: 208048128 05:43:15 INFO - PROCESS | 15219 | 05:46:18 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35530/tests/dromaeo/cssquery-prototype.html) 05:46:18 INFO - PROCESS | 15219 | RSS: Main: 212537344 05:46:18 INFO - PROCESS | 15219 | 05:49:21 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35530/tests/dromaeo/cssquery-yui.html) 05:49:22 INFO - PROCESS | 15219 | RSS: Main: 183488512 05:49:22 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | Cycle 1(1): loaded http://localhost:35530/tests/dromaeo/cssquery-yui.html (next: http://localhost:35530/tests/dromaeo/cssquery-dojo.html) 05:52:25 INFO - PROCESS | 15219 | RSS: Main: 273358848 05:52:25 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | __start_tp_report 05:52:25 INFO - PROCESS | 15219 | _x_x_mozilla_page_load 05:52:25 INFO - PROCESS | 15219 | _x_x_mozilla_page_load_details 05:52:25 INFO - PROCESS | 15219 | |i|pagename|runs| 05:52:25 INFO - PROCESS | 15219 | |0;dojo.html;2672.251769504539;2694.6092816541614;2706.336947447875;2733.316670832292;2736.8631568421574;4957;4998.425181104174;5016.799328026884;5081.161608334625;5116.38603367596;5040.117979353608;5055.51972562606;5056.367954005749;5073.644844860852;5099.133147364948;4564.338170965208;4600.861974140781;4637.397138372024;4646.094011667709;4662.7901744421415;4597.540245975392;4638.67529272951;4685.5314468553215;4732.05358928214;4756.07256584966;4521.570450807168;4679.789409476582;4688.203005489075;4701.4593321767925;4788.497207793183;4549.499555048942;4601.3558101865765;4611.031683346501;4617.30740388941;4618.838340658061;4578.771061446948;4579.587837094644;4581.518940511265;4588.151192029485;4594.425696787902;5022.974885125587;5065.189569668835;5071.949280507221;5119.539241468286;5150.896982060375;5515.393306736256;5516.172574113915;5518.862028449281;5568.3596386415675;5583.637063590853;5524.861878453031;5532.336119665626;5537.667739935617;5548.306461692288;5560.4161563036105;4992.450830408652;5016.949830501721;5017.498250174954;5118.078745825713;5209.47905209476;5556.361018482926;5580.888382232332;5585.218069470277;5589.5807814413265;5595;5389.649672771257;5436.075867102602;5436.592255580847;5486.1770734389365;5493.862653433696;5541.833744987657;5546.140348246028;5546.584006199551;5550.195221692832;5551.9722401387735;5300.2049692546425;5495.450454954553;5498.3127109111365;5507.0637991541535;5559.8888022239325;5319.627626066215;5412.702301373383;5413.323334583177;5413.756380962866;5418.322709661293;4548.295014272793;4555.612772914273;4556.681032327705;4557.020240648277;4561.156186105581;3896.785676787804;3898.4737060497037;3931.1941052084253;3956.9208615827524;3978.124812541236;4722.338872557844;4723.00816828463;4724.456687480915;4749.64377671676;4760.976195119002;5535.446455354432;5543.223948647193;5551.250581171571;5552.194931734876;5586.13414920688;4577.130345234395;4603.447586289667;4639.652026098056;4687.929681054787;4689.859304220879;4856.077345304381;4922.729249891218;4929.211326187865;4942.728149951715;4954.430240522314;5102.642815002914;5113;5117.053345131163;5123.077845987609;5123.87190320245;5387.784488620411;5419.4309597493275;5431.022415965164;5470.206820010996;5494.697791621499;5101.974490127525;5106.438291787975;5110.488951105009;5111.591072714248;5114.539691427789;5357.651752636066;5377.919331209957;5378.2739330189925;5381.730913454233;5383.703896285742;5411;5411.594130440311;5461;5470.124780035176;5472.2065300531995;5335.06636338647;5370.919436208538;5379.1662292344745;5383.300170977748;5384.353877534721;5298.81454149103;5300;5306.522412982696;5323.600729945192;5338;5230.790768369223;5251.133562962068;5255.684658920477;5269.525742683177;5309.522143007148;5214.400343960341;5239.738013099253;5249.133892907627;5310.3893052297935;5349.97325013388;5187.1181899078;5191.299174611379;5195.220716892496;5198.558122559625;5203.92194117081 05:52:25 INFO - PROCESS | 15219 | |1;ext.html;674.8650269946012;702.3854127638316;765.2538774694673;780.0366547314067;782.0693374883891;35257;35698.46452303218;35938.10154746132;35972.2805543889;39821.800890995575;36160;36369;36392;36398;36445.27109457809;6672;7336.853262934738;7462.067241594801;7466.365358944497;9220.446773193597;9087.227585655195;9378.109079637423;9406.858897116548;9409.153176214139;9410.482423466707;9397.671081512148;9429.528523573828;9432.056794320582;9435.622575096988;9453.291003174754;9353.251739860794;9414.1527262546;9420.905790942072;9422.528873556363;9427.198688111519;9056.909430905738;9104.180623743894;9109.772255693595;9112.589933452944;9112.954435227848;34041.319173616386;34161.316773664636;34423.13942151441;34455.82772086149;34505.30989380198;3417.179876829568;3437.5874895012507;3467.4625433057918;3477.897335337397;3511.139770756181;21526.461838454008;21695.566088678297;22205.333839984825;22933.655995160087;23286.068557257688;3229.3702727968057;3247.480403135487;3338.1988322802595;3429.2798512312443;3431.159365955332;156902;157711;158470.20764896218;159050;159416;30598;31355.686443135277;36513.634863651554;36535.26929461396;45015;41372;41899.7905010473;45707.77146114248;45882;45887.77056114698;10877.619283325204;10895.509702063426;10926.508307126198;10930.344179349264;10942.17933654963;8851.336149788664;8854.114588541222;8856.64573417056;8871.379003469825;8876.911230887737;12160.209586376857;12383.380830958416;12387.442565084593;12488.188267762567;12548.623541293775;5395.70323632204;5433;5463.951018368112;5474.671519708831;5539.473749993744;815.416976861535;850.5832142250252;853.4665833853842;855.5166331022953;872.6858331000834;23927.52144957126;24695.5060898781;24902.252932412055;24910.626340604904;24927.750722492543;895.6596493332622;899.2940541674753;899.595182168027;906.8685040669066;915.9816803663889;13179.472821087049;13393.794558489783;13423.932880335537;13494.797578036338;13564.118332308566;242189;243703;245066;245459;245878;29983.850080749457;30070.84964575163;30100.397992040038;30189.245268868013;30222.697773022428;1162.4943149729895;1183.272287543172;1200.4657927222477;1205.2286536616398;1209.8245754365569;23174.884125579265;23278.30165094982;23846;23970;23994.88002559976;31977.840110799298;32060;32064.35871282608;32074.67925320717;32086.83956580202;211583;211586;211885;212401;213037;22052.14490984126;22443.409054551194;22447.77552224457;22460.775392246524;22462.32613021612;35037.124071898405;35233.82383088171;35536.62402071799;35952.82023589865;36037.27925441424;28930.421391572472;29569.704302956696;29997.100086997423;30343.848280758455;31261.374772504878;29555.704442956154;29646.110616681533;29718.25704357322;29873.402531949672;31032.68967310298;29656;30129.548056778727;30288.5456718145;30301.24246893757;30315.696843031288;25068;26921.730782691924;27097.1870843875;27149.457010860067;27289;21479.892600536896;21514.784852151904;21677.40258961448;21784.78215217891;21789.34631961044 05:52:25 INFO - PROCESS | 15219 | |2;jquery.html;383.4095492940871;393.8326211360171;408.87120557024525;424.206733408526;443.2509059689125;11348.48931798069;12900.161489503187;16648.500544983654;17288.049157296377;17804;15103.54689359321;15230.390784368612;15490.148041857721;15533.844661553381;15593.84406155938;5464.890702185954;5715.71421428929;5725.828225153252;5731.254936858202;5739.110437882114;3728.45937339087;3903.0242439390154;5588.30146231721;5629.9437005629825;6673.2325782535145;6824.658767061652;6825.829354266133;6827.487938404614;6831.351021652935;6845.110135682379;6573.046908198308;6651.733930642768;6691.698873550702;6696.866062678768;6697.665116744192;5554.1946417769195;5831.067029275338;6518.478521718251;6518.674066296714;6529.444997175246;19888.90055549713;20116.49708757278;20242.79757202424;20341.593168136555;20456.829191475346;2599.6230546570832;2601.557735185023;2633.5259653262406;2634.7628713415693;2693.0708905427596;12438.19151755142;12456.626301210978;12566.560170393992;12907.354632268349;13349;1590.3718031377657;1607.172306262276;1610.4202487104633;1622.083522809609;1655.966880662392;81673;88060;88561;89200;91413;13222.404991775393;13765.449382024806;14031.719365612631;14399.42402303896;14469.49356772508;24271.878640607036;24310.635340469908;24408.26775196747;24437.877810610833;24448.388790280384;7331.340179383881;7335.266473352622;7577.772666820004;7617.847643047219;7639.847203055908;5997.310309314397;6019.789307374221;6203.131561581382;6206.782762603287;6223.719932603044;7454.36637885775;7464.776056718307;7529.510581812165;7683;7732.961335193288;3139.237471025483;3148.489434280806;3172.969299648227;3410.9829450852585;3453.620101788801;791.1100012485954;813.4915677701437;822.4900561651694;827.5324441690426;850.8425941200774;16522.83477165237;16579.253933573018;17209.827901720822;17220.311187552357;17535.386261480788;794.2018271636967;796.3629096722599;803.1005274093053;809.9635516401776;815.8001289684065;8848.513331766686;9437.528123593793;9437.622495100119;9472.147506724428;9619.56711947964;459373;463529;466359;469568;477300;60623.69688151531;61123.77752444926;70974;78068.60965695135;82826;899.3210126354692;901.8241442918699;922.8892532895961;923.5705396990431;925.2413021322585;14364.784528232294;14682.265886705409;15059;15107.774735205492;15161.848381516043;39361.2127757449;39586.518017636765;39703.40444893387;40415;41181.735004573835;48815;48849.5115048845;48944.26583601178;51221;51233.97532049413;9192.402493838146;9310.720678379388;9330.906690933003;9527.09492598202;9871.358361706752;10425.843612345669;10664.733381665521;10886.61896833607;10993.175511836484;11396.316221026766;9553.904460955302;9586.712398628053;9602.66390676351;9671.90328096738;9994.850077248702;9069.682561110329;9153.77115572116;9256.07439256069;9315.487648179143;9473.905260947302;9306.615492182482;9443.291753118407;9618.182454491447;9945.403275803186;10290.691279261635;7968.84062318762;7975.601219939096;8347.248747612744;8376.911001569757;9492.335536512377;9211.907880921104;9278.396904201205;9279.536023198949;9560;10061.094501494901 05:52:25 INFO - PROCESS | 15219 | |3;mootools.html;1416.8228971378578;1428.2216192175263;1463.282991334246;1483.7329280729468;1484.4136566056409;8827.558622068895;9425.104615061575;9431.292653051023;9438.622455101797;9451.149396554309;9276.58255378508;9342.112499312554;9720.854187187198;9741.659041933533;10025.949870250639;2124.3308357867263;2161.675748637709;2164.199246278871;2165.4802847316687;2165.545235500547;2015.7782643909159;2028.8072633099905;2039.2658642888548;2045.4068320187127;2048.252387878421;2092.5814837032576;2092.9790702092937;2115.196225434333;2115.4605575578207;2116.947076323089;2021.413790000898;2044.2231951858348;2047.692846073086;2049.0369526322606;2050.7539095308507;1898.392514395394;1951.3853136262032;2021.6563184258712;2023.7773844877051;2043.989780051105;9549.045095490465;9569.425834449956;9601.183899368561;9606.471644059575;9612.18296444803;4711.670183087185;4801.399825021872;4803.279508073782;4823.252395878644;4837.080954618611;2809.5083360411845;2844.459552685004;2904.0416662501325;3003.6245469316336;3006.4137493188837;1024.7386916336286;1077.8814330423647;1092.792369449802;1130.7964566378048;1147.701597584634;12127.272363658121;12531.749365012649;13722.65693357674;13921.373538190704;14137.293135343192;4048.716589838683;4138.937915931264;4150.958490415118;4154.189932963043;4175.06061136248;10629.202809789296;10652.680419587425;10673.73315667099;10674.199435042248;10677.679669609925;4113.1568028554075;4276.957230427718;4857.9028419431415;4859.854204373874;4863.781129849165;4244.108737165168;4399.802008909607;4429.047754732748;4457;4461.375407442961;3232.5474433579316;3314.2708604107056;3404.1829960809227;3438.5014172944784;3449.7067749241596;913.0321858829661;913.9405938613969;920.4753290624413;921.6267411698273;926.6432423516994;657.5627207906784;659.9175103112111;682.4915437998624;683.2211279141783;688.9207741109736;5633.746481408347;5882.264716910387;5917.615355001911;5964.135200395918;6197.163382943245;920.4385324951774;930.1535602601735;935.4901578639658;942.4627962061696;971.3734641156415;3804.334241507725;4137.565555616678;4266.552012038754;4362.192994296065;4375.562443755599;11915.70210744721;12164.513419463123;12165.939170304091;12170.756584868253;12196.085293603015;11470.139739519569;11751.764964700658;12062.155649104478;12082.456289466994;12091.45588448522;8802.691905783267;8803.515806630698;9044.321675874337;9049.77375565616;9058.954705226432;6117.571769976059;6223.688815559113;6242.531810114168;6295.307516173309;6296.842578935563;10790.56837726482;10803.513841877291;10805.621803236849;10817.729556760829;10820.837687434538;9813.26400519978;10246.795064098826;10546.894531054591;11001.559937602726;11096.556137754722;7974.760757177294;8188.713395031384;8232.34141268709;8313.293370063371;8332.750017499484;8735.606897689491;8779.648814047621;8792.208701216921;8794.648214071365;8828.470291782514;7731.626519568846;7905.960470197612;7956.9602151988865;8046.074701409413;8107.47301425429;7700.114486834086;7705.075390953121;7710.151883292721;7720.420968427278;7749.92250077492;7017.4386049116965;7103.573785572882;7179.389751870941;7180.138383394026;7193.784186474414;5169.741512924414;5283.260343551982;5294.735263236746;5308.946910531;5340.332458442695;5107.668001579886;5142.871428214325;5150.922736159036;5181.326427564392;5275.472452754694 05:52:25 INFO - PROCESS | 15219 | |4;prototype.html;355.11399059346934;355.64968506021575;367.4561648759835;377.44515562123667;382.8468612554976;4742.241241401376;4802.6157907367415;4923.5076492350745;4937.87655308617;4982.701037937722;4719.834805781798;4798.640101992347;4846.418429788421;4860.538248866361;4863.829765958192;4158.97920510397;4163;4173.64524015459;4176.895577610561;4178.268802959486;4001.659858911996;4102.671786257092;4161.708680392374;4191;4194.266003449399;4131.710780245384;4154.43915071466;4160.105577300879;4160.56314087021;4161.148289011391;4133.379993001044;4139.937900931488;4148.771817550049;4160.147169830193;4177.26897792885;3996.840126394941;4022.839086436539;4052.189562087565;4059.7158198926086;4060.4315395844606;4664.976675116636;4716.097133059549;4739.620830333565;4748.810047598092;4750.382450281476;4813.66304358695;4845.685030473008;4851.490593487703;4853.762290615906;4856.927146092811;5162.6128040397125;5167.328247327823;5179.223116532513;5182.948170518284;5185.603429753517;3913.863014794497;4131.8514372526415;4151.8962025949295;4170.91658166838;4445.644348452116;5368.973155134199;5377;5379.300690910157;5380.91928621071;5402.297701298845;4283.614474697292;4290.785460726951;4291.9785401072795;4303.849365272201;4309.5778393130195;4115.609017143426;4305.354196870495;4351.891202719958;4366.170427618806;4375.081232941118;4601.746903920316;4610.593768900518;4620.745858977789;4627.629789616823;4627.791749371287;5105.004524117761;5121.385433747974;5125.769340379692;5126.718030508283;5151.484851514819;1361.6255529729403;1371.5131128449457;1389.6248013036422;1450.7668481790604;1459.3797636004656;1097.2319376436367;1108.6563165418584;1110.5890820396505;1120.641394753671;1122.231271578971;4320.589543993316;4369.60673539383;4376.562343765598;4387.897316009541;4397.1205758848355;5097.93533618885;5107.87230319245;5111.67418824434;5137.743112844343;5152.433232344439;4352.914564462637;4368.781560922005;4376.846810361622;4402.16358891816;4404.207242696281;2592.8833202505934;2692.2192564156176;2700.865636432703;2702.2298644886505;2707.620933069372;4755.453122890843;4758.595519380891;4764.714117152982;4764.833230836974;4803.495632958489;5062.6709263898465;5221.947780522146;5229.816956406507;5239;5247.790088396498;4904.950950490521;4950.183219768698;4953.504649535162;4956.925646115384;4957.7769000395065;5277.920831187458;5288.127458969227;5291.497307755911;5333.280007199133;5345.599080068932;4901.803927842846;5165.7675404607635;5199.324087868553;5222.556082732858;5233.911991924782;4914.778834952364;4937.975310123426;4940.901181976412;4955.529224723646;4962.478939711423;4258;4290.099079193405;4314.9784251078545;4325.870223893288;4329.264025115801;5140.614453915897;5304.814331498534;5319.601029922694;5324.893502130013;5344.35867695879;5101.8724531887;5137.8201762938115;5142.408623008402;5149.407818100966;5158.509941555696;5082.771275292695;5118.436971933159;5147.974260128825;5168.53483186515;5181.3782346118705;4831.782569784438;5041.798328066836;5063.215201643751;5069.543741063322;5105.591552675852;5137.743112844418;5158.638895277445;5167.948320516897;5179.300794392709;5195.350581177353;5008.524190201925;5025.522575355335;5059.443461219336;5060.240963855451;5074.923876141935 05:52:25 INFO - PROCESS | 15219 | |5;yui.html;621.9098230756543;632.2792017100509;710.7100612388515;730.6237287796785;748.3115533708989;12224.3276619786;12623.621291361262;12655.683607909807;12669.873301266985;12692.492300307988;12581.622551323451;12584.05619578533;12619.36903154841;12620.053495987791;12677.175983561063;821.7534739578117;824.7031068815222;835.1690068381969;836.7406104107715;844.4046946902449;843.4180415513276;853.56894768142;854.0093491549803;854.090393730678;854.1927878155146;899.8965119011332;900.5857305639381;901.265468643057;901.4230892228978;901.6618767962015;890.2566357091836;890.7639475538988;891.006527721589;891.31814162166;891.8394688955985;658.2857599504543;659.2780904909117;660.445226010149;660.795153502411;660.9834754131138;13675.658108547266;13947.302634868216;14067.929660351632;14138.50515231962;14150.929245353707;11264.549418023269;11356.943215283953;11572.652820415316;11951.103667224992;12872.806907896389;11578.53685852565;11797.115216358807;11824.408779561074;11878.762424751456;11948.283103013848;3934.3705007198996;4063;4068.7151899367054;4150.335946248586;4167.1040726244;57794.42205577932;59651.105233421535;59954.40045599532;60341.39658603402;60518;8949.865752013726;9118.635254589875;9364.578593963288;9367;9553.952230238805;15237;15686.68626627461;15711.68576628461;15716.764248536052;15750;6011.849703757441;6421.775237866652;6444.258910225384;6457.580257283262;6466.062420948936;3319.1038419626566;3330.9500357494658;3510.5962814276686;3569.44673575591;3579.284143171376;2805.1724741201397;2897;2897.5074237379695;2902.8693708783157;2910.5779661949323;475.99048019039424;480.71877951398125;481.78801327415823;484.56147186796005;486.1079918349797;563.6449037106679;574.7672192761938;597.4831770518557;603.3453702732496;609.0954931926086;7623.275788800055;7625.504342217738;7805.258500442449;7901;9125.680601178927;503.57699532392235;510.07930685113723;523.7878659143054;600.984336471362;650.6459202809524;3638.6179451157777;3717.739758216953;3742.925141497155;3771.528558930134;3951.940720889189;55465;57028.144577831365;57923.71038144867;59625.701871491234;59627.701861490415;50225;51332.23001654978;51419;51470.742646286526;53214.20178697323;45175.54824451779;45259;45502.77248613802;46028.30957535573;46705.2994205094;7438.107427108782;7557.811054723676;7779.37764978789;7821;7898.763037108896;30721.69278307188;30941.535876961414;31521.21196970094;32108;32753.672463275063;36963.26073478569;37281.6271837289;37291.81354093212;37952.430713538764;41721;10852.240343175901;10918.399488028235;10925.56297748113;11177.385243811668;11537.077033837106;11721;11722.472488738198;11885.881141188824;12494.875051249372;12509.311987840756;10268.948655256676;10355;10525.473726313501;10871.456427178768;10873.347599144077;10624.84062739075;10757.784844302914;11146.55413783472;11243.66269011931;11253.549858005588;11412.543498259976;11812;11988.280703157838;11993.880061199276;12530.49878004906;9218.539073046186;9460.858087128561;9662.806743864943;9722.513874306398;9752.85370719454;8172.426607209216;8305.377096717892;9164.633414663605;9293.442393456415;9338.159565639126 05:52:25 INFO - PROCESS | 15219 | __end_tp_report 05:52:25 INFO - PROCESS | 15219 | __start_cc_report 05:52:25 INFO - PROCESS | 15219 | _x_x_mozilla_cycle_collect,2860 05:52:25 INFO - PROCESS | 15219 | __end_cc_report 05:52:25 INFO - PROCESS | 15219 | __startTimestamp1488462745982__endTimestamp 05:52:25 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | ------- Summary: start ------- 05:52:25 INFO - PROCESS | 15219 | Number of tests: 6 05:52:25 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | [#0] dojo.html Cycles:165 Average:5027.13 Median:5123.87 stddev:568.56 (11.1%) stddev-sans-first:539.46 05:52:25 INFO - PROCESS | 15219 | Values: 2672.3 2694.6 2706.3 2733.3 2736.9 4957.0 4998.4 5016.8 5081.2 5116.4 5040.1 5055.5 5056.4 5073.6 5099.1 4564.3 4600.9 4637.4 4646.1 4662.8 4597.5 4638.7 4685.5 4732.1 4756.1 4521.6 4679.8 4688.2 4701.5 4788.5 4549.5 4601.4 4611.0 4617.3 4618.8 4578.8 4579.6 4581.5 4588.2 4594.4 5023.0 5065.2 5071.9 5119.5 5150.9 5515.4 5516.2 5518.9 5568.4 5583.6 5524.9 5532.3 5537.7 5548.3 5560.4 4992.5 5016.9 5017.5 5118.1 5209.5 5556.4 5580.9 5585.2 5589.6 5595.0 5389.6 5436.1 5436.6 5486.2 5493.9 5541.8 5546.1 5546.6 5550.2 5552.0 5300.2 5495.5 5498.3 5507.1 5559.9 5319.6 5412.7 5413.3 5413.8 5418.3 4548.3 4555.6 4556.7 4557.0 4561.2 3896.8 3898.5 3931.2 3956.9 3978.1 4722.3 4723.0 4724.5 4749.6 4761.0 5535.4 5543.2 5551.3 5552.2 5586.1 4577.1 4603.4 4639.7 4687.9 4689.9 4856.1 4922.7 4929.2 4942.7 4954.4 5102.6 5113.0 5117.1 5123.1 5123.9 5387.8 5419.4 5431.0 5470.2 5494.7 5102.0 5106.4 5110.5 5111.6 5114.5 5357.7 5377.9 5378.3 5381.7 5383.7 5411.0 5411.6 5461.0 5470.1 5472.2 5335.1 5370.9 5379.2 5383.3 5384.4 5298.8 5300.0 5306.5 5323.6 5338.0 5230.8 5251.1 5255.7 5269.5 5309.5 5214.4 5239.7 5249.1 5310.4 5350.0 5187.1 5191.3 5195.2 5198.6 5203.9 05:52:25 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | [#1] ext.html Cycles:180 Average:34385.92 Median:32080.76 stddev:54056.14 (168.5%) stddev-sans-first:54148.52 05:52:25 INFO - PROCESS | 15219 | Values: 674.9 702.4 765.3 780.0 782.1 35257.0 35698.5 35938.1 35972.3 39821.8 36160.0 36369.0 36392.0 36398.0 36445.3 6672.0 7336.9 7462.1 7466.4 9220.4 9087.2 9378.1 9406.9 9409.2 9410.5 9397.7 9429.5 9432.1 9435.6 9453.3 9353.3 9414.2 9420.9 9422.5 9427.2 9056.9 9104.2 9109.8 9112.6 9113.0 34041.3 34161.3 34423.1 34455.8 34505.3 3417.2 3437.6 3467.5 3477.9 3511.1 21526.5 21695.6 22205.3 22933.7 23286.1 3229.4 3247.5 3338.2 3429.3 3431.2 156902.0 157711.0 158470.2 159050.0 159416.0 30598.0 31355.7 36513.6 36535.3 45015.0 41372.0 41899.8 45707.8 45882.0 45887.8 10877.6 10895.5 10926.5 10930.3 10942.2 8851.3 8854.1 8856.6 8871.4 8876.9 12160.2 12383.4 12387.4 12488.2 12548.6 5395.7 5433.0 5464.0 5474.7 5539.5 815.4 850.6 853.5 855.5 872.7 23927.5 24695.5 24902.3 24910.6 24927.8 895.7 899.3 899.6 906.9 916.0 13179.5 13393.8 13423.9 13494.8 13564.1 242189.0 243703.0 245066.0 245459.0 245878.0 29983.9 30070.8 30100.4 30189.2 30222.7 1162.5 1183.3 1200.5 1205.2 1209.8 23174.9 23278.3 23846.0 23970.0 23994.9 31977.8 32060.0 32064.4 32074.7 32086.8 211583.0 211586.0 211885.0 212401.0 213037.0 22052.1 22443.4 22447.8 22460.8 22462.3 35037.1 35233.8 35536.6 35952.8 36037.3 28930.4 29569.7 29997.1 30343.8 31261.4 29555.7 29646.1 29718.3 29873.4 31032.7 29656.0 30129.5 30288.5 30301.2 30315.7 25068.0 26921.7 27097.2 27149.5 27289.0 21479.9 21514.8 21677.4 21784.8 21789.3 05:52:25 INFO - PROCESS | 15219 | 05:52:25 INFO - PROCESS | 15219 | [#2] jquery.html Cycles:180 Average:27437.71 Median:5735.18 stddev:76873.00 (1340.4%) stddev-sans-first:77061.81 05:52:26 INFO - PROCESS | 15219 | Values: 383.4 393.8 408.9 424.2 443.3 11348.5 12900.2 16648.5 17288.0 17804.0 15103.5 15230.4 15490.1 15533.8 15593.8 5464.9 5715.7 5725.8 5731.3 5739.1 3728.5 3903.0 5588.3 5629.9 6673.2 6824.7 6825.8 6827.5 6831.4 6845.1 6573.0 6651.7 6691.7 6696.9 6697.7 5554.2 5831.1 6518.5 6518.7 6529.4 19888.9 20116.5 20242.8 20341.6 20456.8 2599.6 2601.6 2633.5 2634.8 2693.1 12438.2 12456.6 12566.6 12907.4 13349.0 1590.4 1607.2 1610.4 1622.1 1656.0 81673.0 88060.0 88561.0 89200.0 91413.0 13222.4 13765.4 14031.7 14399.4 14469.5 24271.9 24310.6 24408.3 24437.9 24448.4 7331.3 7335.3 7577.8 7617.8 7639.8 5997.3 6019.8 6203.1 6206.8 6223.7 7454.4 7464.8 7529.5 7683.0 7733.0 3139.2 3148.5 3173.0 3411.0 3453.6 791.1 813.5 822.5 827.5 850.8 16522.8 16579.3 17209.8 17220.3 17535.4 794.2 796.4 803.1 810.0 815.8 8848.5 9437.5 9437.6 9472.1 9619.6 459373.0 463529.0 466359.0 469568.0 477300.0 60623.7 61123.8 70974.0 78068.6 82826.0 899.3 901.8 922.9 923.6 925.2 14364.8 14682.3 15059.0 15107.8 15161.8 39361.2 39586.5 39703.4 40415.0 41181.7 48815.0 48849.5 48944.3 51221.0 51234.0 9192.4 9310.7 9330.9 9527.1 9871.4 10425.8 10664.7 10886.6 10993.2 11396.3 9553.9 9586.7 9602.7 9671.9 9994.9 9069.7 9153.8 9256.1 9315.5 9473.9 9306.6 9443.3 9618.2 9945.4 10290.7 7968.8 7975.6 8347.2 8376.9 9492.3 9211.9 9278.4 9279.5 9560.0 10061.1 05:52:26 INFO - PROCESS | 15219 | 05:52:26 INFO - PROCESS | 15219 | [#3] mootools.html Cycles:180 Average:5916.50 Median:4459.19 stddev:3702.01 (83.0%) stddev-sans-first:3696.95 05:52:26 INFO - PROCESS | 15219 | Values: 1416.8 1428.2 1463.3 1483.7 1484.4 8827.6 9425.1 9431.3 9438.6 9451.1 9276.6 9342.1 9720.9 9741.7 10025.9 2124.3 2161.7 2164.2 2165.5 2165.5 2015.8 2028.8 2039.3 2045.4 2048.3 2092.6 2093.0 2115.2 2115.5 2116.9 2021.4 2044.2 2047.7 2049.0 2050.8 1898.4 1951.4 2021.7 2023.8 2044.0 9549.0 9569.4 9601.2 9606.5 9612.2 4711.7 4801.4 4803.3 4823.3 4837.1 2809.5 2844.5 2904.0 3003.6 3006.4 1024.7 1077.9 1092.8 1130.8 1147.7 12127.3 12531.7 13722.7 13921.4 14137.3 4048.7 4138.9 4151.0 4154.2 4175.1 10629.2 10652.7 10673.7 10674.2 10677.7 4113.2 4277.0 4857.9 4859.9 4863.8 4244.1 4399.8 4429.0 4457.0 4461.4 3232.5 3314.3 3404.2 3438.5 3449.7 913.0 913.9 920.5 921.6 926.6 657.6 659.9 682.5 683.2 688.9 5633.7 5882.3 5917.6 5964.1 6197.2 920.4 930.2 935.5 942.5 971.4 3804.3 4137.6 4266.6 4362.2 4375.6 11915.7 12164.5 12165.9 12170.8 12196.1 11470.1 11751.8 12062.2 12082.5 12091.5 8802.7 8803.5 9044.3 9049.8 9059.0 6117.6 6223.7 6242.5 6295.3 6296.8 10790.6 10803.5 10805.6 10817.7 10820.8 9813.3 10246.8 10546.9 11001.6 11096.6 7974.8 8188.7 8232.3 8313.3 8332.8 8735.6 8779.6 8792.2 8794.6 8828.5 7731.6 7906.0 7957.0 8046.1 8107.5 7700.1 7705.1 7710.2 7720.4 7749.9 7017.4 7103.6 7179.4 7180.1 7193.8 5169.7 5283.3 5294.7 5308.9 5340.3 5107.7 5142.9 5150.9 5181.3 5275.5 05:52:26 INFO - PROCESS | 15219 | 05:52:26 INFO - PROCESS | 15219 | [#4] prototype.html Cycles:180 Average:4383.94 Median:4781.74 stddev:1169.15 (24.5%) stddev-sans-first:1132.65 05:52:26 INFO - PROCESS | 15219 | Values: 355.1 355.6 367.5 377.4 382.8 4742.2 4802.6 4923.5 4937.9 4982.7 4719.8 4798.6 4846.4 4860.5 4863.8 4159.0 4163.0 4173.6 4176.9 4178.3 4001.7 4102.7 4161.7 4191.0 4194.3 4131.7 4154.4 4160.1 4160.6 4161.1 4133.4 4139.9 4148.8 4160.1 4177.3 3996.8 4022.8 4052.2 4059.7 4060.4 4665.0 4716.1 4739.6 4748.8 4750.4 4813.7 4845.7 4851.5 4853.8 4856.9 5162.6 5167.3 5179.2 5182.9 5185.6 3913.9 4131.9 4151.9 4170.9 4445.6 5369.0 5377.0 5379.3 5380.9 5402.3 4283.6 4290.8 4292.0 4303.8 4309.6 4115.6 4305.4 4351.9 4366.2 4375.1 4601.7 4610.6 4620.7 4627.6 4627.8 5105.0 5121.4 5125.8 5126.7 5151.5 1361.6 1371.5 1389.6 1450.8 1459.4 1097.2 1108.7 1110.6 1120.6 1122.2 4320.6 4369.6 4376.6 4387.9 4397.1 5097.9 5107.9 5111.7 5137.7 5152.4 4352.9 4368.8 4376.8 4402.2 4404.2 2592.9 2692.2 2700.9 2702.2 2707.6 4755.5 4758.6 4764.7 4764.8 4803.5 5062.7 5221.9 5229.8 5239.0 5247.8 4905.0 4950.2 4953.5 4956.9 4957.8 5277.9 5288.1 5291.5 5333.3 5345.6 4901.8 5165.8 5199.3 5222.6 5233.9 4914.8 4938.0 4940.9 4955.5 4962.5 4258.0 4290.1 4315.0 4325.9 4329.3 5140.6 5304.8 5319.6 5324.9 5344.4 5101.9 5137.8 5142.4 5149.4 5158.5 5082.8 5118.4 5148.0 5168.5 5181.4 4831.8 5041.8 5063.2 5069.5 5105.6 5137.7 5158.6 5167.9 5179.3 5195.4 5008.5 5025.5 5059.4 5060.2 5074.9 05:52:26 INFO - PROCESS | 15219 | 05:52:26 INFO - PROCESS | 15219 | [#5] yui.html Cycles:180 Average:13616.78 Median:478.35 stddev:16387.69 (3425.8%) stddev-sans-first:16404.61 05:52:26 INFO - PROCESS | 15219 | Values: 621.9 632.3 710.7 730.6 748.3 12224.3 12623.6 12655.7 12669.9 12692.5 12581.6 12584.1 12619.4 12620.1 12677.2 821.8 824.7 835.2 836.7 844.4 843.4 853.6 854.0 854.1 854.2 899.9 900.6 901.3 901.4 901.7 890.3 890.8 891.0 891.3 891.8 658.3 659.3 660.4 660.8 661.0 13675.7 13947.3 14067.9 14138.5 14150.9 11264.5 11356.9 11572.7 11951.1 12872.8 11578.5 11797.1 11824.4 11878.8 11948.3 3934.4 4063.0 4068.7 4150.3 4167.1 57794.4 59651.1 59954.4 60341.4 60518.0 8949.9 9118.6 9364.6 9367.0 9554.0 15237.0 15686.7 15711.7 15716.8 15750.0 6011.8 6421.8 6444.3 6457.6 6466.1 3319.1 3331.0 3510.6 3569.4 3579.3 2805.2 2897.0 2897.5 2902.9 2910.6 476.0 480.7 481.8 484.6 486.1 563.6 574.8 597.5 603.3 609.1 7623.3 7625.5 7805.3 7901.0 9125.7 503.6 510.1 523.8 601.0 650.6 3638.6 3717.7 3742.9 3771.5 3951.9 55465.0 57028.1 57923.7 59625.7 59627.7 50225.0 51332.2 51419.0 51470.7 53214.2 45175.5 45259.0 45502.8 46028.3 46705.3 7438.1 7557.8 7779.4 7821.0 7898.8 30721.7 30941.5 31521.2 32108.0 32753.7 36963.3 37281.6 37291.8 37952.4 41721.0 10852.2 10918.4 10925.6 11177.4 11537.1 11721.0 11722.5 11885.9 12494.9 12509.3 10268.9 10355.0 10525.5 10871.5 10873.3 10624.8 10757.8 11146.6 11243.7 11253.5 11412.5 11812.0 11988.3 11993.9 12530.5 9218.5 9460.9 9662.8 9722.5 9752.9 8172.4 8305.4 9164.6 9293.4 9338.2 05:52:26 INFO - PROCESS | 15219 | -------- Summary: end -------- 05:52:26 INFO - PROCESS | 15219 | 05:52:26 INFO - TEST-INFO | 15219: exit 0 05:52:26 INFO - TEST-OK | dromaeo_css | took 1124852ms 05:52:26 INFO - TEST-START | kraken 05:52:26 INFO - operating with platform_type : linux_ 05:52:26 INFO - Initialising browser for kraken test... 05:52:26 INFO - TEST-INFO | started process 15542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBHKFL/profile http://localhost:35530/getInfo.html) 05:52:31 INFO - PROCESS | 15542 | __metrics Screen width/height:1600/1200 05:52:31 INFO - PROCESS | 15542 | colorDepth:24 05:52:31 INFO - PROCESS | 15542 | Browser inner width/height: 1024/697 05:52:31 INFO - PROCESS | 15542 | __metrics 05:52:32 INFO - PROCESS | 15542 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:32 INFO - PROCESS | 15542 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:33 INFO - TEST-INFO | 15542: exit 0 05:52:33 INFO - Browser initialized. 05:52:33 INFO - Running cycle 1/1 for kraken test... 05:52:33 INFO - TEST-INFO | started process 15631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBHKFL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:45 INFO - PROCESS | 15631 | RSS: Main: 147476480 05:52:45 INFO - PROCESS | 15631 | 05:52:48 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35530/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:49 INFO - PROCESS | 15631 | RSS: Main: 203141120 05:52:49 INFO - PROCESS | 15631 | 05:52:52 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35530/tests/kraken/driver.html?testName=audio-dft) 05:52:52 INFO - PROCESS | 15631 | RSS: Main: 181493760 05:52:52 INFO - PROCESS | 15631 | 05:52:55 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35530/tests/kraken/driver.html?testName=audio-fft) 05:52:56 INFO - PROCESS | 15631 | RSS: Main: 264675328 05:52:56 INFO - PROCESS | 15631 | 05:52:58 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35530/tests/kraken/driver.html?testName=audio-oscillator) 05:52:59 INFO - PROCESS | 15631 | RSS: Main: 174039040 05:52:59 INFO - PROCESS | 15631 | 05:53:01 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35530/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:02 INFO - PROCESS | 15631 | RSS: Main: 178585600 05:53:02 INFO - PROCESS | 15631 | 05:53:05 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35530/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:05 INFO - PROCESS | 15631 | RSS: Main: 218320896 05:53:05 INFO - PROCESS | 15631 | 05:53:09 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35530/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:10 INFO - PROCESS | 15631 | RSS: Main: 212439040 05:53:10 INFO - PROCESS | 15631 | 05:53:13 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35530/tests/kraken/driver.html?testName=json-parse-financial) 05:53:13 INFO - PROCESS | 15631 | RSS: Main: 214208512 05:53:13 INFO - PROCESS | 15631 | 05:53:15 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35530/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:16 INFO - PROCESS | 15631 | RSS: Main: 177840128 05:53:16 INFO - PROCESS | 15631 | 05:53:18 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:18 INFO - PROCESS | 15631 | RSS: Main: 183406592 05:53:18 INFO - PROCESS | 15631 | 05:53:20 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:21 INFO - PROCESS | 15631 | RSS: Main: 193871872 05:53:21 INFO - PROCESS | 15631 | 05:53:24 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:25 INFO - PROCESS | 15631 | RSS: Main: 203198464 05:53:25 INFO - PROCESS | 15631 | 05:53:28 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:28 INFO - PROCESS | 15631 | RSS: Main: 198852608 05:53:28 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35530/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35530/tests/kraken/driver.html?testName=ai-astar) 05:53:30 INFO - PROCESS | 15631 | RSS: Main: 251678720 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | __start_tp_report 05:53:30 INFO - PROCESS | 15631 | _x_x_mozilla_page_load 05:53:30 INFO - PROCESS | 15631 | _x_x_mozilla_page_load_details 05:53:30 INFO - PROCESS | 15631 | |i|pagename|runs| 05:53:30 INFO - PROCESS | 15631 | |0;ai-astar;118;118;118;118;120;119;118;117;120;118 05:53:30 INFO - PROCESS | 15631 | |1;audio-beat-detection;150;125;126;163;125;125;124;124;148;130 05:53:30 INFO - PROCESS | 15631 | |2;audio-dft;161;162;162;163;164;161;162;161;161;162 05:53:30 INFO - PROCESS | 15631 | |3;audio-fft;77;77;78;113;77;77;78;77;97;77 05:53:30 INFO - PROCESS | 15631 | |4;audio-oscillator;85;84;115;83;84;84;118;83;84;116 05:53:30 INFO - PROCESS | 15631 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;113;113;113 05:53:30 INFO - PROCESS | 15631 | |6;imaging-darkroom;150;150;150;150;149;149;149;150;148;148 05:53:30 INFO - PROCESS | 15631 | |7;imaging-desaturate;94;94;94;94;93;94;93;94;94;93 05:53:30 INFO - PROCESS | 15631 | |8;json-parse-financial;68;65;65;65;65;66;65;64;66;66 05:53:30 INFO - PROCESS | 15631 | |9;json-stringify-tinderbox;57;57;57;57;57;57;57;56;56;56 05:53:30 INFO - PROCESS | 15631 | |10;stanford-crypto-aes;95;90;89;94;85;95;92;84;85;95 05:53:30 INFO - PROCESS | 15631 | |11;stanford-crypto-ccm;136;135;135;143;135;134;135;135;180;163 05:53:30 INFO - PROCESS | 15631 | |12;stanford-crypto-pbkdf2;187;187;187;185;182;190;184;181;184;183 05:53:30 INFO - PROCESS | 15631 | |13;stanford-crypto-sha256-iterative;71;69;69;69;68;69;68;68;67;67 05:53:30 INFO - PROCESS | 15631 | __end_tp_report 05:53:30 INFO - PROCESS | 15631 | __start_cc_report 05:53:30 INFO - PROCESS | 15631 | _x_x_mozilla_cycle_collect,2028 05:53:30 INFO - PROCESS | 15631 | __end_cc_report 05:53:30 INFO - PROCESS | 15631 | __startTimestamp1488462810944__endTimestamp 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | ------- Summary: start ------- 05:53:30 INFO - PROCESS | 15631 | Number of tests: 14 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#0] ai-astar Cycles:10 Average:118.40 Median:118.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 05:53:30 INFO - PROCESS | 15631 | Values: 118.0 118.0 118.0 118.0 120.0 119.0 118.0 117.0 120.0 118.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:128.00 stddev:14.20 (11.1%) stddev-sans-first:13.84 05:53:30 INFO - PROCESS | 15631 | Values: 150.0 125.0 126.0 163.0 125.0 125.0 124.0 124.0 148.0 130.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 05:53:30 INFO - PROCESS | 15631 | Values: 161.0 162.0 162.0 163.0 164.0 161.0 162.0 161.0 161.0 162.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:12.30 (16.0%) stddev-sans-first:12.87 05:53:30 INFO - PROCESS | 15631 | Values: 77.0 77.0 78.0 113.0 77.0 77.0 78.0 77.0 97.0 77.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.71 (18.7%) stddev-sans-first:16.36 05:53:30 INFO - PROCESS | 15631 | Values: 85.0 84.0 115.0 83.0 84.0 84.0 118.0 83.0 84.0 116.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:53:30 INFO - PROCESS | 15631 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 05:53:30 INFO - PROCESS | 15631 | Values: 150.0 150.0 150.0 150.0 149.0 149.0 149.0 150.0 148.0 148.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:53:30 INFO - PROCESS | 15631 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 93.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:1.08 (1.6%) stddev-sans-first:0.67 05:53:30 INFO - PROCESS | 15631 | Values: 68.0 65.0 65.0 65.0 65.0 66.0 65.0 64.0 66.0 66.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:53:30 INFO - PROCESS | 15631 | Values: 57.0 57.0 57.0 57.0 57.0 57.0 57.0 56.0 56.0 56.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:93.00 stddev:4.48 (4.8%) stddev-sans-first:4.43 05:53:30 INFO - PROCESS | 15631 | Values: 95.0 90.0 89.0 94.0 85.0 95.0 92.0 84.0 85.0 95.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:135.50 stddev:15.70 (11.6%) stddev-sans-first:16.44 05:53:30 INFO - PROCESS | 15631 | Values: 136.0 135.0 135.0 143.0 135.0 134.0 135.0 135.0 180.0 163.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:186.00 stddev:2.75 (1.5%) stddev-sans-first:2.82 05:53:30 INFO - PROCESS | 15631 | Values: 187.0 187.0 187.0 185.0 182.0 190.0 184.0 181.0 184.0 183.0 05:53:30 INFO - PROCESS | 15631 | 05:53:30 INFO - PROCESS | 15631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:0.83 05:53:30 INFO - PROCESS | 15631 | Values: 71.0 69.0 69.0 69.0 68.0 69.0 68.0 68.0 67.0 67.0 05:53:30 INFO - PROCESS | 15631 | -------- Summary: end -------- 05:53:30 INFO - PROCESS | 15631 | 05:53:32 INFO - TEST-INFO | 15631: exit 0 05:53:32 INFO - TEST-OK | kraken | took 65277ms 05:53:32 INFO - SUITE-END | took 1190s 05:53:32 INFO - Completed test suite (00:19:50) 05:53:32 INFO - javascript benchmark 05:53:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6497.596196662812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.251769504539, 2694.6092816541614, 2706.336947447875, 2733.316670832292, 2736.8631568421574, 4957.0, 4998.425181104174, 5016.799328026884, 5081.161608334625, 5116.38603367596, 5040.117979353608, 5055.51972562606, 5056.367954005749, 5073.644844860852, 5099.133147364948, 4564.338170965208, 4600.861974140781, 4637.397138372024, 4646.094011667709, 4662.7901744421415, 4597.540245975392, 4638.67529272951, 4685.5314468553215, 4732.05358928214, 4756.07256584966, 4521.570450807168, 4679.789409476582, 4688.203005489075, 4701.4593321767925, 4788.497207793183, 4549.499555048942, 4601.3558101865765, 4611.031683346501, 4617.30740388941, 4618.838340658061, 4578.771061446948, 4579.587837094644, 4581.518940511265, 4588.151192029485, 4594.425696787902, 5022.974885125587, 5065.189569668835, 5071.949280507221, 5119.539241468286, 5150.896982060375, 5515.393306736256, 5516.172574113915, 5518.862028449281, 5568.3596386415675, 5583.637063590853, 5524.861878453031, 5532.336119665626, 5537.667739935617, 5548.306461692288, 5560.4161563036105, 4992.450830408652, 5016.949830501721, 5017.498250174954, 5118.078745825713, 5209.47905209476, 5556.361018482926, 5580.888382232332, 5585.218069470277, 5589.5807814413265, 5595.0, 5389.649672771257, 5436.075867102602, 5436.592255580847, 5486.1770734389365, 5493.862653433696, 5541.833744987657, 5546.140348246028, 5546.584006199551, 5550.195221692832, 5551.9722401387735, 5300.2049692546425, 5495.450454954553, 5498.3127109111365, 5507.0637991541535, 5559.8888022239325, 5319.627626066215, 5412.702301373383, 5413.323334583177, 5413.756380962866, 5418.322709661293, 4548.295014272793, 4555.612772914273, 4556.681032327705, 4557.020240648277, 4561.156186105581, 3896.785676787804, 3898.4737060497037, 3931.1941052084253, 3956.9208615827524, 3978.124812541236, 4722.338872557844, 4723.00816828463, 4724.456687480915, 4749.64377671676, 4760.976195119002, 5535.446455354432, 5543.223948647193, 5551.250581171571, 5552.194931734876, 5586.13414920688, 4577.130345234395, 4603.447586289667, 4639.652026098056, 4687.929681054787, 4689.859304220879, 4856.077345304381, 4922.729249891218, 4929.211326187865, 4942.728149951715, 4954.430240522314, 5102.642815002914, 5113.0, 5117.053345131163, 5123.077845987609, 5123.87190320245, 5387.784488620411, 5419.4309597493275, 5431.022415965164, 5470.206820010996, 5494.697791621499, 5101.974490127525, 5106.438291787975, 5110.488951105009, 5111.591072714248, 5114.539691427789, 5357.651752636066, 5377.919331209957, 5378.2739330189925, 5381.730913454233, 5383.703896285742, 5411.0, 5411.594130440311, 5461.0, 5470.124780035176, 5472.2065300531995, 5335.06636338647, 5370.919436208538, 5379.1662292344745, 5383.300170977748, 5384.353877534721, 5298.81454149103, 5300.0, 5306.522412982696, 5323.600729945192, 5338.0, 5230.790768369223, 5251.133562962068, 5255.684658920477, 5269.525742683177, 5309.522143007148, 5214.400343960341, 5239.738013099253, 5249.133892907627, 5310.3893052297935, 5349.97325013388, 5187.1181899078, 5191.299174611379, 5195.220716892496, 5198.558122559625, 5203.92194117081], "value": 4987.356512228182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.8650269946012, 702.3854127638316, 765.2538774694673, 780.0366547314067, 782.0693374883891, 35257.0, 35698.46452303218, 35938.10154746132, 35972.2805543889, 39821.800890995575, 36160.0, 36369.0, 36392.0, 36398.0, 36445.27109457809, 6672.0, 7336.853262934738, 7462.067241594801, 7466.365358944497, 9220.446773193597, 9087.227585655195, 9378.109079637423, 9406.858897116548, 9409.153176214139, 9410.482423466707, 9397.671081512148, 9429.528523573828, 9432.056794320582, 9435.622575096988, 9453.291003174754, 9353.251739860794, 9414.1527262546, 9420.905790942072, 9422.528873556363, 9427.198688111519, 9056.909430905738, 9104.180623743894, 9109.772255693595, 9112.589933452944, 9112.954435227848, 34041.319173616386, 34161.316773664636, 34423.13942151441, 34455.82772086149, 34505.30989380198, 3417.179876829568, 3437.5874895012507, 3467.4625433057918, 3477.897335337397, 3511.139770756181, 21526.461838454008, 21695.566088678297, 22205.333839984825, 22933.655995160087, 23286.068557257688, 3229.3702727968057, 3247.480403135487, 3338.1988322802595, 3429.2798512312443, 3431.159365955332, 156902.0, 157711.0, 158470.20764896218, 159050.0, 159416.0, 30598.0, 31355.686443135277, 36513.634863651554, 36535.26929461396, 45015.0, 41372.0, 41899.7905010473, 45707.77146114248, 45882.0, 45887.77056114698, 10877.619283325204, 10895.509702063426, 10926.508307126198, 10930.344179349264, 10942.17933654963, 8851.336149788664, 8854.114588541222, 8856.64573417056, 8871.379003469825, 8876.911230887737, 12160.209586376857, 12383.380830958416, 12387.442565084593, 12488.188267762567, 12548.623541293775, 5395.70323632204, 5433.0, 5463.951018368112, 5474.671519708831, 5539.473749993744, 815.416976861535, 850.5832142250252, 853.4665833853842, 855.5166331022953, 872.6858331000834, 23927.52144957126, 24695.5060898781, 24902.252932412055, 24910.626340604904, 24927.750722492543, 895.6596493332622, 899.2940541674753, 899.595182168027, 906.8685040669066, 915.9816803663889, 13179.472821087049, 13393.794558489783, 13423.932880335537, 13494.797578036338, 13564.118332308566, 242189.0, 243703.0, 245066.0, 245459.0, 245878.0, 29983.850080749457, 30070.84964575163, 30100.397992040038, 30189.245268868013, 30222.697773022428, 1162.4943149729895, 1183.272287543172, 1200.4657927222477, 1205.2286536616398, 1209.8245754365569, 23174.884125579265, 23278.30165094982, 23846.0, 23970.0, 23994.88002559976, 31977.840110799298, 32060.0, 32064.35871282608, 32074.67925320717, 32086.83956580202, 211583.0, 211586.0, 211885.0, 212401.0, 213037.0, 22052.14490984126, 22443.409054551194, 22447.77552224457, 22460.775392246524, 22462.32613021612, 35037.124071898405, 35233.82383088171, 35536.62402071799, 35952.82023589865, 36037.27925441424, 28930.421391572472, 29569.704302956696, 29997.100086997423, 30343.848280758455, 31261.374772504878, 29555.704442956154, 29646.110616681533, 29718.25704357322, 29873.402531949672, 31032.68967310298, 29656.0, 30129.548056778727, 30288.5456718145, 30301.24246893757, 30315.696843031288, 25068.0, 26921.730782691924, 27097.1870843875, 27149.457010860067, 27289.0, 21479.892600536896, 21514.784852151904, 21677.40258961448, 21784.78215217891, 21789.34631961044], "value": 15221.803062466108, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.4095492940871, 393.8326211360171, 408.87120557024525, 424.206733408526, 443.2509059689125, 11348.48931798069, 12900.161489503187, 16648.500544983654, 17288.049157296377, 17804.0, 15103.54689359321, 15230.390784368612, 15490.148041857721, 15533.844661553381, 15593.84406155938, 5464.890702185954, 5715.71421428929, 5725.828225153252, 5731.254936858202, 5739.110437882114, 3728.45937339087, 3903.0242439390154, 5588.30146231721, 5629.9437005629825, 6673.2325782535145, 6824.658767061652, 6825.829354266133, 6827.487938404614, 6831.351021652935, 6845.110135682379, 6573.046908198308, 6651.733930642768, 6691.698873550702, 6696.866062678768, 6697.665116744192, 5554.1946417769195, 5831.067029275338, 6518.478521718251, 6518.674066296714, 6529.444997175246, 19888.90055549713, 20116.49708757278, 20242.79757202424, 20341.593168136555, 20456.829191475346, 2599.6230546570832, 2601.557735185023, 2633.5259653262406, 2634.7628713415693, 2693.0708905427596, 12438.19151755142, 12456.626301210978, 12566.560170393992, 12907.354632268349, 13349.0, 1590.3718031377657, 1607.172306262276, 1610.4202487104633, 1622.083522809609, 1655.966880662392, 81673.0, 88060.0, 88561.0, 89200.0, 91413.0, 13222.404991775393, 13765.449382024806, 14031.719365612631, 14399.42402303896, 14469.49356772508, 24271.878640607036, 24310.635340469908, 24408.26775196747, 24437.877810610833, 24448.388790280384, 7331.340179383881, 7335.266473352622, 7577.772666820004, 7617.847643047219, 7639.847203055908, 5997.310309314397, 6019.789307374221, 6203.131561581382, 6206.782762603287, 6223.719932603044, 7454.36637885775, 7464.776056718307, 7529.510581812165, 7683.0, 7732.961335193288, 3139.237471025483, 3148.489434280806, 3172.969299648227, 3410.9829450852585, 3453.620101788801, 791.1100012485954, 813.4915677701437, 822.4900561651694, 827.5324441690426, 850.8425941200774, 16522.83477165237, 16579.253933573018, 17209.827901720822, 17220.311187552357, 17535.386261480788, 794.2018271636967, 796.3629096722599, 803.1005274093053, 809.9635516401776, 815.8001289684065, 8848.513331766686, 9437.528123593793, 9437.622495100119, 9472.147506724428, 9619.56711947964, 459373.0, 463529.0, 466359.0, 469568.0, 477300.0, 60623.69688151531, 61123.77752444926, 70974.0, 78068.60965695135, 82826.0, 899.3210126354692, 901.8241442918699, 922.8892532895961, 923.5705396990431, 925.2413021322585, 14364.784528232294, 14682.265886705409, 15059.0, 15107.774735205492, 15161.848381516043, 39361.2127757449, 39586.518017636765, 39703.40444893387, 40415.0, 41181.735004573835, 48815.0, 48849.5115048845, 48944.26583601178, 51221.0, 51233.97532049413, 9192.402493838146, 9310.720678379388, 9330.906690933003, 9527.09492598202, 9871.358361706752, 10425.843612345669, 10664.733381665521, 10886.61896833607, 10993.175511836484, 11396.316221026766, 9553.904460955302, 9586.712398628053, 9602.66390676351, 9671.90328096738, 9994.850077248702, 9069.682561110329, 9153.77115572116, 9256.07439256069, 9315.487648179143, 9473.905260947302, 9306.615492182482, 9443.291753118407, 9618.182454491447, 9945.403275803186, 10290.691279261635, 7968.84062318762, 7975.601219939096, 8347.248747612744, 8376.911001569757, 9492.335536512377, 9211.907880921104, 9278.396904201205, 9279.536023198949, 9560.0, 10061.094501494901], "value": 8968.084075143288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8228971378578, 1428.2216192175263, 1463.282991334246, 1483.7329280729468, 1484.4136566056409, 8827.558622068895, 9425.104615061575, 9431.292653051023, 9438.622455101797, 9451.149396554309, 9276.58255378508, 9342.112499312554, 9720.854187187198, 9741.659041933533, 10025.949870250639, 2124.3308357867263, 2161.675748637709, 2164.199246278871, 2165.4802847316687, 2165.545235500547, 2015.7782643909159, 2028.8072633099905, 2039.2658642888548, 2045.4068320187127, 2048.252387878421, 2092.5814837032576, 2092.9790702092937, 2115.196225434333, 2115.4605575578207, 2116.947076323089, 2021.413790000898, 2044.2231951858348, 2047.692846073086, 2049.0369526322606, 2050.7539095308507, 1898.392514395394, 1951.3853136262032, 2021.6563184258712, 2023.7773844877051, 2043.989780051105, 9549.045095490465, 9569.425834449956, 9601.183899368561, 9606.471644059575, 9612.18296444803, 4711.670183087185, 4801.399825021872, 4803.279508073782, 4823.252395878644, 4837.080954618611, 2809.5083360411845, 2844.459552685004, 2904.0416662501325, 3003.6245469316336, 3006.4137493188837, 1024.7386916336286, 1077.8814330423647, 1092.792369449802, 1130.7964566378048, 1147.701597584634, 12127.272363658121, 12531.749365012649, 13722.65693357674, 13921.373538190704, 14137.293135343192, 4048.716589838683, 4138.937915931264, 4150.958490415118, 4154.189932963043, 4175.06061136248, 10629.202809789296, 10652.680419587425, 10673.73315667099, 10674.199435042248, 10677.679669609925, 4113.1568028554075, 4276.957230427718, 4857.9028419431415, 4859.854204373874, 4863.781129849165, 4244.108737165168, 4399.802008909607, 4429.047754732748, 4457.0, 4461.375407442961, 3232.5474433579316, 3314.2708604107056, 3404.1829960809227, 3438.5014172944784, 3449.7067749241596, 913.0321858829661, 913.9405938613969, 920.4753290624413, 921.6267411698273, 926.6432423516994, 657.5627207906784, 659.9175103112111, 682.4915437998624, 683.2211279141783, 688.9207741109736, 5633.746481408347, 5882.264716910387, 5917.615355001911, 5964.135200395918, 6197.163382943245, 920.4385324951774, 930.1535602601735, 935.4901578639658, 942.4627962061696, 971.3734641156415, 3804.334241507725, 4137.565555616678, 4266.552012038754, 4362.192994296065, 4375.562443755599, 11915.70210744721, 12164.513419463123, 12165.939170304091, 12170.756584868253, 12196.085293603015, 11470.139739519569, 11751.764964700658, 12062.155649104478, 12082.456289466994, 12091.45588448522, 8802.691905783267, 8803.515806630698, 9044.321675874337, 9049.77375565616, 9058.954705226432, 6117.571769976059, 6223.688815559113, 6242.531810114168, 6295.307516173309, 6296.842578935563, 10790.56837726482, 10803.513841877291, 10805.621803236849, 10817.729556760829, 10820.837687434538, 9813.26400519978, 10246.795064098826, 10546.894531054591, 11001.559937602726, 11096.556137754722, 7974.760757177294, 8188.713395031384, 8232.34141268709, 8313.293370063371, 8332.750017499484, 8735.606897689491, 8779.648814047621, 8792.208701216921, 8794.648214071365, 8828.470291782514, 7731.626519568846, 7905.960470197612, 7956.9602151988865, 8046.074701409413, 8107.47301425429, 7700.114486834086, 7705.075390953121, 7710.151883292721, 7720.420968427278, 7749.92250077492, 7017.4386049116965, 7103.573785572882, 7179.389751870941, 7180.138383394026, 7193.784186474414, 5169.741512924414, 5283.260343551982, 5294.735263236746, 5308.946910531, 5340.332458442695, 5107.668001579886, 5142.871428214325, 5150.922736159036, 5181.326427564392, 5275.472452754694], "value": 4500.027551377383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.11399059346934, 355.64968506021575, 367.4561648759835, 377.44515562123667, 382.8468612554976, 4742.241241401376, 4802.6157907367415, 4923.5076492350745, 4937.87655308617, 4982.701037937722, 4719.834805781798, 4798.640101992347, 4846.418429788421, 4860.538248866361, 4863.829765958192, 4158.97920510397, 4163.0, 4173.64524015459, 4176.895577610561, 4178.268802959486, 4001.659858911996, 4102.671786257092, 4161.708680392374, 4191.0, 4194.266003449399, 4131.710780245384, 4154.43915071466, 4160.105577300879, 4160.56314087021, 4161.148289011391, 4133.379993001044, 4139.937900931488, 4148.771817550049, 4160.147169830193, 4177.26897792885, 3996.840126394941, 4022.839086436539, 4052.189562087565, 4059.7158198926086, 4060.4315395844606, 4664.976675116636, 4716.097133059549, 4739.620830333565, 4748.810047598092, 4750.382450281476, 4813.66304358695, 4845.685030473008, 4851.490593487703, 4853.762290615906, 4856.927146092811, 5162.6128040397125, 5167.328247327823, 5179.223116532513, 5182.948170518284, 5185.603429753517, 3913.863014794497, 4131.8514372526415, 4151.8962025949295, 4170.91658166838, 4445.644348452116, 5368.973155134199, 5377.0, 5379.300690910157, 5380.91928621071, 5402.297701298845, 4283.614474697292, 4290.785460726951, 4291.9785401072795, 4303.849365272201, 4309.5778393130195, 4115.609017143426, 4305.354196870495, 4351.891202719958, 4366.170427618806, 4375.081232941118, 4601.746903920316, 4610.593768900518, 4620.745858977789, 4627.629789616823, 4627.791749371287, 5105.004524117761, 5121.385433747974, 5125.769340379692, 5126.718030508283, 5151.484851514819, 1361.6255529729403, 1371.5131128449457, 1389.6248013036422, 1450.7668481790604, 1459.3797636004656, 1097.2319376436367, 1108.6563165418584, 1110.5890820396505, 1120.641394753671, 1122.231271578971, 4320.589543993316, 4369.60673539383, 4376.562343765598, 4387.897316009541, 4397.1205758848355, 5097.93533618885, 5107.87230319245, 5111.67418824434, 5137.743112844343, 5152.433232344439, 4352.914564462637, 4368.781560922005, 4376.846810361622, 4402.16358891816, 4404.207242696281, 2592.8833202505934, 2692.2192564156176, 2700.865636432703, 2702.2298644886505, 2707.620933069372, 4755.453122890843, 4758.595519380891, 4764.714117152982, 4764.833230836974, 4803.495632958489, 5062.6709263898465, 5221.947780522146, 5229.816956406507, 5239.0, 5247.790088396498, 4904.950950490521, 4950.183219768698, 4953.504649535162, 4956.925646115384, 4957.7769000395065, 5277.920831187458, 5288.127458969227, 5291.497307755911, 5333.280007199133, 5345.599080068932, 4901.803927842846, 5165.7675404607635, 5199.324087868553, 5222.556082732858, 5233.911991924782, 4914.778834952364, 4937.975310123426, 4940.901181976412, 4955.529224723646, 4962.478939711423, 4258.0, 4290.099079193405, 4314.9784251078545, 4325.870223893288, 4329.264025115801, 5140.614453915897, 5304.814331498534, 5319.601029922694, 5324.893502130013, 5344.35867695879, 5101.8724531887, 5137.8201762938115, 5142.408623008402, 5149.407818100966, 5158.509941555696, 5082.771275292695, 5118.436971933159, 5147.974260128825, 5168.53483186515, 5181.3782346118705, 4831.782569784438, 5041.798328066836, 5063.215201643751, 5069.543741063322, 5105.591552675852, 5137.743112844418, 5158.638895277445, 5167.948320516897, 5179.300794392709, 5195.350581177353, 5008.524190201925, 5025.522575355335, 5059.443461219336, 5060.240963855451, 5074.923876141935], "value": 4034.887898716558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.9098230756543, 632.2792017100509, 710.7100612388515, 730.6237287796785, 748.3115533708989, 12224.3276619786, 12623.621291361262, 12655.683607909807, 12669.873301266985, 12692.492300307988, 12581.622551323451, 12584.05619578533, 12619.36903154841, 12620.053495987791, 12677.175983561063, 821.7534739578117, 824.7031068815222, 835.1690068381969, 836.7406104107715, 844.4046946902449, 843.4180415513276, 853.56894768142, 854.0093491549803, 854.090393730678, 854.1927878155146, 899.8965119011332, 900.5857305639381, 901.265468643057, 901.4230892228978, 901.6618767962015, 890.2566357091836, 890.7639475538988, 891.006527721589, 891.31814162166, 891.8394688955985, 658.2857599504543, 659.2780904909117, 660.445226010149, 660.795153502411, 660.9834754131138, 13675.658108547266, 13947.302634868216, 14067.929660351632, 14138.50515231962, 14150.929245353707, 11264.549418023269, 11356.943215283953, 11572.652820415316, 11951.103667224992, 12872.806907896389, 11578.53685852565, 11797.115216358807, 11824.408779561074, 11878.762424751456, 11948.283103013848, 3934.3705007198996, 4063.0, 4068.7151899367054, 4150.335946248586, 4167.1040726244, 57794.42205577932, 59651.105233421535, 59954.40045599532, 60341.39658603402, 60518.0, 8949.865752013726, 9118.635254589875, 9364.578593963288, 9367.0, 9553.952230238805, 15237.0, 15686.68626627461, 15711.68576628461, 15716.764248536052, 15750.0, 6011.849703757441, 6421.775237866652, 6444.258910225384, 6457.580257283262, 6466.062420948936, 3319.1038419626566, 3330.9500357494658, 3510.5962814276686, 3569.44673575591, 3579.284143171376, 2805.1724741201397, 2897.0, 2897.5074237379695, 2902.8693708783157, 2910.5779661949323, 475.99048019039424, 480.71877951398125, 481.78801327415823, 484.56147186796005, 486.1079918349797, 563.6449037106679, 574.7672192761938, 597.4831770518557, 603.3453702732496, 609.0954931926086, 7623.275788800055, 7625.504342217738, 7805.258500442449, 7901.0, 9125.680601178927, 503.57699532392235, 510.07930685113723, 523.7878659143054, 600.984336471362, 650.6459202809524, 3638.6179451157777, 3717.739758216953, 3742.925141497155, 3771.528558930134, 3951.940720889189, 55465.0, 57028.144577831365, 57923.71038144867, 59625.701871491234, 59627.701861490415, 50225.0, 51332.23001654978, 51419.0, 51470.742646286526, 53214.20178697323, 45175.54824451779, 45259.0, 45502.77248613802, 46028.30957535573, 46705.2994205094, 7438.107427108782, 7557.811054723676, 7779.37764978789, 7821.0, 7898.763037108896, 30721.69278307188, 30941.535876961414, 31521.21196970094, 32108.0, 32753.672463275063, 36963.26073478569, 37281.6271837289, 37291.81354093212, 37952.430713538764, 41721.0, 10852.240343175901, 10918.399488028235, 10925.56297748113, 11177.385243811668, 11537.077033837106, 11721.0, 11722.472488738198, 11885.881141188824, 12494.875051249372, 12509.311987840756, 10268.948655256676, 10355.0, 10525.473726313501, 10871.456427178768, 10873.347599144077, 10624.84062739075, 10757.784844302914, 11146.55413783472, 11243.66269011931, 11253.549858005588, 11412.543498259976, 11812.0, 11988.280703157838, 11993.880061199276, 12530.49878004906, 9218.539073046186, 9460.858087128561, 9662.806743864943, 9722.513874306398, 9752.85370719454, 8172.426607209216, 8305.377096717892, 9164.633414663605, 9293.442393456415, 9338.159565639126], "value": 6086.883566600366, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 120.0, 119.0, 118.0, 117.0, 120.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 126.0, 163.0, 125.0, 125.0, 124.0, 124.0, 148.0, 130.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 164.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 113.0, 77.0, 77.0, 78.0, 77.0, 97.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 83.0, 84.0, 84.0, 118.0, 83.0, 84.0, 116.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 149.0, 149.0, 149.0, 150.0, 148.0, 148.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 90.0, 89.0, 94.0, 85.0, 95.0, 92.0, 84.0, 85.0, 95.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 135.0, 143.0, 135.0, 134.0, 135.0, 135.0, 180.0, 163.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 187.0, 185.0, 182.0, 190.0, 184.0, 181.0, 184.0, 183.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0], "value": 68.5, "unit": "score"}]}]} 05:53:32 INFO - Return code: 0 05:53:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:32 ERROR - # TBPL SUCCESS # 05:53:32 INFO - Running post-action listener: _resource_record_post_action 05:53:32 INFO - [mozharness: 2017-03-02 13:53:32.762876Z] Finished run-tests step (success) 05:53:32 INFO - Running post-run listener: _resource_record_post_run 05:53:32 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359686144; Read time: 16; Write time: 299772 05:53:32 INFO - TinderboxPrint: CPU usage
13.1% 05:53:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:53:32 INFO - TinderboxPrint: I/O write bytes / time
359,686,144 / 299,772 05:53:32 INFO - TinderboxPrint: CPU idle
8,360.5 (86.9%) 05:53:32 INFO - TinderboxPrint: CPU user
1,217.5 (12.6%) 05:53:32 INFO - TinderboxPrint: Swap in / out
0 / 0 05:53:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104964096; Read time: 0; Write time: 104720 05:53:32 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254722048; Read time: 16; Write time: 195052 05:53:33 INFO - Running post-run listener: _upload_blobber_files 05:53:33 INFO - Blob upload gear active. 05:53:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:33 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 05:53:33 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'] 05:53:33 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 05:53:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:53:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:34 INFO - (blobuploader) - INFO - Done attempting. 05:53:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:35 INFO - (blobuploader) - INFO - Done attempting. 05:53:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:39 INFO - (blobuploader) - INFO - Done attempting. 05:53:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:39 INFO - (blobuploader) - INFO - Done attempting. 05:53:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:39 INFO - Return code: 0 05:53:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88a800e0844efb410bab3a9f6efb2fa7af83b23a0a4d76b3e32baca351dd0afff4bd197b82b7ff330ab913b13b0719dee86b8c4cbac02c13425b1325df3f45a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f838c5c798a705e9c78e348c2e6167918ac44f0c8fd2f489a1195e3e32e79d66399f19188da5cc22187e249cbf4c3f64c5cb032edaa81a5b3c94fb8b517a6521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3259487a3ca23e488da6d9789cad8ea73270a5a328c8635cc8b80a5ac8a219878af44f76c5099640650a3a16e6d221642e6cc6b6a863231fa30fa4e202874117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792a764d5615f4d1bb9e9cf59d5a088a7a2cacea9e9e7055e4aba89c2b4ff6841a3ecedba768f4433c3bf8e5517d16b35b091f49a59d84637f49cf352a2a4dff"} 05:53:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:39 INFO - Contents: 05:53:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88a800e0844efb410bab3a9f6efb2fa7af83b23a0a4d76b3e32baca351dd0afff4bd197b82b7ff330ab913b13b0719dee86b8c4cbac02c13425b1325df3f45a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f838c5c798a705e9c78e348c2e6167918ac44f0c8fd2f489a1195e3e32e79d66399f19188da5cc22187e249cbf4c3f64c5cb032edaa81a5b3c94fb8b517a6521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3259487a3ca23e488da6d9789cad8ea73270a5a328c8635cc8b80a5ac8a219878af44f76c5099640650a3a16e6d221642e6cc6b6a863231fa30fa4e202874117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792a764d5615f4d1bb9e9cf59d5a088a7a2cacea9e9e7055e4aba89c2b4ff6841a3ecedba768f4433c3bf8e5517d16b35b091f49a59d84637f49cf352a2a4dff"} 05:53:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:39 INFO - Copying logs to upload dir... 05:53:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.688924 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-03-02 05:53:37.888224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 05:53:37.892066) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88a800e0844efb410bab3a9f6efb2fa7af83b23a0a4d76b3e32baca351dd0afff4bd197b82b7ff330ab913b13b0719dee86b8c4cbac02c13425b1325df3f45a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f838c5c798a705e9c78e348c2e6167918ac44f0c8fd2f489a1195e3e32e79d66399f19188da5cc22187e249cbf4c3f64c5cb032edaa81a5b3c94fb8b517a6521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3259487a3ca23e488da6d9789cad8ea73270a5a328c8635cc8b80a5ac8a219878af44f76c5099640650a3a16e6d221642e6cc6b6a863231fa30fa4e202874117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792a764d5615f4d1bb9e9cf59d5a088a7a2cacea9e9e7055e4aba89c2b4ff6841a3ecedba768f4433c3bf8e5517d16b35b091f49a59d84637f49cf352a2a4dff"} build_url:https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/M9KVlWcUQ0KxQdxlqY4exQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88a800e0844efb410bab3a9f6efb2fa7af83b23a0a4d76b3e32baca351dd0afff4bd197b82b7ff330ab913b13b0719dee86b8c4cbac02c13425b1325df3f45a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f838c5c798a705e9c78e348c2e6167918ac44f0c8fd2f489a1195e3e32e79d66399f19188da5cc22187e249cbf4c3f64c5cb032edaa81a5b3c94fb8b517a6521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3259487a3ca23e488da6d9789cad8ea73270a5a328c8635cc8b80a5ac8a219878af44f76c5099640650a3a16e6d221642e6cc6b6a863231fa30fa4e202874117", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/792a764d5615f4d1bb9e9cf59d5a088a7a2cacea9e9e7055e4aba89c2b4ff6841a3ecedba768f4433c3bf8e5517d16b35b091f49a59d84637f49cf352a2a4dff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 05:53:37.917048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:53:37.917356) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1488459156.829406-624313902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 05:53:38.000523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 05:53:38.000838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 05:53:38.001141) ========= ========= Total master_lag: 0.14 =========