builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-083 starttime: 1488819904.59 results: success (0) revision: f4caa69ef5f2b363944b62225d3daa68d1687a3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.592295) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.592778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.593251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.629822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.630194) ========= 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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-06 09:05:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-03-06 09:05:05 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096666 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.747673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.747984) ========= 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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018791 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:04.813051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 09:05:04.813383) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f4caa69ef5f2b363944b62225d3daa68d1687a3b --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 f4caa69ef5f2b363944b62225d3daa68d1687a3b --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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-06 09:05:05,551 truncating revision to first 12 chars 2017-03-06 09:05:05,551 Setting DEBUG logging. 2017-03-06 09:05:05,551 attempt 1/10 2017-03-06 09:05:05,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f4caa69ef5f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-06 09:05:06,528 unpacking tar archive at: mozilla-central-f4caa69ef5f2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.360457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 09:05:06.190467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:06.190791) ========= script_repo_revision: f4caa69ef5f2b363944b62225d3daa68d1687a3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:06.191176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:06.191436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 09:05:06.200403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-06 09:05:06.200792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:07 INFO - MultiFileLogger online at 20170306 09:05:07 in /builds/slave/test 09:05:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:05:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:07 INFO - {'append_to_log': False, 09:05:07 INFO - 'base_work_dir': '/builds/slave/test', 09:05:07 INFO - 'blob_upload_branch': 'Firefox', 09:05:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:07 INFO - 'branch': 'Firefox', 09:05:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:07 INFO - 'config_files': ('talos/linux_config.py',), 09:05:07 INFO - 'default_actions': ('clobber', 09:05:07 INFO - 'read-buildbot-config', 09:05:07 INFO - 'download-and-extract', 09:05:07 INFO - 'populate-webroot', 09:05:07 INFO - 'create-virtualenv', 09:05:07 INFO - 'install', 09:05:07 INFO - 'run-tests'), 09:05:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:07 INFO - 'download_minidump_stackwalk': True, 09:05:07 INFO - 'download_symbols': 'ondemand', 09:05:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:07 INFO - 'gecko_profile': False, 09:05:07 INFO - 'gecko_profile_interval': 0, 09:05:07 INFO - 'installer_path': 'installer.exe', 09:05:07 INFO - 'log_level': 'info', 09:05:07 INFO - 'log_name': 'talos', 09:05:07 INFO - 'log_to_console': True, 09:05:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:07 INFO - 'opt_config_files': (), 09:05:07 INFO - 'pip_index': False, 09:05:07 INFO - 'suite': 'dromaeojs', 09:05:07 INFO - 'system_bits': '32', 09:05:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:07 INFO - 'title': 'talos-linux64-ix-083', 09:05:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:07 INFO - 'use_talos_json': True, 09:05:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:07 INFO - 'work_dir': 'build'} 09:05:07 INFO - [mozharness: 2017-03-06 17:05:07.032184Z] Running clobber step. 09:05:07 INFO - Running pre-action listener: _resource_record_pre_action 09:05:07 INFO - Running main action method: clobber 09:05:07 INFO - rmtree: /builds/slave/test/build 09:05:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:08 INFO - Running post-action listener: _resource_record_post_action 09:05:08 INFO - [mozharness: 2017-03-06 17:05:08.453750Z] Finished clobber step (success) 09:05:08 INFO - [mozharness: 2017-03-06 17:05:08.453849Z] Running read-buildbot-config step. 09:05:08 INFO - Running pre-action listener: _resource_record_pre_action 09:05:08 INFO - Running main action method: read_buildbot_config 09:05:08 INFO - Using buildbot properties: 09:05:08 INFO - { 09:05:08 INFO - "project": "", 09:05:08 INFO - "product": "firefox", 09:05:08 INFO - "who": "cbook@mozilla.com", 09:05:08 INFO - "installer_path": "public/build/target.tar.bz2", 09:05:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:05:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:05:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 09:05:08 INFO - "stage_platform": "linux64-pgo", 09:05:08 INFO - "basedir": "/builds/slave/test", 09:05:08 INFO - "buildnumber": 71, 09:05:08 INFO - "platform": "ubuntu64_hw", 09:05:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:08 INFO - "slavebuilddir": "test", 09:05:08 INFO - "taskId": "WmJNXns5RK6M0n4Varg4Zw", 09:05:08 INFO - "branch": "mozilla-central", 09:05:08 INFO - "script_repo_revision": "production", 09:05:08 INFO - "revision": "f4caa69ef5f2b363944b62225d3daa68d1687a3b", 09:05:08 INFO - "slavename": "talos-linux64-ix-083", 09:05:08 INFO - "repo_path": "mozilla-central" 09:05:08 INFO - } 09:05:08 INFO - Finding installer, test and symbols from parent task. 09:05:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmJNXns5RK6M0n4Varg4Zw'}, attempt #1 09:05:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WmJNXns5RK6M0n4Varg4Zw'}, attempt #1 09:05:09 INFO - Task dependencies: Q4cI9DpLRMe6aVNfvclp-g 09:05:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g'}, attempt #1 09:05:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 09:05:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/test_packages.json 09:05:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.crashreporter-symbols.zip 09:05:09 INFO - Running post-action listener: _resource_record_post_action 09:05:09 INFO - [mozharness: 2017-03-06 17:05:09.849551Z] Finished read-buildbot-config step (success) 09:05:09 INFO - [mozharness: 2017-03-06 17:05:09.849768Z] Running download-and-extract step. 09:05:09 INFO - Running pre-action listener: _resource_record_pre_action 09:05:09 INFO - Running main action method: download_and_extract 09:05:09 INFO - mkdir: /builds/slave/test/build/tests 09:05: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')]} 09:05:09 INFO - trying https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.test_packages.json 09:05:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:05:10 INFO - Downloaded 896 bytes. 09:05:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:05:10 INFO - Using the following test package requirements: 09:05:10 INFO - {u'common': [u'target.common.tests.zip'], 09:05:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:05:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:05:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:05:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:05:10 INFO - u'mozbase': [u'target.common.tests.zip'], 09:05:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:05:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:05:10 INFO - u'web-platform': [u'target.common.tests.zip', 09:05:10 INFO - u'target.web-platform.tests.zip'], 09:05:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:05:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:05:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip 09:05:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip into memory 09:05:11 INFO - Expected file size: 59623628 09:05:11 INFO - Obtained file size: 59623628 09:05:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:05:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip 09:05:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.common.tests.zip into memory 09:05:23 INFO - Expected file size: 59623628 09:05:23 INFO - Obtained file size: 59623628 09:05:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.talos.tests.zip 09:05:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:05:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.talos.tests.zip into memory 09:05:34 INFO - Expected file size: 14404424 09:05:34 INFO - Obtained file size: 14404424 09:05: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')]} 09:05:35 INFO - trying https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 09:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:05:36 INFO - Downloaded 67004023 bytes. 09:05:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 09:05:36 INFO - mkdir: /builds/slave/test/properties 09:05:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:36 INFO - Contents: 09:05:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 09:05:36 INFO - Running post-action listener: _resource_record_post_action 09:05:36 INFO - Running post-action listener: set_extra_try_arguments 09:05:36 INFO - [mozharness: 2017-03-06 17:05:36.280832Z] Finished download-and-extract step (success) 09:05:36 INFO - [mozharness: 2017-03-06 17:05:36.280929Z] Running populate-webroot step. 09:05:36 INFO - Running pre-action listener: _resource_record_pre_action 09:05:36 INFO - Running main action method: populate_webroot 09:05:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:36 INFO - '--tppagecycles', 09:05:36 INFO - '7'], 09:05:36 INFO - 'tests': ['tsvgm']}}, 09:05:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['damp', 'tps']}, 09:05:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'tests': ['damp', 'tps']}, 09:05:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['dromaeo_dom']}, 09:05:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['basic_compositor_video']}, 09:05:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['a11yr', 09:05:36 INFO - 'ts_paint', 09:05:36 INFO - 'tpaint', 09:05:36 INFO - 'sessionrestore', 09:05:36 INFO - 'sessionrestore_no_auto_restore', 09:05:36 INFO - 'tabpaint']}, 09:05:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['tsvgx', 09:05:36 INFO - 'tsvgr_opacity', 09:05:36 INFO - 'tart', 09:05:36 INFO - 'tscrollx', 09:05:36 INFO - 'cart', 09:05:36 INFO - 'tsvg_static']}, 09:05:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:36 INFO - 'tsvgr_opacity', 09:05:36 INFO - 'tart', 09:05:36 INFO - 'tscrollx', 09:05:36 INFO - 'cart', 09:05:36 INFO - 'tsvg_static']}, 09:05:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'talos_options': ['--disable-e10s'], 09:05:36 INFO - 'tests': ['tp5o']}, 09:05:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:05:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'talos_options': ['--disable-e10s', 09:05:36 INFO - '--xperf_path', 09:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:36 INFO - 'tests': ['tp5n']}, 09:05:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:05:36 INFO - 'talos_options': ['--xperf_path', 09:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:36 INFO - 'tests': ['tp5n']}}, 09:05:36 INFO - 'talos.zip': {'path': '', 09:05:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:36 INFO - Running post-action listener: _resource_record_post_action 09:05:36 INFO - [mozharness: 2017-03-06 17:05:36.294069Z] Finished populate-webroot step (success) 09:05:36 INFO - [mozharness: 2017-03-06 17:05:36.294163Z] Running create-virtualenv step. 09:05:36 INFO - Running pre-action listener: _resource_record_pre_action 09:05:36 INFO - Running main action method: create_virtualenv 09:05:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:36 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 09:05:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:36 INFO - Using real prefix '/usr' 09:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:38 INFO - Installing pip.................done. 09:05:38 INFO - Return code: 0 09:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:39 INFO - Reading from file tmpfile_stdout 09:05:39 INFO - Output received: 09:05:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:39 INFO - Using env: {'DISPLAY': ':0', 09:05:39 INFO - 'HOME': '/home/cltbld', 09:05:39 INFO - 'LANG': 'en_US.UTF-8', 09:05:39 INFO - 'LANGUAGE': 'en_US:en', 09:05:39 INFO - 'LOGNAME': 'cltbld', 09:05:39 INFO - 'MAIL': '/var/mail/cltbld', 09:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:39 INFO - 'MOZ_NO_REMOTE': '1', 09:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:39 INFO - 'NO_EM_RESTART': '1', 09:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:39 INFO - 'PWD': '/builds/slave/test', 09:05:39 INFO - 'SHELL': '/bin/bash', 09:05:39 INFO - 'SHLVL': '1', 09:05:39 INFO - 'TERM': 'linux', 09:05:39 INFO - 'TMOUT': '86400', 09:05:39 INFO - 'USER': 'cltbld', 09:05:39 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:39 INFO - '_': '/tools/buildbot/bin/python'} 09:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:39 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 09:05:39 INFO - Cleaning up... 09:05:39 INFO - Return code: 0 09:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:39 INFO - Using env: {'DISPLAY': ':0', 09:05:39 INFO - 'HOME': '/home/cltbld', 09:05:39 INFO - 'LANG': 'en_US.UTF-8', 09:05:39 INFO - 'LANGUAGE': 'en_US:en', 09:05:39 INFO - 'LOGNAME': 'cltbld', 09:05:39 INFO - 'MAIL': '/var/mail/cltbld', 09:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:39 INFO - 'MOZ_NO_REMOTE': '1', 09:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:39 INFO - 'NO_EM_RESTART': '1', 09:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:39 INFO - 'PWD': '/builds/slave/test', 09:05:39 INFO - 'SHELL': '/bin/bash', 09:05:39 INFO - 'SHLVL': '1', 09:05:39 INFO - 'TERM': 'linux', 09:05:39 INFO - 'TMOUT': '86400', 09:05:39 INFO - 'USER': 'cltbld', 09:05:39 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:39 INFO - '_': '/tools/buildbot/bin/python'} 09:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:39 INFO - Downloading/unpacking psutil>=3.1.1 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:41 INFO - Installing collected packages: psutil 09:05:41 INFO - Running setup.py install for psutil 09:05:41 INFO - building 'psutil._psutil_linux' extension 09:05:41 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 09:05:41 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 09:05:41 INFO - building 'psutil._psutil_posix' extension 09:05:41 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 09:05:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:42 INFO - Successfully installed psutil 09:05:42 INFO - Cleaning up... 09:05:42 INFO - Return code: 0 09:05:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:05:42 INFO - Using env: {'DISPLAY': ':0', 09:05:42 INFO - 'HOME': '/home/cltbld', 09:05:42 INFO - 'LANG': 'en_US.UTF-8', 09:05:42 INFO - 'LANGUAGE': 'en_US:en', 09:05:42 INFO - 'LOGNAME': 'cltbld', 09:05:42 INFO - 'MAIL': '/var/mail/cltbld', 09:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:42 INFO - 'MOZ_NO_REMOTE': '1', 09:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:42 INFO - 'NO_EM_RESTART': '1', 09:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:42 INFO - 'PWD': '/builds/slave/test', 09:05:42 INFO - 'SHELL': '/bin/bash', 09:05:42 INFO - 'SHLVL': '1', 09:05:42 INFO - 'TERM': 'linux', 09:05:42 INFO - 'TMOUT': '86400', 09:05:42 INFO - 'USER': 'cltbld', 09:05:42 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:42 INFO - '_': '/tools/buildbot/bin/python'} 09:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:42 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 09:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:44 INFO - Installing collected packages: mozsystemmonitor 09:05:44 INFO - Running setup.py install for mozsystemmonitor 09:05:44 INFO - Successfully installed mozsystemmonitor 09:05:44 INFO - Cleaning up... 09:05:44 INFO - Return code: 0 09:05:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 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 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:44 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 09:05:44 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 09:05:44 INFO - Using env: {'DISPLAY': ':0', 09:05:44 INFO - 'HOME': '/home/cltbld', 09:05:44 INFO - 'LANG': 'en_US.UTF-8', 09:05:44 INFO - 'LANGUAGE': 'en_US:en', 09:05:44 INFO - 'LOGNAME': 'cltbld', 09:05:44 INFO - 'MAIL': '/var/mail/cltbld', 09:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:44 INFO - 'MOZ_NO_REMOTE': '1', 09:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:44 INFO - 'NO_EM_RESTART': '1', 09:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:44 INFO - 'PWD': '/builds/slave/test', 09:05:44 INFO - 'SHELL': '/bin/bash', 09:05:44 INFO - 'SHLVL': '1', 09:05:44 INFO - 'TERM': 'linux', 09:05:44 INFO - 'TMOUT': '86400', 09:05:44 INFO - 'USER': 'cltbld', 09:05:44 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:44 INFO - '_': '/tools/buildbot/bin/python'} 09:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:46 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 09:05:46 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 09:05:46 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 09:05:46 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 09:05:46 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 09:05:46 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 09:05:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:47 INFO - warning: no files found matching '*.txt' 09:05:47 INFO - no previously-included directories found matching 'build' 09:05:47 INFO - no previously-included directories found matching 'dist' 09:05:47 INFO - no previously-included directories found matching '.git*' 09:05:47 INFO - Installing collected packages: jsonschema, functools32 09:05:47 INFO - Running setup.py install for functools32 09:05:47 INFO - warning: no files found matching '*.txt' 09:05:47 INFO - no previously-included directories found matching 'build' 09:05:47 INFO - no previously-included directories found matching 'dist' 09:05:47 INFO - no previously-included directories found matching '.git*' 09:05:47 INFO - Successfully installed jsonschema functools32 09:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:05:47 INFO - Using env: {'DISPLAY': ':0', 09:05:47 INFO - 'HOME': '/home/cltbld', 09:05:47 INFO - 'LANG': 'en_US.UTF-8', 09:05:47 INFO - 'LANGUAGE': 'en_US:en', 09:05:47 INFO - 'LOGNAME': 'cltbld', 09:05:47 INFO - 'MAIL': '/var/mail/cltbld', 09:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:47 INFO - 'MOZ_NO_REMOTE': '1', 09:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:47 INFO - 'NO_EM_RESTART': '1', 09:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:47 INFO - 'PWD': '/builds/slave/test', 09:05:47 INFO - 'SHELL': '/bin/bash', 09:05:47 INFO - 'SHLVL': '1', 09:05:47 INFO - 'TERM': 'linux', 09:05:47 INFO - 'TMOUT': '86400', 09:05:47 INFO - 'USER': 'cltbld', 09:05:47 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:47 INFO - '_': '/tools/buildbot/bin/python'} 09:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:47 INFO - Using env: {'DISPLAY': ':0', 09:05:47 INFO - 'HOME': '/home/cltbld', 09:05:47 INFO - 'LANG': 'en_US.UTF-8', 09:05:47 INFO - 'LANGUAGE': 'en_US:en', 09:05:47 INFO - 'LOGNAME': 'cltbld', 09:05:47 INFO - 'MAIL': '/var/mail/cltbld', 09:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:47 INFO - 'MOZ_NO_REMOTE': '1', 09:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:47 INFO - 'NO_EM_RESTART': '1', 09:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:47 INFO - 'PWD': '/builds/slave/test', 09:05:47 INFO - 'SHELL': '/bin/bash', 09:05:47 INFO - 'SHLVL': '1', 09:05:47 INFO - 'TERM': 'linux', 09:05:47 INFO - 'TMOUT': '86400', 09:05:47 INFO - 'USER': 'cltbld', 09:05:47 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:47 INFO - '_': '/tools/buildbot/bin/python'} 09:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:50 INFO - Downloading docopt-0.6.1.tar.gz 09:05:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:50 INFO - Running setup.py install for blobuploader 09:05:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:50 INFO - Running setup.py install for requests 09:05:51 INFO - Running setup.py install for docopt 09:05:51 INFO - Successfully installed blobuploader requests docopt 09:05:51 INFO - Cleaning up... 09:05:51 INFO - Return code: 0 09:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:51 INFO - Using env: {'DISPLAY': ':0', 09:05:51 INFO - 'HOME': '/home/cltbld', 09:05:51 INFO - 'LANG': 'en_US.UTF-8', 09:05:51 INFO - 'LANGUAGE': 'en_US:en', 09:05:51 INFO - 'LOGNAME': 'cltbld', 09:05:51 INFO - 'MAIL': '/var/mail/cltbld', 09:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:51 INFO - 'MOZ_NO_REMOTE': '1', 09:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:51 INFO - 'NO_EM_RESTART': '1', 09:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:51 INFO - 'PWD': '/builds/slave/test', 09:05:51 INFO - 'SHELL': '/bin/bash', 09:05:51 INFO - 'SHLVL': '1', 09:05:51 INFO - 'TERM': 'linux', 09:05:51 INFO - 'TMOUT': '86400', 09:05:51 INFO - 'USER': 'cltbld', 09:05:51 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:51 INFO - '_': '/tools/buildbot/bin/python'} 09:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:51 INFO - Running setup.py (path:/tmp/pip-zDxTwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:51 INFO - Running setup.py (path:/tmp/pip-g7Bci6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:51 INFO - Running setup.py (path:/tmp/pip-wD_L9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:51 INFO - Running setup.py (path:/tmp/pip-O9qmho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:51 INFO - Running setup.py (path:/tmp/pip-XS9Tzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:51 INFO - Running setup.py (path:/tmp/pip-ocuElm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:51 INFO - Running setup.py (path:/tmp/pip-R9CR77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:51 INFO - Running setup.py (path:/tmp/pip-Crorhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:52 INFO - Running setup.py (path:/tmp/pip-WfZ3wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:52 INFO - Running setup.py (path:/tmp/pip-hzLLwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:52 INFO - Running setup.py (path:/tmp/pip-ACEpIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:52 INFO - Running setup.py (path:/tmp/pip-Eovd7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:52 INFO - Running setup.py (path:/tmp/pip-AJhuzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:52 INFO - Running setup.py (path:/tmp/pip-2ME0MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:52 INFO - Running setup.py (path:/tmp/pip-8f_PL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:52 INFO - Running setup.py (path:/tmp/pip-l_Q23t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:52 INFO - Running setup.py (path:/tmp/pip-lpIW07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:52 INFO - Running setup.py install for manifestparser 09:05:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:52 INFO - Running setup.py install for mozcrash 09:05:52 INFO - Running setup.py install for mozdebug 09:05:52 INFO - Running setup.py install for mozdevice 09:05:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozfile 09:05:53 INFO - Running setup.py install for mozhttpd 09:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozinfo 09:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozInstall 09:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozleak 09:05:53 INFO - Running setup.py install for mozlog 09:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for moznetwork 09:05:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:53 INFO - Running setup.py install for mozprocess 09:05:53 INFO - Running setup.py install for mozprofile 09:05:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Running setup.py install for mozrunner 09:05:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Running setup.py install for mozscreenshot 09:05:54 INFO - Running setup.py install for moztest 09:05:54 INFO - Running setup.py install for mozversion 09:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:54 INFO - Cleaning up... 09:05:54 INFO - Return code: 0 09:05:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:54 INFO - Using env: {'DISPLAY': ':0', 09:05:54 INFO - 'HOME': '/home/cltbld', 09:05:54 INFO - 'LANG': 'en_US.UTF-8', 09:05:54 INFO - 'LANGUAGE': 'en_US:en', 09:05:54 INFO - 'LOGNAME': 'cltbld', 09:05:54 INFO - 'MAIL': '/var/mail/cltbld', 09:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:54 INFO - 'MOZ_NO_REMOTE': '1', 09:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:54 INFO - 'NO_EM_RESTART': '1', 09:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:54 INFO - 'PWD': '/builds/slave/test', 09:05:54 INFO - 'SHELL': '/bin/bash', 09:05:54 INFO - 'SHLVL': '1', 09:05:54 INFO - 'TERM': 'linux', 09:05:54 INFO - 'TMOUT': '86400', 09:05:54 INFO - 'USER': 'cltbld', 09:05:54 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:54 INFO - '_': '/tools/buildbot/bin/python'} 09:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:54 INFO - Running setup.py (path:/tmp/pip-n1kIvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:54 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)) 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:54 INFO - Running setup.py (path:/tmp/pip-eqkSAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:54 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)) 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:54 INFO - Running setup.py (path:/tmp/pip-0V3jzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:54 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)) 09:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:54 INFO - Running setup.py (path:/tmp/pip-JN4fFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:55 INFO - Running setup.py (path:/tmp/pip-H21JCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:55 INFO - Running setup.py (path:/tmp/pip-XUnqRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:55 INFO - Running setup.py (path:/tmp/pip-50ixno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:55 INFO - Running setup.py (path:/tmp/pip-OmZ_Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:55 INFO - Running setup.py (path:/tmp/pip-ophkWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:55 INFO - Running setup.py (path:/tmp/pip-ShwvIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:55 INFO - Running setup.py (path:/tmp/pip-HMnO4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:55 INFO - Running setup.py (path:/tmp/pip-tNvih2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:55 INFO - Running setup.py (path:/tmp/pip-AWKnHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:55 INFO - Running setup.py (path:/tmp/pip-StvbjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:55 INFO - Running setup.py (path:/tmp/pip-gpX5EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:55 INFO - Running setup.py (path:/tmp/pip-aRyejv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:55 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)) 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:55 INFO - Running setup.py (path:/tmp/pip-e4ASXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:55 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)) 09:05:55 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)) 09:05:55 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)) 09:05:55 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)) 09:05:55 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)) 09:05:55 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)) 09:05:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:55 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 09:05:55 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 09:05:55 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 09:05:55 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 09:05:55 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 09:05:55 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 09:05:57 INFO - Downloading blessings-1.6.tar.gz 09:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:58 INFO - Installing collected packages: blessings 09:05:58 INFO - Running setup.py install for blessings 09:05:58 INFO - Successfully installed blessings 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:58 INFO - Reading from file tmpfile_stdout 09:05:58 INFO - Current package versions: 09:05:58 INFO - argparse == 1.2.1 09:05:58 INFO - blessings == 1.6 09:05:58 INFO - blobuploader == 1.2.4 09:05:58 INFO - docopt == 0.6.1 09:05:58 INFO - functools32 == 3.2.3-2 09:05:58 INFO - jsonschema == 2.5.1 09:05:58 INFO - manifestparser == 1.1 09:05:58 INFO - mozInstall == 1.12 09:05:58 INFO - mozcrash == 1.0 09:05:58 INFO - mozdebug == 0.1 09:05:58 INFO - mozdevice == 0.49 09:05:58 INFO - mozfile == 1.2 09:05:58 INFO - mozhttpd == 0.7 09:05:58 INFO - mozinfo == 0.9 09:05:58 INFO - mozleak == 0.1 09:05:58 INFO - mozlog == 3.4 09:05:58 INFO - moznetwork == 0.27 09:05:58 INFO - mozprocess == 0.25 09:05:58 INFO - mozprofile == 0.28 09:05:58 INFO - mozrunner == 6.13 09:05:58 INFO - mozscreenshot == 0.1 09:05:58 INFO - mozsystemmonitor == 0.3 09:05:58 INFO - moztest == 0.8 09:05:58 INFO - mozversion == 1.4 09:05:58 INFO - psutil == 3.1.1 09:05:58 INFO - requests == 1.2.3 09:05:58 INFO - wsgiref == 0.1.2 09:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f07a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2168310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, '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': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', '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 09:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:58 INFO - Cleaning up... 09:05:58 INFO - Return code: 0 09:05:58 INFO - Running post-action listener: _resource_record_post_action 09:05:58 INFO - Running post-action listener: _start_resource_monitoring 09:05:58 INFO - Starting resource monitoring. 09:05:58 INFO - [mozharness: 2017-03-06 17:05:58.956632Z] Finished create-virtualenv step (success) 09:05:58 INFO - [mozharness: 2017-03-06 17:05:58.957102Z] Running install step. 09:05:58 INFO - Running pre-action listener: _resource_record_pre_action 09:05:58 INFO - Running main action method: install 09:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:59 INFO - Reading from file tmpfile_stdout 09:05:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:59 INFO - Reading from file tmpfile_stdout 09:05:59 INFO - Output received: 09:05:59 INFO - Usage: mozinstall [options] installer 09:05:59 INFO - Options: 09:05:59 INFO - -h, --help show this help message and exit 09:05:59 INFO - -d DEST, --destination=DEST 09:05:59 INFO - Directory to install application into. [default: 09:05:59 INFO - "/builds/slave/test"] 09:05:59 INFO - --app=APP Application being installed. [default: firefox] 09:05:59 INFO - mkdir: /builds/slave/test/build/application 09:05:59 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'] 09:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:06:16 INFO - Reading from file tmpfile_stdout 09:06:16 INFO - Output received: 09:06:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:16 INFO - Running post-action listener: _resource_record_post_action 09:06:16 INFO - [mozharness: 2017-03-06 17:06:16.404341Z] Finished install step (success) 09:06:16 INFO - [mozharness: 2017-03-06 17:06:16.404617Z] Running run-tests step. 09:06:16 INFO - Running pre-action listener: _resource_record_pre_action 09:06:16 INFO - Running main action method: run_tests 09:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:16 INFO - Python 2.7.3 09:06:16 INFO - Return code: 0 09:06:16 INFO - grabbing minidump binary from tooltool 09:06:16 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')]} 09:06:16 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 0x2165400>, '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 0x21663b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2166840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:16 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 09:06:16 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 09:06:16 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 09:06:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:16 INFO - Return code: 0 09:06:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:16 INFO - ENV: RUST_BACKTRACE is now 1 09:06:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 09:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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 09:06:16 INFO - Using env: {'DISPLAY': ':0', 09:06:16 INFO - 'HOME': '/home/cltbld', 09:06:16 INFO - 'LANG': 'en_US.UTF-8', 09:06:16 INFO - 'LANGUAGE': 'en_US:en', 09:06:16 INFO - 'LOGNAME': 'cltbld', 09:06:16 INFO - 'MAIL': '/var/mail/cltbld', 09:06:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:16 INFO - 'MOZ_NO_REMOTE': '1', 09:06:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:16 INFO - 'NO_EM_RESTART': '1', 09:06:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:16 INFO - 'PWD': '/builds/slave/test', 09:06:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:16 INFO - 'RUST_BACKTRACE': '1', 09:06:16 INFO - 'SHELL': '/bin/bash', 09:06:16 INFO - 'SHLVL': '1', 09:06:16 INFO - 'TERM': 'linux', 09:06:16 INFO - 'TMOUT': '86400', 09:06:16 INFO - 'USER': 'cltbld', 09:06:16 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877', 09:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:16 INFO - '_': '/tools/buildbot/bin/python'} 09:06:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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 09:06:16 INFO - mozversion application_buildid: 20170306153320 09:06:16 INFO - mozversion application_changeset: f4caa69ef5f2b363944b62225d3daa68d1687a3b 09:06:16 INFO - mozversion application_display_name: Nightly 09:06:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:16 INFO - mozversion application_name: Firefox 09:06:16 INFO - mozversion application_remotingname: firefox 09:06:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:06:16 INFO - mozversion application_vendor: Mozilla 09:06:16 INFO - mozversion application_version: 54.0a1 09:06:16 INFO - mozversion platform_buildid: 20170306153320 09:06:16 INFO - mozversion platform_changeset: f4caa69ef5f2b363944b62225d3daa68d1687a3b 09:06:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:06:16 INFO - mozversion platform_version: 54.0a1 09:06:16 INFO - using testdate: 1488819976 09:06:16 INFO - actual date: 1488819976 09:06:16 INFO - starting webserver on 'localhost:55815' 09:06:16 INFO - SUITE-START | Running 2 tests 09:06:16 INFO - TEST-START | dromaeo_css 09:06:16 INFO - operating with platform_type : linux_ 09:06:16 INFO - Initialising browser for dromaeo_css test... 09:06:16 INFO - TEST-INFO | started process 30410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPxWXB/profile http://localhost:55815/getInfo.html) 09:06:20 INFO - PROCESS | 30410 | __metrics Screen width/height:1600/1200 09:06:20 INFO - PROCESS | 30410 | colorDepth:24 09:06:20 INFO - PROCESS | 30410 | Browser inner width/height: 1024/697 09:06:20 INFO - PROCESS | 30410 | __metrics 09:06:21 INFO - PROCESS | 30410 | 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" 09:06:21 INFO - PROCESS | 30410 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:22 INFO - TEST-INFO | 30410: exit 0 09:06:22 INFO - Browser initialized. 09:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:22 INFO - TEST-INFO | started process 30502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPxWXB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:34 INFO - PROCESS | 30502 | RSS: Main: 143458304 09:06:34 INFO - PROCESS | 30502 | 09:09:37 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55815/tests/dromaeo/cssquery-ext.html) 09:09:38 INFO - PROCESS | 30502 | RSS: Main: 275529728 09:09:38 INFO - PROCESS | 30502 | 09:11:24 INFO - PROCESS | 30502 | ************************* 09:11:24 INFO - PROCESS | 30502 | A coding exception was thrown and uncaught in a Task. 09:11:24 INFO - PROCESS | 30502 | 09:11:24 ERROR - PROCESS | 30502 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:11:24 INFO - PROCESS | 30502 | Full stack: 09:11:24 INFO - PROCESS | 30502 | ************************* 09:12:41 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-ext.html (next: http://localhost:55815/tests/dromaeo/cssquery-jquery.html) 09:12:41 INFO - PROCESS | 30502 | RSS: Main: 240525312 09:12:41 INFO - PROCESS | 30502 | 09:15:44 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55815/tests/dromaeo/cssquery-mootools.html) 09:15:44 INFO - PROCESS | 30502 | RSS: Main: 215478272 09:15:44 INFO - PROCESS | 30502 | 09:18:46 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55815/tests/dromaeo/cssquery-prototype.html) 09:18:47 INFO - PROCESS | 30502 | RSS: Main: 208658432 09:18:47 INFO - PROCESS | 30502 | 09:21:50 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55815/tests/dromaeo/cssquery-yui.html) 09:21:50 INFO - PROCESS | 30502 | RSS: Main: 182456320 09:21:50 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | Cycle 1(1): loaded http://localhost:55815/tests/dromaeo/cssquery-yui.html (next: http://localhost:55815/tests/dromaeo/cssquery-dojo.html) 09:24:53 INFO - PROCESS | 30502 | RSS: Main: 266543104 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | __start_tp_report 09:24:53 INFO - PROCESS | 30502 | _x_x_mozilla_page_load 09:24:53 INFO - PROCESS | 30502 | _x_x_mozilla_page_load_details 09:24:53 INFO - PROCESS | 30502 | |i|pagename|runs| 09:24:53 INFO - PROCESS | 30502 | |0;dojo.html;3208.5187221916717;3235.56319896814;3257.4299497587917;3264.2329052672617;3275.737940964723;5382.300300960869;5410.513053825155;5477.698726570037;5553.500184983351;5558.110702287635;5393.78424863005;5575;5597.4402559744;5656.632318899268;5699.116636921273;5122.538971492565;5126.051680439112;5144.768485418156;5163.096458119833;5182.2226666000215;5062.822801201959;5165.863510027788;5208.817691380802;5209.843704688866;5216.6869987800665;4944.851654450336;4954.3063971044085;5136.409312929024;5145.151050076752;5180.6373553851245;5016.297718319438;5029.5221953914315;5029.84910452687;5037.2695959086095;5037.924431133536;4975.0796102721115;4994.976029913859;4999.875003124951;5006.5744411725045;5008.5993120550265;5563.304586926634;5565.387807341189;5610.298712660918;5626.774929002835;5662.37713851476;5995;6012.18835457212;6017.368176341465;6020.608660437058;6022.397760223943;5858.062709966428;5868.530517558628;5972.372900845392;5987.970060149715;6064.120702498113;5516.282883225155;5521.2270282160935;5521.806736764194;5528.253685752412;5554.611177217556;6032.426919442646;6056.969715151484;6076.878462430726;6098.038923863779;6101.938980610137;5716.314042314949;5929.377415371324;5987.6108052976415;5987.64074155552;5989.341172471025;5927.525797936155;5934.584579079509;5934.584579079509;5936.257967754031;5937.406259374028;5893.44012318829;5894.67579283135;5895.55783316253;5896.086106653475;5901.704914754245;5886.058230683156;5905.379935106838;5910.734016969247;5917.52659787216;5923.378045305267;4616.699914505546;4619.445666519972;4619.653525985565;4625.6530760192445;4666;4046.3121269384274;4067.633912947849;4094.344904815215;4104.15864747726;4109.4246805447265;5411.729413529308;5522.282103326622;5532.806351777668;5535.252740880011;5568.081266591048;5816.5928385013485;5883.3234178069215;5951.464368206795;5954.4045595440975;5960.016597261403;5622.57830662702;5623.493885550321;5624.831255062355;5624.91562626561;5631.465010823965;5065.949340506548;5069.239614057921;5070.087384270793;5071.340725705634;5076.44159142494;6159.19930409044;6166.290876549075;6166.784162554289;6166.9383306167265;6169.321374648875;5811.506021988009;5865.706714664165;5943.970280148572;5944.970275148597;5945.316288626863;6052;6097.736416265211;6103.489197737777;6127.417895299939;6144.692765361625;5852.707364631837;5878.559108066997;5910.527157827278;5923.733431995484;5928.2293301872205;5953.7023148843255;5953.940460595339;5954.225950626391;5966.105084237399;5966.19456373384;5833.241678581757;5835.183074369676;5842.532597392284;5845.941540584539;5850.005499065254;5639.351474580476;5671.688057156731;5742.971285143548;5810.912836307374;5820.505257053198;5818.389069147678;5820.330661973927;5822.184894114743;5921.61509501881;5935.525157987437;5869.119632055226;5905.557083218861;5935.317438494629;5936.020556608111;5938.851528711817;5565.860853478695;5767.9134812977;5773.076307790733;5774.971125144348;5778.075507918713 09:24:53 INFO - PROCESS | 30502 | |1;ext.html;707.8548897476018;762.0169980724866;779.8206412525119;835.9665613375465;850.7787975126473;28908.277293067684;42003;42358.15283694328;42510.78744606273;42557.7872110639;41997.58002419975;42122.57877421225;42132;42285.15429691404;42292.36561451581;7364.447666425012;8768.693095741635;8897.866532002025;8901;8901.287896968259;7471.327580517753;9971.75070623233;10124.69625911224;10152;10162.695119146401;10278.7430314242;10287.434191119486;10297.073263406292;10299.691009269734;10310.587576496968;10244.180465562737;10257.692269231935;10280.845787313196;10287.588496460132;10287.794244115075;10230.9488452558;10252.33359831616;10257.948710256402;10263.486825658687;10280.38317700933;40220.39669404961;40286.194276114315;40373.394399084034;40387.39418908719;40424.191516169514;3834.7307408160295;3842.7117966152373;3858.536975562922;3884.3590807516725;3899.961000389988;28936.27659308513;29430.558541621893;29557.85221073881;29796.404071918656;29897.551536726965;3999.14018486024;4071.6156506787834;4083.224187404384;4091.1585682428317;4263.59495847894;222989;223395;224012.8799356009;224151.9810023747;224429;49889;49979.75010124926;49996;50010.749946250035;50054.49945500571;52581.2112818308;52733.209001865005;52822.47177528252;52823;52837.735811321465;13507.324633768469;13532.120412173177;13560.254186019667;13662.658433539042;13670.17978921248;9795;9915.454649994175;11375.203735738585;11467.08263338931;11478.655640330804;11920.52317907274;12908.58005619381;13153.934230328978;13578.388972496261;13602.183868967893;5170.8965820684125;5360.91958620621;5440.700761458079;5473.370562385297;5476.658218736435;957.8563215517728;963.3160456076264;974.9317547771587;981.7594689301025;988.5205675247499;26116.34709132287;26369.736302637113;26443.206703798918;26893.731062689512;26974.730252697223;1000.9449480278655;1013.8377859542438;1019.1870437592298;1027.8355463125863;1038.5845661735216;13830.37763300654;14131.576052718436;14331.570052898429;14364.475190315017;14518.637034074021;269756;272534;296954;301478;302571;46067.76966115148;46278.537214627424;46300.7684961573;46435.303470447296;46478.30282545764;1375.8692924172187;1376.3531140364014;1390.1589538329165;1394.1565352961516;1396.0995158122953;26419.207423777316;27327.863360683863;27602.861985690746;27754;28121.578176326962;36104.819475902455;43782.56217437912;44556.999999998705;49281;49357.50642493673;296417;297277;298865;299067;299511;29221.415571688023;29282.267943301587;29631.111066668036;29687.507811055024;29700.702992969793;36317.45523817198;36924.44613330749;37244.441333380564;37550.06124846901;47972.520274798204;37755.43366849554;38800;40432;41533.79233103815;43378.56621433745;40338.798306008284;41054.58945410508;41101.588984109774;41541.58458415498;43146.56853431551;42011.579884200764;43246.567534324255;43608.12783744371;43758.12483750371;43829.34255986099;33952.320953581286;36210.45684314684;36373.63626363808;37194.6280537202;37210.62789372072;28479.715202847707;28908.42183156283;28917.132486025454;28935.276618084717;28947.42105157843 09:24:53 INFO - PROCESS | 30502 | |2;jquery.html;390.31694534564514;421.46480720637305;430.4941693510126;441.7482035239913;448.17088386485005;16378.83621163788;18977.430677079694;19962.201511939504;20124;20266.986650667463;19773.209071637117;20372.490687732814;20696.586068278626;20915.267965621206;21362.786372136274;6325.240971083476;6385.233771947373;6623.602583844985;6636.73453061877;6637.800865974004;5413.458654134574;6311.400416960381;6445.452136568374;6461.224653041641;6462.289148193695;6235.127082208494;6367.4906007519285;6416.743330266784;6467.353264673542;6471.579347342431;6299.275583307933;6321.905171422432;6323.715432805535;6329.8417539561415;6334.746610135635;6158;6162.198914141178;6200.325912003779;6201.162843016225;6212.471939885115;23752;23959.640605390934;23987.52024959491;24059.639105413433;24114.758852411425;3275.2958114005364;3335.366280406715;3404.472306792451;3420.9315813683834;3479.9130021749406;15352.462663806826;15920.840791592167;16061.598460038476;16710.58223544409;16769.580760480963;2091.874487530738;2150.107705302313;2157.3420106867397;2223.633100538409;2229.476073122815;89919.55040224757;90709.54645226798;92843.53578232066;93367;94959.52520237424;14608.809862588509;18015.72976405355;18806.905965470087;19190.520236993907;20380.59238815245;30973.380532389678;32095.197620059684;32118.518222226685;32177;32244.516332255036;8284.544350060805;9080.22818060459;9129.680461183827;10053.447060411747;10373.170146388271;8264.710735124241;8555.40112192153;8560.743177704679;8562.73087631778;8627.266682331947;9677.854562352957;9702.611895524242;9718.854217186748;9723.235614548961;9759.219262459128;3196.888108916177;3255.2493143293877;3482.6169121396624;3526.9719911050734;3586.3903136466865;924.1867156901883;936.9297302702324;938.5119737736339;947.9620815167316;947.9620815167455;19844.206231750857;21676.783232167792;21707.348779536638;21739.239126630808;21933.890330548245;925.9444433334022;930.0792215706537;931.1811376128508;951.7192428233687;963.7638778499313;11900.523979040914;12172.14794964344;12289.754204915851;12310.199837010745;12346.629601111981;271462;272674;273363;273613;610111;84240;84287.57856210803;101083;120471.39764301122;123564;1216.6410908781932;1228.2814553486132;1274.955376561816;1279.405076639367;1281.8910392616544;17495.475135745946;17933.461996140137;18149.455516334532;18707.7907470818;18908.338208162648;37027.444588330654;41202.58797411987;50386.49613503818;51416.48583514117;51892.22161667502;50963.49036509587;61308.386916130265;62916.42708932313;70868.29131708617;72731;12025.518979241082;12043.578474753342;12132.272063676208;12218.6945326364;12238.449269782703;12914.418851151908;13015.739685206054;13115.737685246433;13121.343932803513;13184.143030702973;12142.75714485723;12146.210496317712;12325.630231093082;12334.691632709255;12833.294168820805;11066.336019838835;12033.278003319829;12082.879171208175;12103.515859365527;12479.812802808146;11860.525578976743;11953.760924781282;12008;12109.152359334763;12303.138780285293;11770.58802941893;11842.28946263227;11882.584109556125;11919.76160476803;12098.334591597195;11989.880101198876;12043.156979011384;12361.505539778667;12400.75198496007;12418.627441176779 09:24:53 INFO - PROCESS | 30502 | |3;mootools.html;1499.69256302458;1514.2050423527653;1531.6170957260686;1537.8769698424123;1555.4633651390266;10211.642592509264;10948.3978381189;10984.670459886196;10987.725306867333;10992.230543861933;10334.379937203754;10771.56913723452;10776.40729759863;11065.723356916082;11107.611233606825;2064.907079181433;2102.1486298049313;2102.4533621258506;2103.737032870891;2106.389147147333;2030.786767389425;2068.0900403822347;2075.699023641571;2080.126346934291;2082.187946700788;2039.1741344755399;2050.7744148143693;2054.12699602669;2055.804698553635;2057.043474784225;1969.350114462224;1970.2316096722218;1971.2706298669511;1971.5366888781125;1975.387629834756;1750.2124044180043;1758.6834369813428;1950.9609807803906;2002.9699554506694;2006.839452843769;10631.255812093157;10688.946555267252;10693.358398496115;10695.19786016044;10702.892971070267;5184.351956005499;5282.524572788429;5292.338457692788;5310.628256022042;5317.361916569997;2948.2187220386613;3115.081051089934;3162.683731626819;3163.3040731039137;3201.7438604911786;1150.206357613244;1196.1208511743862;1234.179270784927;1266.4807428954177;1275.6555729952954;13701.314934253347;14059.437622495088;15081.622959426102;15546.689066218725;15710.293036813371;4226.323788193874;4417.867463976086;4470.329450582439;4496.235639941153;4521.480029796549;13275.535356262484;13292.867071329356;13294.601161965156;13300.733985320432;13320.800187997187;4699.412573428322;4836.395450568679;5380.3274590676165;5463.590230732711;5472.179173123984;4776.9761151194025;4947.975260123676;4950.331705219821;4975.029869175549;5041.0422019816115;3725.1432170600915;3853.8265778040054;3873.5545412277384;3948.4866967294643;4000.5199376075057;1079.794838980591;1082.7726177502655;1083.9349639021684;1098.1708809848512;1104.729341311384;940.2571968145089;952.5761036338763;955.8231727130503;961.1974001708512;996.2229461020415;5983.640981541122;6131.877362452726;6151.938480615226;6156.630602163885;6247.156633854372;992.2855544008303;996.2478328861663;998.4358837256926;1018.2617602238317;1030.5362586835954;3759.7180211484247;3929.0766669832565;3941.7832019238645;4003.559608443069;4067.08490589615;13280.535181268802;13557.728845423037;13617.64764386461;13741.03812733119;13744.862551374557;13209.40557674907;13272.27002514871;13384.130031547918;13392.464301428028;13404.530841420503;9884.528867783054;10027.949860250797;10102.949485252673;10110.77562936153;10118.494075296207;5808.73860676279;5860.208871802252;5871.412858714094;5878.500327472213;5969.582129250911;11261.268017578832;11947.581834635746;11997.460114295052;12027.45876435545;12141.453634586289;10732.946335268274;10905.672829815117;12190.878091219329;12194.390280486117;12195.51217951272;8878.911210888067;9013.819723605622;9092.681756138503;9206.217471514996;9248.028956959422;10305.072543471124;10338.844917326096;10412.843807342744;10418.322809017389;10420.270581059252;8986.689694190596;9081.545922703706;9083.63665453401;9283;9312.394694344846;8484.745457636282;8506.532140732319;8613.741587752378;8660.653573857227;8685.174908383693;6734.8653026940165;6771.28901465339;6835.350641689031;6839.2476827547935;6848.212455567674;5540.390557038642;5620.072688006433;5620.297462817148;5675.347335056521;5772.39389864075;5734.082546792493;5778.971105144447;5816.0694288915265;5827.329857066322;6013.248343957005 09:24:53 INFO - PROCESS | 30502 | |4;prototype.html;390.27019473584403;406.10453949042363;416.63136596281214;420.8169446290864;427.29709627662487;5130.307408499852;5222.608304377168;5230.816921407747;5230.966039696976;5240.397354304256;4988.3515143031445;5076.111680455924;5086.0590790703745;5101.897962040757;5125.820596279131;4324.22164010478;4348.717333373321;4350.8259669613335;4356.62766228637;4365.672574556905;4366.432363792718;4372.344148377737;4380.6495480361655;4393.846215382462;4409.536998615147;4208.863606826155;4318.870433886988;4336.7181133226395;4351.891202719926;4354.934675979863;4273.807678654468;4302.569743025703;4305.835211119825;4307.956920430818;4315.5900189481945;4037.7981100944835;4038.495188101487;4049.7975101245115;4064.6951478638925;4095.160492099142;4900.828471003533;4916.336294600254;4947.406311242638;4972.925406118911;5073.670211436245;4926.45808961014;4974.303597496353;4976.208564916627;4998.525140111684;5002.924956125661;5424.616722735677;5444.700541470217;5445.264889239981;5471.206675032138;5481.862953426196;4256.743256743257;4453.755043472608;4476.239039363316;4482.775861206959;4486.641068714495;5385.919211211796;5480.91778623325;5488.2711945737365;5599.664020158803;5615.747291371898;4435.556444355539;4516.774161291923;4522.88692782683;4537.274036154199;4574.4446888057555;4457.214241099313;4630.448799652154;4642.489326174118;4645.466995891347;4649.697769644962;4799.520047995243;4826.95173048272;4998.475160108209;5024.397072351341;5037.244413337955;5430.800525787063;5431.8098866539485;5443.918341224885;5469.343678758574;5483.424240454775;1539.6074001129641;1586.4130271799277;1587.2619232056918;1621.3109428493078;1625.1874062968516;1190.7142285851332;1231.2981600487635;1246.7631150081456;1250.412306216077;1253.3795771093185;5245.973770131125;5252.894942101137;5253.36959564847;5255.237990491358;5271.65734227274;5542.113261878161;5568.276124103841;5573.108302671553;5589.882023595297;5615.775368985195;4889.4377146627885;5197.454267301954;5206.245094461282;5215.791368345223;5245.842624721265;2911.694272101441;2923.780716446275;2925.527928900076;2926.473234817711;2949.5280755079084;5675.744591493392;5699.373068962411;5772.3938986406665;5774.884502310014;5778.913316300259;5344.759485823147;5627.733759903989;5677.403872593318;5686.317641883001;5730.36965933747;5710.8001219957105;5722.656640601661;5749.3963133871175;5750.856228594319;5778.393268706725;5230.398504172069;5493.917591236055;5523.895220955745;5545.3622833374675;5565.081761509306;5487.506124448659;5523.392426833126;5532.778688852401;5555.388907220122;5573.359063707726;5480.506754392124;5592.608517403743;5618.353889302619;5700.603352178743;5706.2011318414625;4505.346724724831;4565.201089809337;4565.52062033495;4570.223062079388;4575.542445755398;5319.776451416118;5521.944780552143;5528.253685752372;5530.281063461724;5534.889302214014;5351.902859913786;5424.186372044225;5429.203959960544;5445.50990410865;5459.454054594509;5430.864228394322;5432.185172224198;5453.263809385682;5460.617756757148;5473.658953556404;5051.2423136529815;5378.865528361822;5385.919211211756;5389.27244821944;5409.675419474844;5396.595255355943;5401.2168235606405;5403.594730395157;5439.891202176013;5452.773126046766;5262.710550919736;5360.678359298455;5383.973080134731;5395.843431592562;5397.541208997122 09:24:53 INFO - PROCESS | 30502 | |5;yui.html;775.8952541406908;777.3897490469982;841.5035129273729;847.588919374103;855.7646647172027;15588.142652154142;16876.071816050113;16894.07082610459;16994.49016529503;17033.488995330128;14722.558323250292;14864.479743208989;14891.553253402388;14900.105993640389;14903;807.3863863463765;825.154216927648;826.5495305058728;832.3923535818856;835.7534527314457;822.7572866004513;832.0057531250159;832.0431503770682;832.0473058348188;832.138736407818;871.2159056848824;872.6073267029831;872.6945569050813;874.1826392323198;874.2394117118116;863.5984267315729;866.9523176225305;867.3668222197799;867.5965675960678;868.192580899763;631.5042691487206;635.3424205946823;635.5678138865569;635.6218050260088;636.2841802971657;15797.605059873595;15886.52340429789;15999.200039997953;16470.258838352303;16472.588185295343;14206.786898196535;14640;14757.335919883632;14808.555743327717;14847.703045939128;12192.695182620417;12423;12473.75052498954;12664.81002784959;13245.470181192837;3662.61542538035;3723.3298006359114;3738.178420741389;3747.8126093695478;3809.8857034289017;83574;86940;87627.56186219092;88506.99999999936;89255.55372223162;10953.780924381468;11052.447377631086;11336.263142895685;11494.379160694603;11596.478158482889;22256.666150007764;22616.434589135402;22637.43406414853;22750.431239218822;22784.886075569517;7579.583122928292;7626.618669066635;7739.7291094812535;7746.961265193638;7832.373410127176;4143.627073563393;4229.619334259932;4234.661227101825;4249.46881639795;4283.1433713257475;3239;3288.128645908836;3293.8682452701623;3310.741918071166;3324.667533246656;526.7971830845075;529.6689569019363;536.8067495701545;539.5926075812736;542.6689719271242;599.9640021598718;622.9595076320024;643.5623775832386;651.7034749189107;665.5374514712325;10266.897331026594;10584.629537966135;10864.511097000654;11329.660110196708;11330.433478326051;780.3679019993823;785.1716439156744;794.5629903553023;800;802.2659266770839;4964.776585053682;5234.536018474788;5243.737813109406;5271.868203294948;5302.2046692996355;58660.706696467096;71773;72630.63684681543;73841.6307918457;75594.24405755872;66520.33479665141;67829.66085169543;68567;68965;69437;60375.39624603698;60969;61485;61701.38298617046;62198.378016220166;10043.69868903934;10058.40652726388;10088.243381746252;10140.847887281549;10274.383536987805;36381.81809090938;36396;37371.439428408055;40280.59719402886;44168.779156104014;54834.72582637061;55423;55835.72082139563;56403.43596564146;56479.71760141337;12378.133530653127;12406.739047562496;12474.313912734524;12626.747465050832;12672.493100275886;14639.48761793332;14660.486882959472;14960.251987400805;15213.923930380277;15411.152386618394;13634.181949083088;13672.384742686801;13937.09408888419;14403.42386304536;14442.494512692005;14669.779953300922;14711.3379897907;14986.100833949999;15086.24568771579;15506.612334691723;14692.779608306098;14734.189619571027;14804.555863324118;14898.137732783402;14940.178290194144;12048.939755301168;12308.753824923631;12432.440540175894;12608.306543140216;12646.645469315104;10009.69970900874;11867.202495201453;12157.1489995703;12210.816837747263;12432.875671243171 09:24:53 INFO - PROCESS | 30502 | __end_tp_report 09:24:53 INFO - PROCESS | 30502 | __start_cc_report 09:24:53 INFO - PROCESS | 30502 | _x_x_mozilla_cycle_collect,1432 09:24:53 INFO - PROCESS | 30502 | __end_cc_report 09:24:53 INFO - PROCESS | 30502 | __startTimestamp1488821093647__endTimestamp 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | ------- Summary: start ------- 09:24:53 INFO - PROCESS | 30502 | Number of tests: 6 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#0] dojo.html Cycles:165 Average:5530.91 Median:5774.97 stddev:617.73 (10.7%) stddev-sans-first:592.15 09:24:53 INFO - PROCESS | 30502 | Values: 3208.5 3235.6 3257.4 3264.2 3275.7 5382.3 5410.5 5477.7 5553.5 5558.1 5393.8 5575.0 5597.4 5656.6 5699.1 5122.5 5126.1 5144.8 5163.1 5182.2 5062.8 5165.9 5208.8 5209.8 5216.7 4944.9 4954.3 5136.4 5145.2 5180.6 5016.3 5029.5 5029.8 5037.3 5037.9 4975.1 4995.0 4999.9 5006.6 5008.6 5563.3 5565.4 5610.3 5626.8 5662.4 5995.0 6012.2 6017.4 6020.6 6022.4 5858.1 5868.5 5972.4 5988.0 6064.1 5516.3 5521.2 5521.8 5528.3 5554.6 6032.4 6057.0 6076.9 6098.0 6101.9 5716.3 5929.4 5987.6 5987.6 5989.3 5927.5 5934.6 5934.6 5936.3 5937.4 5893.4 5894.7 5895.6 5896.1 5901.7 5886.1 5905.4 5910.7 5917.5 5923.4 4616.7 4619.4 4619.7 4625.7 4666.0 4046.3 4067.6 4094.3 4104.2 4109.4 5411.7 5522.3 5532.8 5535.3 5568.1 5816.6 5883.3 5951.5 5954.4 5960.0 5622.6 5623.5 5624.8 5624.9 5631.5 5065.9 5069.2 5070.1 5071.3 5076.4 6159.2 6166.3 6166.8 6166.9 6169.3 5811.5 5865.7 5944.0 5945.0 5945.3 6052.0 6097.7 6103.5 6127.4 6144.7 5852.7 5878.6 5910.5 5923.7 5928.2 5953.7 5953.9 5954.2 5966.1 5966.2 5833.2 5835.2 5842.5 5845.9 5850.0 5639.4 5671.7 5743.0 5810.9 5820.5 5818.4 5820.3 5822.2 5921.6 5935.5 5869.1 5905.6 5935.3 5936.0 5938.9 5565.9 5767.9 5773.1 5775.0 5778.1 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#1] ext.html Cycles:180 Average:44084.46 Median:36345.55 stddev:70985.46 (195.3%) stddev-sans-first:71109.88 09:24:53 INFO - PROCESS | 30502 | Values: 707.9 762.0 779.8 836.0 850.8 28908.3 42003.0 42358.2 42510.8 42557.8 41997.6 42122.6 42132.0 42285.2 42292.4 7364.4 8768.7 8897.9 8901.0 8901.3 7471.3 9971.8 10124.7 10152.0 10162.7 10278.7 10287.4 10297.1 10299.7 10310.6 10244.2 10257.7 10280.8 10287.6 10287.8 10230.9 10252.3 10257.9 10263.5 10280.4 40220.4 40286.2 40373.4 40387.4 40424.2 3834.7 3842.7 3858.5 3884.4 3900.0 28936.3 29430.6 29557.9 29796.4 29897.6 3999.1 4071.6 4083.2 4091.2 4263.6 222989.0 223395.0 224012.9 224152.0 224429.0 49889.0 49979.8 49996.0 50010.7 50054.5 52581.2 52733.2 52822.5 52823.0 52837.7 13507.3 13532.1 13560.3 13662.7 13670.2 9795.0 9915.5 11375.2 11467.1 11478.7 11920.5 12908.6 13153.9 13578.4 13602.2 5170.9 5360.9 5440.7 5473.4 5476.7 957.9 963.3 974.9 981.8 988.5 26116.3 26369.7 26443.2 26893.7 26974.7 1000.9 1013.8 1019.2 1027.8 1038.6 13830.4 14131.6 14331.6 14364.5 14518.6 269756.0 272534.0 296954.0 301478.0 302571.0 46067.8 46278.5 46300.8 46435.3 46478.3 1375.9 1376.4 1390.2 1394.2 1396.1 26419.2 27327.9 27602.9 27754.0 28121.6 36104.8 43782.6 44557.0 49281.0 49357.5 296417.0 297277.0 298865.0 299067.0 299511.0 29221.4 29282.3 29631.1 29687.5 29700.7 36317.5 36924.4 37244.4 37550.1 47972.5 37755.4 38800.0 40432.0 41533.8 43378.6 40338.8 41054.6 41101.6 41541.6 43146.6 42011.6 43246.6 43608.1 43758.1 43829.3 33952.3 36210.5 36373.6 37194.6 37210.6 28479.7 28908.4 28917.1 28935.3 28947.4 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#2] jquery.html Cycles:180 Average:27355.85 Median:272068.00 stddev:62127.94 (22.8%) stddev-sans-first:62269.24 09:24:53 INFO - PROCESS | 30502 | Values: 390.3 421.5 430.5 441.7 448.2 16378.8 18977.4 19962.2 20124.0 20267.0 19773.2 20372.5 20696.6 20915.3 21362.8 6325.2 6385.2 6623.6 6636.7 6637.8 5413.5 6311.4 6445.5 6461.2 6462.3 6235.1 6367.5 6416.7 6467.4 6471.6 6299.3 6321.9 6323.7 6329.8 6334.7 6158.0 6162.2 6200.3 6201.2 6212.5 23752.0 23959.6 23987.5 24059.6 24114.8 3275.3 3335.4 3404.5 3420.9 3479.9 15352.5 15920.8 16061.6 16710.6 16769.6 2091.9 2150.1 2157.3 2223.6 2229.5 89919.6 90709.5 92843.5 93367.0 94959.5 14608.8 18015.7 18806.9 19190.5 20380.6 30973.4 32095.2 32118.5 32177.0 32244.5 8284.5 9080.2 9129.7 10053.4 10373.2 8264.7 8555.4 8560.7 8562.7 8627.3 9677.9 9702.6 9718.9 9723.2 9759.2 3196.9 3255.2 3482.6 3527.0 3586.4 924.2 936.9 938.5 948.0 948.0 19844.2 21676.8 21707.3 21739.2 21933.9 925.9 930.1 931.2 951.7 963.8 11900.5 12172.1 12289.8 12310.2 12346.6 271462.0 272674.0 273363.0 273613.0 610111.0 84240.0 84287.6 101083.0 120471.4 123564.0 1216.6 1228.3 1275.0 1279.4 1281.9 17495.5 17933.5 18149.5 18707.8 18908.3 37027.4 41202.6 50386.5 51416.5 51892.2 50963.5 61308.4 62916.4 70868.3 72731.0 12025.5 12043.6 12132.3 12218.7 12238.4 12914.4 13015.7 13115.7 13121.3 13184.1 12142.8 12146.2 12325.6 12334.7 12833.3 11066.3 12033.3 12082.9 12103.5 12479.8 11860.5 11953.8 12008.0 12109.2 12303.1 11770.6 11842.3 11882.6 11919.8 12098.3 11989.9 12043.2 12361.5 12400.8 12418.6 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#3] mootools.html Cycles:180 Average:6529.72 Median:2081.16 stddev:4260.07 (204.7%) stddev-sans-first:4255.26 09:24:53 INFO - PROCESS | 30502 | Values: 1499.7 1514.2 1531.6 1537.9 1555.5 10211.6 10948.4 10984.7 10987.7 10992.2 10334.4 10771.6 10776.4 11065.7 11107.6 2064.9 2102.1 2102.5 2103.7 2106.4 2030.8 2068.1 2075.7 2080.1 2082.2 2039.2 2050.8 2054.1 2055.8 2057.0 1969.4 1970.2 1971.3 1971.5 1975.4 1750.2 1758.7 1951.0 2003.0 2006.8 10631.3 10688.9 10693.4 10695.2 10702.9 5184.4 5282.5 5292.3 5310.6 5317.4 2948.2 3115.1 3162.7 3163.3 3201.7 1150.2 1196.1 1234.2 1266.5 1275.7 13701.3 14059.4 15081.6 15546.7 15710.3 4226.3 4417.9 4470.3 4496.2 4521.5 13275.5 13292.9 13294.6 13300.7 13320.8 4699.4 4836.4 5380.3 5463.6 5472.2 4777.0 4948.0 4950.3 4975.0 5041.0 3725.1 3853.8 3873.6 3948.5 4000.5 1079.8 1082.8 1083.9 1098.2 1104.7 940.3 952.6 955.8 961.2 996.2 5983.6 6131.9 6151.9 6156.6 6247.2 992.3 996.2 998.4 1018.3 1030.5 3759.7 3929.1 3941.8 4003.6 4067.1 13280.5 13557.7 13617.6 13741.0 13744.9 13209.4 13272.3 13384.1 13392.5 13404.5 9884.5 10027.9 10102.9 10110.8 10118.5 5808.7 5860.2 5871.4 5878.5 5969.6 11261.3 11947.6 11997.5 12027.5 12141.5 10732.9 10905.7 12190.9 12194.4 12195.5 8878.9 9013.8 9092.7 9206.2 9248.0 10305.1 10338.8 10412.8 10418.3 10420.3 8986.7 9081.5 9083.6 9283.0 9312.4 8484.7 8506.5 8613.7 8660.7 8685.2 6734.9 6771.3 6835.4 6839.2 6848.2 5540.4 5620.1 5620.3 5675.3 5772.4 5734.1 5779.0 5816.1 5827.3 6013.2 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#4] prototype.html Cycles:180 Average:4706.43 Median:5219.20 stddev:1253.85 (24.0%) stddev-sans-first:1214.79 09:24:53 INFO - PROCESS | 30502 | Values: 390.3 406.1 416.6 420.8 427.3 5130.3 5222.6 5230.8 5231.0 5240.4 4988.4 5076.1 5086.1 5101.9 5125.8 4324.2 4348.7 4350.8 4356.6 4365.7 4366.4 4372.3 4380.6 4393.8 4409.5 4208.9 4318.9 4336.7 4351.9 4354.9 4273.8 4302.6 4305.8 4308.0 4315.6 4037.8 4038.5 4049.8 4064.7 4095.2 4900.8 4916.3 4947.4 4972.9 5073.7 4926.5 4974.3 4976.2 4998.5 5002.9 5424.6 5444.7 5445.3 5471.2 5481.9 4256.7 4453.8 4476.2 4482.8 4486.6 5385.9 5480.9 5488.3 5599.7 5615.7 4435.6 4516.8 4522.9 4537.3 4574.4 4457.2 4630.4 4642.5 4645.5 4649.7 4799.5 4827.0 4998.5 5024.4 5037.2 5430.8 5431.8 5443.9 5469.3 5483.4 1539.6 1586.4 1587.3 1621.3 1625.2 1190.7 1231.3 1246.8 1250.4 1253.4 5246.0 5252.9 5253.4 5255.2 5271.7 5542.1 5568.3 5573.1 5589.9 5615.8 4889.4 5197.5 5206.2 5215.8 5245.8 2911.7 2923.8 2925.5 2926.5 2949.5 5675.7 5699.4 5772.4 5774.9 5778.9 5344.8 5627.7 5677.4 5686.3 5730.4 5710.8 5722.7 5749.4 5750.9 5778.4 5230.4 5493.9 5523.9 5545.4 5565.1 5487.5 5523.4 5532.8 5555.4 5573.4 5480.5 5592.6 5618.4 5700.6 5706.2 4505.3 4565.2 4565.5 4570.2 4575.5 5319.8 5521.9 5528.3 5530.3 5534.9 5351.9 5424.2 5429.2 5445.5 5459.5 5430.9 5432.2 5453.3 5460.6 5473.7 5051.2 5378.9 5385.9 5389.3 5409.7 5396.6 5401.2 5403.6 5439.9 5452.8 5262.7 5360.7 5384.0 5395.8 5397.5 09:24:53 INFO - PROCESS | 30502 | 09:24:53 INFO - PROCESS | 30502 | [#5] yui.html Cycles:180 Average:17729.01 Median:3743.00 stddev:22297.51 (595.7%) stddev-sans-first:22323.71 09:24:53 INFO - PROCESS | 30502 | Values: 775.9 777.4 841.5 847.6 855.8 15588.1 16876.1 16894.1 16994.5 17033.5 14722.6 14864.5 14891.6 14900.1 14903.0 807.4 825.2 826.5 832.4 835.8 822.8 832.0 832.0 832.0 832.1 871.2 872.6 872.7 874.2 874.2 863.6 867.0 867.4 867.6 868.2 631.5 635.3 635.6 635.6 636.3 15797.6 15886.5 15999.2 16470.3 16472.6 14206.8 14640.0 14757.3 14808.6 14847.7 12192.7 12423.0 12473.8 12664.8 13245.5 3662.6 3723.3 3738.2 3747.8 3809.9 83574.0 86940.0 87627.6 88507.0 89255.6 10953.8 11052.4 11336.3 11494.4 11596.5 22256.7 22616.4 22637.4 22750.4 22784.9 7579.6 7626.6 7739.7 7747.0 7832.4 4143.6 4229.6 4234.7 4249.5 4283.1 3239.0 3288.1 3293.9 3310.7 3324.7 526.8 529.7 536.8 539.6 542.7 600.0 623.0 643.6 651.7 665.5 10266.9 10584.6 10864.5 11329.7 11330.4 780.4 785.2 794.6 800.0 802.3 4964.8 5234.5 5243.7 5271.9 5302.2 58660.7 71773.0 72630.6 73841.6 75594.2 66520.3 67829.7 68567.0 68965.0 69437.0 60375.4 60969.0 61485.0 61701.4 62198.4 10043.7 10058.4 10088.2 10140.8 10274.4 36381.8 36396.0 37371.4 40280.6 44168.8 54834.7 55423.0 55835.7 56403.4 56479.7 12378.1 12406.7 12474.3 12626.7 12672.5 14639.5 14660.5 14960.3 15213.9 15411.2 13634.2 13672.4 13937.1 14403.4 14442.5 14669.8 14711.3 14986.1 15086.2 15506.6 14692.8 14734.2 14804.6 14898.1 14940.2 12048.9 12308.8 12432.4 12608.3 12646.6 10009.7 11867.2 12157.1 12210.8 12432.9 09:24:53 INFO - PROCESS | 30502 | -------- Summary: end -------- 09:24:53 INFO - PROCESS | 30502 | 09:24:54 INFO - TEST-INFO | 30502: exit 0 09:24:54 INFO - TEST-OK | dromaeo_css | took 1117779ms 09:24:54 INFO - TEST-START | kraken 09:24:54 INFO - operating with platform_type : linux_ 09:24:54 INFO - Initialising browser for kraken test... 09:24:54 INFO - TEST-INFO | started process 30825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnOEgG/profile http://localhost:55815/getInfo.html) 09:24:58 INFO - PROCESS | 30825 | __metrics Screen width/height:1600/1200 09:24:58 INFO - PROCESS | 30825 | colorDepth:24 09:24:58 INFO - PROCESS | 30825 | Browser inner width/height: 1024/697 09:24:58 INFO - PROCESS | 30825 | __metrics 09:24:59 INFO - PROCESS | 30825 | 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" 09:24:59 INFO - PROCESS | 30825 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:00 INFO - TEST-INFO | 30825: exit 0 09:25:00 INFO - Browser initialized. 09:25:00 INFO - Running cycle 1/1 for kraken test... 09:25:00 INFO - TEST-INFO | started process 30916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSnOEgG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:12 INFO - PROCESS | 30916 | RSS: Main: 143179776 09:25:12 INFO - PROCESS | 30916 | 09:25:14 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55815/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:15 INFO - PROCESS | 30916 | RSS: Main: 197402624 09:25:15 INFO - PROCESS | 30916 | 09:25:18 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55815/tests/kraken/driver.html?testName=audio-dft) 09:25:18 INFO - PROCESS | 30916 | RSS: Main: 178147328 09:25:18 INFO - PROCESS | 30916 | 09:25:21 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55815/tests/kraken/driver.html?testName=audio-fft) 09:25:22 INFO - PROCESS | 30916 | RSS: Main: 259846144 09:25:22 INFO - PROCESS | 30916 | 09:25:24 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55815/tests/kraken/driver.html?testName=audio-oscillator) 09:25:25 INFO - PROCESS | 30916 | RSS: Main: 171421696 09:25:25 INFO - PROCESS | 30916 | 09:25:27 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:27 INFO - PROCESS | 30916 | RSS: Main: 175067136 09:25:27 INFO - PROCESS | 30916 | 09:25:30 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55815/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:31 INFO - PROCESS | 30916 | RSS: Main: 213938176 09:25:31 INFO - PROCESS | 30916 | 09:25:35 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55815/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:35 INFO - PROCESS | 30916 | RSS: Main: 208863232 09:25:35 INFO - PROCESS | 30916 | 09:25:38 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55815/tests/kraken/driver.html?testName=json-parse-financial) 09:25:39 INFO - PROCESS | 30916 | RSS: Main: 211279872 09:25:39 INFO - PROCESS | 30916 | 09:25:40 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:41 INFO - PROCESS | 30916 | RSS: Main: 174157824 09:25:41 INFO - PROCESS | 30916 | 09:25:43 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:43 INFO - PROCESS | 30916 | RSS: Main: 181194752 09:25:43 INFO - PROCESS | 30916 | 09:25:45 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:46 INFO - PROCESS | 30916 | RSS: Main: 190717952 09:25:46 INFO - PROCESS | 30916 | 09:25:49 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:49 INFO - PROCESS | 30916 | RSS: Main: 199782400 09:25:49 INFO - PROCESS | 30916 | 09:25:52 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:53 INFO - PROCESS | 30916 | RSS: Main: 196042752 09:25:53 INFO - PROCESS | 30916 | 09:25:54 INFO - PROCESS | 30916 | Cycle 1(1): loaded http://localhost:55815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55815/tests/kraken/driver.html?testName=ai-astar) 09:25:55 INFO - PROCESS | 30916 | RSS: Main: 244891648 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | __start_tp_report 09:25:55 INFO - PROCESS | 30916 | _x_x_mozilla_page_load 09:25:55 INFO - PROCESS | 30916 | _x_x_mozilla_page_load_details 09:25:55 INFO - PROCESS | 30916 | |i|pagename|runs| 09:25:55 INFO - PROCESS | 30916 | |0;ai-astar;108;114;115;113;115;115;114;114;114;113 09:25:55 INFO - PROCESS | 30916 | |1;audio-beat-detection;150;117;118;169;119;118;120;118;150;118 09:25:55 INFO - PROCESS | 30916 | |2;audio-dft;161;163;162;163;163;161;164;162;163;162 09:25:55 INFO - PROCESS | 30916 | |3;audio-fft;76;76;75;119;76;78;76;76;96;76 09:25:55 INFO - PROCESS | 30916 | |4;audio-oscillator;83;82;109;83;83;84;101;82;82;110 09:25:55 INFO - PROCESS | 30916 | |5;imaging-gaussian-blur;113;113;113;113;113;114;113;113;113;113 09:25:55 INFO - PROCESS | 30916 | |6;imaging-darkroom;148;147;147;146;147;147;147;147;146;149 09:25:55 INFO - PROCESS | 30916 | |7;imaging-desaturate;94;94;94;94;94;94;95;95;95;95 09:25:55 INFO - PROCESS | 30916 | |8;json-parse-financial;57;56;56;56;60;57;57;57;56;56 09:25:55 INFO - PROCESS | 30916 | |9;json-stringify-tinderbox;53;53;53;53;54;54;53;53;53;53 09:25:55 INFO - PROCESS | 30916 | |10;stanford-crypto-aes;89;85;89;85;84;85;81;81;85;80 09:25:55 INFO - PROCESS | 30916 | |11;stanford-crypto-ccm;127;126;126;133;127;127;125;157;162;143 09:25:55 INFO - PROCESS | 30916 | |12;stanford-crypto-pbkdf2;176;173;178;170;174;174;171;171;171;169 09:25:55 INFO - PROCESS | 30916 | |13;stanford-crypto-sha256-iterative;64;68;69;62;63;62;63;66;64;61 09:25:55 INFO - PROCESS | 30916 | __end_tp_report 09:25:55 INFO - PROCESS | 30916 | __start_cc_report 09:25:55 INFO - PROCESS | 30916 | _x_x_mozilla_cycle_collect,1791 09:25:55 INFO - PROCESS | 30916 | __end_cc_report 09:25:55 INFO - PROCESS | 30916 | __startTimestamp1488821155187__endTimestamp 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | ------- Summary: start ------- 09:25:55 INFO - PROCESS | 30916 | Number of tests: 14 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 09:25:55 INFO - PROCESS | 30916 | Values: 108.0 114.0 115.0 113.0 115.0 115.0 114.0 114.0 114.0 113.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:119.50 stddev:19.11 (16.0%) stddev-sans-first:18.80 09:25:55 INFO - PROCESS | 30916 | Values: 150.0 117.0 118.0 169.0 119.0 118.0 120.0 118.0 150.0 118.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 09:25:55 INFO - PROCESS | 30916 | Values: 161.0 163.0 162.0 163.0 163.0 161.0 164.0 162.0 163.0 162.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.32 (18.8%) stddev-sans-first:15.00 09:25:55 INFO - PROCESS | 30916 | Values: 76.0 76.0 75.0 119.0 76.0 78.0 76.0 76.0 96.0 76.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.50 stddev:11.82 (14.3%) stddev-sans-first:12.27 09:25:55 INFO - PROCESS | 30916 | Values: 83.0 82.0 109.0 83.0 83.0 84.0 101.0 82.0 82.0 110.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:25:55 INFO - PROCESS | 30916 | Values: 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 09:25:55 INFO - PROCESS | 30916 | Values: 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 149.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:25:55 INFO - PROCESS | 30916 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.23 (2.2%) stddev-sans-first:1.30 09:25:55 INFO - PROCESS | 30916 | Values: 57.0 56.0 56.0 56.0 60.0 57.0 57.0 57.0 56.0 56.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#9] json-stringify-tinderbox Cycles:10 Average:53.20 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:25:55 INFO - PROCESS | 30916 | Values: 53.0 53.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 53.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:3.10 (3.6%) stddev-sans-first:2.80 09:25:55 INFO - PROCESS | 30916 | Values: 89.0 85.0 89.0 85.0 84.0 85.0 81.0 81.0 85.0 80.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:130.00 stddev:13.88 (10.7%) stddev-sans-first:14.39 09:25:55 INFO - PROCESS | 30916 | Values: 127.0 126.0 126.0 133.0 127.0 127.0 125.0 157.0 162.0 143.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.50 stddev:2.83 (1.6%) stddev-sans-first:2.74 09:25:55 INFO - PROCESS | 30916 | Values: 176.0 173.0 178.0 170.0 174.0 174.0 171.0 171.0 171.0 169.0 09:25:55 INFO - PROCESS | 30916 | 09:25:55 INFO - PROCESS | 30916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:2.66 (4.2%) stddev-sans-first:2.82 09:25:55 INFO - PROCESS | 30916 | Values: 64.0 68.0 69.0 62.0 63.0 62.0 63.0 66.0 64.0 61.0 09:25:55 INFO - PROCESS | 30916 | -------- Summary: end -------- 09:25:55 INFO - PROCESS | 30916 | 09:25:56 INFO - TEST-INFO | 30916: exit 0 09:25:56 INFO - TEST-OK | kraken | took 61809ms 09:25:56 INFO - SUITE-END | took 1179s 09:25:56 INFO - Completed test suite (00:19:39) 09:25:56 INFO - javascript benchmark 09:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7440.9005293774135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.5187221916717, 3235.56319896814, 3257.4299497587917, 3264.2329052672617, 3275.737940964723, 5382.300300960869, 5410.513053825155, 5477.698726570037, 5553.500184983351, 5558.110702287635, 5393.78424863005, 5575.0, 5597.4402559744, 5656.632318899268, 5699.116636921273, 5122.538971492565, 5126.051680439112, 5144.768485418156, 5163.096458119833, 5182.2226666000215, 5062.822801201959, 5165.863510027788, 5208.817691380802, 5209.843704688866, 5216.6869987800665, 4944.851654450336, 4954.3063971044085, 5136.409312929024, 5145.151050076752, 5180.6373553851245, 5016.297718319438, 5029.5221953914315, 5029.84910452687, 5037.2695959086095, 5037.924431133536, 4975.0796102721115, 4994.976029913859, 4999.875003124951, 5006.5744411725045, 5008.5993120550265, 5563.304586926634, 5565.387807341189, 5610.298712660918, 5626.774929002835, 5662.37713851476, 5995.0, 6012.18835457212, 6017.368176341465, 6020.608660437058, 6022.397760223943, 5858.062709966428, 5868.530517558628, 5972.372900845392, 5987.970060149715, 6064.120702498113, 5516.282883225155, 5521.2270282160935, 5521.806736764194, 5528.253685752412, 5554.611177217556, 6032.426919442646, 6056.969715151484, 6076.878462430726, 6098.038923863779, 6101.938980610137, 5716.314042314949, 5929.377415371324, 5987.6108052976415, 5987.64074155552, 5989.341172471025, 5927.525797936155, 5934.584579079509, 5934.584579079509, 5936.257967754031, 5937.406259374028, 5893.44012318829, 5894.67579283135, 5895.55783316253, 5896.086106653475, 5901.704914754245, 5886.058230683156, 5905.379935106838, 5910.734016969247, 5917.52659787216, 5923.378045305267, 4616.699914505546, 4619.445666519972, 4619.653525985565, 4625.6530760192445, 4666.0, 4046.3121269384274, 4067.633912947849, 4094.344904815215, 4104.15864747726, 4109.4246805447265, 5411.729413529308, 5522.282103326622, 5532.806351777668, 5535.252740880011, 5568.081266591048, 5816.5928385013485, 5883.3234178069215, 5951.464368206795, 5954.4045595440975, 5960.016597261403, 5622.57830662702, 5623.493885550321, 5624.831255062355, 5624.91562626561, 5631.465010823965, 5065.949340506548, 5069.239614057921, 5070.087384270793, 5071.340725705634, 5076.44159142494, 6159.19930409044, 6166.290876549075, 6166.784162554289, 6166.9383306167265, 6169.321374648875, 5811.506021988009, 5865.706714664165, 5943.970280148572, 5944.970275148597, 5945.316288626863, 6052.0, 6097.736416265211, 6103.489197737777, 6127.417895299939, 6144.692765361625, 5852.707364631837, 5878.559108066997, 5910.527157827278, 5923.733431995484, 5928.2293301872205, 5953.7023148843255, 5953.940460595339, 5954.225950626391, 5966.105084237399, 5966.19456373384, 5833.241678581757, 5835.183074369676, 5842.532597392284, 5845.941540584539, 5850.005499065254, 5639.351474580476, 5671.688057156731, 5742.971285143548, 5810.912836307374, 5820.505257053198, 5818.389069147678, 5820.330661973927, 5822.184894114743, 5921.61509501881, 5935.525157987437, 5869.119632055226, 5905.557083218861, 5935.317438494629, 5936.020556608111, 5938.851528711817, 5565.860853478695, 5767.9134812977, 5773.076307790733, 5774.971125144348, 5778.075507918713], "value": 5489.946551464066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8548897476018, 762.0169980724866, 779.8206412525119, 835.9665613375465, 850.7787975126473, 28908.277293067684, 42003.0, 42358.15283694328, 42510.78744606273, 42557.7872110639, 41997.58002419975, 42122.57877421225, 42132.0, 42285.15429691404, 42292.36561451581, 7364.447666425012, 8768.693095741635, 8897.866532002025, 8901.0, 8901.287896968259, 7471.327580517753, 9971.75070623233, 10124.69625911224, 10152.0, 10162.695119146401, 10278.7430314242, 10287.434191119486, 10297.073263406292, 10299.691009269734, 10310.587576496968, 10244.180465562737, 10257.692269231935, 10280.845787313196, 10287.588496460132, 10287.794244115075, 10230.9488452558, 10252.33359831616, 10257.948710256402, 10263.486825658687, 10280.38317700933, 40220.39669404961, 40286.194276114315, 40373.394399084034, 40387.39418908719, 40424.191516169514, 3834.7307408160295, 3842.7117966152373, 3858.536975562922, 3884.3590807516725, 3899.961000389988, 28936.27659308513, 29430.558541621893, 29557.85221073881, 29796.404071918656, 29897.551536726965, 3999.14018486024, 4071.6156506787834, 4083.224187404384, 4091.1585682428317, 4263.59495847894, 222989.0, 223395.0, 224012.8799356009, 224151.9810023747, 224429.0, 49889.0, 49979.75010124926, 49996.0, 50010.749946250035, 50054.49945500571, 52581.2112818308, 52733.209001865005, 52822.47177528252, 52823.0, 52837.735811321465, 13507.324633768469, 13532.120412173177, 13560.254186019667, 13662.658433539042, 13670.17978921248, 9795.0, 9915.454649994175, 11375.203735738585, 11467.08263338931, 11478.655640330804, 11920.52317907274, 12908.58005619381, 13153.934230328978, 13578.388972496261, 13602.183868967893, 5170.8965820684125, 5360.91958620621, 5440.700761458079, 5473.370562385297, 5476.658218736435, 957.8563215517728, 963.3160456076264, 974.9317547771587, 981.7594689301025, 988.5205675247499, 26116.34709132287, 26369.736302637113, 26443.206703798918, 26893.731062689512, 26974.730252697223, 1000.9449480278655, 1013.8377859542438, 1019.1870437592298, 1027.8355463125863, 1038.5845661735216, 13830.37763300654, 14131.576052718436, 14331.570052898429, 14364.475190315017, 14518.637034074021, 269756.0, 272534.0, 296954.0, 301478.0, 302571.0, 46067.76966115148, 46278.537214627424, 46300.7684961573, 46435.303470447296, 46478.30282545764, 1375.8692924172187, 1376.3531140364014, 1390.1589538329165, 1394.1565352961516, 1396.0995158122953, 26419.207423777316, 27327.863360683863, 27602.861985690746, 27754.0, 28121.578176326962, 36104.819475902455, 43782.56217437912, 44556.999999998705, 49281.0, 49357.50642493673, 296417.0, 297277.0, 298865.0, 299067.0, 299511.0, 29221.415571688023, 29282.267943301587, 29631.111066668036, 29687.507811055024, 29700.702992969793, 36317.45523817198, 36924.44613330749, 37244.441333380564, 37550.06124846901, 47972.520274798204, 37755.43366849554, 38800.0, 40432.0, 41533.79233103815, 43378.56621433745, 40338.798306008284, 41054.58945410508, 41101.588984109774, 41541.58458415498, 43146.56853431551, 42011.579884200764, 43246.567534324255, 43608.12783744371, 43758.12483750371, 43829.34255986099, 33952.320953581286, 36210.45684314684, 36373.63626363808, 37194.6280537202, 37210.62789372072, 28479.715202847707, 28908.42183156283, 28917.132486025454, 28935.276618084717, 28947.42105157843], "value": 18333.78712058476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.31694534564514, 421.46480720637305, 430.4941693510126, 441.7482035239913, 448.17088386485005, 16378.83621163788, 18977.430677079694, 19962.201511939504, 20124.0, 20266.986650667463, 19773.209071637117, 20372.490687732814, 20696.586068278626, 20915.267965621206, 21362.786372136274, 6325.240971083476, 6385.233771947373, 6623.602583844985, 6636.73453061877, 6637.800865974004, 5413.458654134574, 6311.400416960381, 6445.452136568374, 6461.224653041641, 6462.289148193695, 6235.127082208494, 6367.4906007519285, 6416.743330266784, 6467.353264673542, 6471.579347342431, 6299.275583307933, 6321.905171422432, 6323.715432805535, 6329.8417539561415, 6334.746610135635, 6158.0, 6162.198914141178, 6200.325912003779, 6201.162843016225, 6212.471939885115, 23752.0, 23959.640605390934, 23987.52024959491, 24059.639105413433, 24114.758852411425, 3275.2958114005364, 3335.366280406715, 3404.472306792451, 3420.9315813683834, 3479.9130021749406, 15352.462663806826, 15920.840791592167, 16061.598460038476, 16710.58223544409, 16769.580760480963, 2091.874487530738, 2150.107705302313, 2157.3420106867397, 2223.633100538409, 2229.476073122815, 89919.55040224757, 90709.54645226798, 92843.53578232066, 93367.0, 94959.52520237424, 14608.809862588509, 18015.72976405355, 18806.905965470087, 19190.520236993907, 20380.59238815245, 30973.380532389678, 32095.197620059684, 32118.518222226685, 32177.0, 32244.516332255036, 8284.544350060805, 9080.22818060459, 9129.680461183827, 10053.447060411747, 10373.170146388271, 8264.710735124241, 8555.40112192153, 8560.743177704679, 8562.73087631778, 8627.266682331947, 9677.854562352957, 9702.611895524242, 9718.854217186748, 9723.235614548961, 9759.219262459128, 3196.888108916177, 3255.2493143293877, 3482.6169121396624, 3526.9719911050734, 3586.3903136466865, 924.1867156901883, 936.9297302702324, 938.5119737736339, 947.9620815167316, 947.9620815167455, 19844.206231750857, 21676.783232167792, 21707.348779536638, 21739.239126630808, 21933.890330548245, 925.9444433334022, 930.0792215706537, 931.1811376128508, 951.7192428233687, 963.7638778499313, 11900.523979040914, 12172.14794964344, 12289.754204915851, 12310.199837010745, 12346.629601111981, 271462.0, 272674.0, 273363.0, 273613.0, 610111.0, 84240.0, 84287.57856210803, 101083.0, 120471.39764301122, 123564.0, 1216.6410908781932, 1228.2814553486132, 1274.955376561816, 1279.405076639367, 1281.8910392616544, 17495.475135745946, 17933.461996140137, 18149.455516334532, 18707.7907470818, 18908.338208162648, 37027.444588330654, 41202.58797411987, 50386.49613503818, 51416.48583514117, 51892.22161667502, 50963.49036509587, 61308.386916130265, 62916.42708932313, 70868.29131708617, 72731.0, 12025.518979241082, 12043.578474753342, 12132.272063676208, 12218.6945326364, 12238.449269782703, 12914.418851151908, 13015.739685206054, 13115.737685246433, 13121.343932803513, 13184.143030702973, 12142.75714485723, 12146.210496317712, 12325.630231093082, 12334.691632709255, 12833.294168820805, 11066.336019838835, 12033.278003319829, 12082.879171208175, 12103.515859365527, 12479.812802808146, 11860.525578976743, 11953.760924781282, 12008.0, 12109.152359334763, 12303.138780285293, 11770.58802941893, 11842.28946263227, 11882.584109556125, 11919.76160476803, 12098.334591597195, 11989.880101198876, 12043.156979011384, 12361.505539778667, 12400.75198496007, 12418.627441176779], "value": 10792.289808472964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.69256302458, 1514.2050423527653, 1531.6170957260686, 1537.8769698424123, 1555.4633651390266, 10211.642592509264, 10948.3978381189, 10984.670459886196, 10987.725306867333, 10992.230543861933, 10334.379937203754, 10771.56913723452, 10776.40729759863, 11065.723356916082, 11107.611233606825, 2064.907079181433, 2102.1486298049313, 2102.4533621258506, 2103.737032870891, 2106.389147147333, 2030.786767389425, 2068.0900403822347, 2075.699023641571, 2080.126346934291, 2082.187946700788, 2039.1741344755399, 2050.7744148143693, 2054.12699602669, 2055.804698553635, 2057.043474784225, 1969.350114462224, 1970.2316096722218, 1971.2706298669511, 1971.5366888781125, 1975.387629834756, 1750.2124044180043, 1758.6834369813428, 1950.9609807803906, 2002.9699554506694, 2006.839452843769, 10631.255812093157, 10688.946555267252, 10693.358398496115, 10695.19786016044, 10702.892971070267, 5184.351956005499, 5282.524572788429, 5292.338457692788, 5310.628256022042, 5317.361916569997, 2948.2187220386613, 3115.081051089934, 3162.683731626819, 3163.3040731039137, 3201.7438604911786, 1150.206357613244, 1196.1208511743862, 1234.179270784927, 1266.4807428954177, 1275.6555729952954, 13701.314934253347, 14059.437622495088, 15081.622959426102, 15546.689066218725, 15710.293036813371, 4226.323788193874, 4417.867463976086, 4470.329450582439, 4496.235639941153, 4521.480029796549, 13275.535356262484, 13292.867071329356, 13294.601161965156, 13300.733985320432, 13320.800187997187, 4699.412573428322, 4836.395450568679, 5380.3274590676165, 5463.590230732711, 5472.179173123984, 4776.9761151194025, 4947.975260123676, 4950.331705219821, 4975.029869175549, 5041.0422019816115, 3725.1432170600915, 3853.8265778040054, 3873.5545412277384, 3948.4866967294643, 4000.5199376075057, 1079.794838980591, 1082.7726177502655, 1083.9349639021684, 1098.1708809848512, 1104.729341311384, 940.2571968145089, 952.5761036338763, 955.8231727130503, 961.1974001708512, 996.2229461020415, 5983.640981541122, 6131.877362452726, 6151.938480615226, 6156.630602163885, 6247.156633854372, 992.2855544008303, 996.2478328861663, 998.4358837256926, 1018.2617602238317, 1030.5362586835954, 3759.7180211484247, 3929.0766669832565, 3941.7832019238645, 4003.559608443069, 4067.08490589615, 13280.535181268802, 13557.728845423037, 13617.64764386461, 13741.03812733119, 13744.862551374557, 13209.40557674907, 13272.27002514871, 13384.130031547918, 13392.464301428028, 13404.530841420503, 9884.528867783054, 10027.949860250797, 10102.949485252673, 10110.77562936153, 10118.494075296207, 5808.73860676279, 5860.208871802252, 5871.412858714094, 5878.500327472213, 5969.582129250911, 11261.268017578832, 11947.581834635746, 11997.460114295052, 12027.45876435545, 12141.453634586289, 10732.946335268274, 10905.672829815117, 12190.878091219329, 12194.390280486117, 12195.51217951272, 8878.911210888067, 9013.819723605622, 9092.681756138503, 9206.217471514996, 9248.028956959422, 10305.072543471124, 10338.844917326096, 10412.843807342744, 10418.322809017389, 10420.270581059252, 8986.689694190596, 9081.545922703706, 9083.63665453401, 9283.0, 9312.394694344846, 8484.745457636282, 8506.532140732319, 8613.741587752378, 8660.653573857227, 8685.174908383693, 6734.8653026940165, 6771.28901465339, 6835.350641689031, 6839.2476827547935, 6848.212455567674, 5540.390557038642, 5620.072688006433, 5620.297462817148, 5675.347335056521, 5772.39389864075, 5734.082546792493, 5778.971105144447, 5816.0694288915265, 5827.329857066322, 6013.248343957005], "value": 4898.314507349536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.27019473584403, 406.10453949042363, 416.63136596281214, 420.8169446290864, 427.29709627662487, 5130.307408499852, 5222.608304377168, 5230.816921407747, 5230.966039696976, 5240.397354304256, 4988.3515143031445, 5076.111680455924, 5086.0590790703745, 5101.897962040757, 5125.820596279131, 4324.22164010478, 4348.717333373321, 4350.8259669613335, 4356.62766228637, 4365.672574556905, 4366.432363792718, 4372.344148377737, 4380.6495480361655, 4393.846215382462, 4409.536998615147, 4208.863606826155, 4318.870433886988, 4336.7181133226395, 4351.891202719926, 4354.934675979863, 4273.807678654468, 4302.569743025703, 4305.835211119825, 4307.956920430818, 4315.5900189481945, 4037.7981100944835, 4038.495188101487, 4049.7975101245115, 4064.6951478638925, 4095.160492099142, 4900.828471003533, 4916.336294600254, 4947.406311242638, 4972.925406118911, 5073.670211436245, 4926.45808961014, 4974.303597496353, 4976.208564916627, 4998.525140111684, 5002.924956125661, 5424.616722735677, 5444.700541470217, 5445.264889239981, 5471.206675032138, 5481.862953426196, 4256.743256743257, 4453.755043472608, 4476.239039363316, 4482.775861206959, 4486.641068714495, 5385.919211211796, 5480.91778623325, 5488.2711945737365, 5599.664020158803, 5615.747291371898, 4435.556444355539, 4516.774161291923, 4522.88692782683, 4537.274036154199, 4574.4446888057555, 4457.214241099313, 4630.448799652154, 4642.489326174118, 4645.466995891347, 4649.697769644962, 4799.520047995243, 4826.95173048272, 4998.475160108209, 5024.397072351341, 5037.244413337955, 5430.800525787063, 5431.8098866539485, 5443.918341224885, 5469.343678758574, 5483.424240454775, 1539.6074001129641, 1586.4130271799277, 1587.2619232056918, 1621.3109428493078, 1625.1874062968516, 1190.7142285851332, 1231.2981600487635, 1246.7631150081456, 1250.412306216077, 1253.3795771093185, 5245.973770131125, 5252.894942101137, 5253.36959564847, 5255.237990491358, 5271.65734227274, 5542.113261878161, 5568.276124103841, 5573.108302671553, 5589.882023595297, 5615.775368985195, 4889.4377146627885, 5197.454267301954, 5206.245094461282, 5215.791368345223, 5245.842624721265, 2911.694272101441, 2923.780716446275, 2925.527928900076, 2926.473234817711, 2949.5280755079084, 5675.744591493392, 5699.373068962411, 5772.3938986406665, 5774.884502310014, 5778.913316300259, 5344.759485823147, 5627.733759903989, 5677.403872593318, 5686.317641883001, 5730.36965933747, 5710.8001219957105, 5722.656640601661, 5749.3963133871175, 5750.856228594319, 5778.393268706725, 5230.398504172069, 5493.917591236055, 5523.895220955745, 5545.3622833374675, 5565.081761509306, 5487.506124448659, 5523.392426833126, 5532.778688852401, 5555.388907220122, 5573.359063707726, 5480.506754392124, 5592.608517403743, 5618.353889302619, 5700.603352178743, 5706.2011318414625, 4505.346724724831, 4565.201089809337, 4565.52062033495, 4570.223062079388, 4575.542445755398, 5319.776451416118, 5521.944780552143, 5528.253685752372, 5530.281063461724, 5534.889302214014, 5351.902859913786, 5424.186372044225, 5429.203959960544, 5445.50990410865, 5459.454054594509, 5430.864228394322, 5432.185172224198, 5453.263809385682, 5460.617756757148, 5473.658953556404, 5051.2423136529815, 5378.865528361822, 5385.919211211756, 5389.27244821944, 5409.675419474844, 5396.595255355943, 5401.2168235606405, 5403.594730395157, 5439.891202176013, 5452.773126046766, 5262.710550919736, 5360.678359298455, 5383.973080134731, 5395.843431592562, 5397.541208997122], "value": 4341.703316237154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.8952541406908, 777.3897490469982, 841.5035129273729, 847.588919374103, 855.7646647172027, 15588.142652154142, 16876.071816050113, 16894.07082610459, 16994.49016529503, 17033.488995330128, 14722.558323250292, 14864.479743208989, 14891.553253402388, 14900.105993640389, 14903.0, 807.3863863463765, 825.154216927648, 826.5495305058728, 832.3923535818856, 835.7534527314457, 822.7572866004513, 832.0057531250159, 832.0431503770682, 832.0473058348188, 832.138736407818, 871.2159056848824, 872.6073267029831, 872.6945569050813, 874.1826392323198, 874.2394117118116, 863.5984267315729, 866.9523176225305, 867.3668222197799, 867.5965675960678, 868.192580899763, 631.5042691487206, 635.3424205946823, 635.5678138865569, 635.6218050260088, 636.2841802971657, 15797.605059873595, 15886.52340429789, 15999.200039997953, 16470.258838352303, 16472.588185295343, 14206.786898196535, 14640.0, 14757.335919883632, 14808.555743327717, 14847.703045939128, 12192.695182620417, 12423.0, 12473.75052498954, 12664.81002784959, 13245.470181192837, 3662.61542538035, 3723.3298006359114, 3738.178420741389, 3747.8126093695478, 3809.8857034289017, 83574.0, 86940.0, 87627.56186219092, 88506.99999999936, 89255.55372223162, 10953.780924381468, 11052.447377631086, 11336.263142895685, 11494.379160694603, 11596.478158482889, 22256.666150007764, 22616.434589135402, 22637.43406414853, 22750.431239218822, 22784.886075569517, 7579.583122928292, 7626.618669066635, 7739.7291094812535, 7746.961265193638, 7832.373410127176, 4143.627073563393, 4229.619334259932, 4234.661227101825, 4249.46881639795, 4283.1433713257475, 3239.0, 3288.128645908836, 3293.8682452701623, 3310.741918071166, 3324.667533246656, 526.7971830845075, 529.6689569019363, 536.8067495701545, 539.5926075812736, 542.6689719271242, 599.9640021598718, 622.9595076320024, 643.5623775832386, 651.7034749189107, 665.5374514712325, 10266.897331026594, 10584.629537966135, 10864.511097000654, 11329.660110196708, 11330.433478326051, 780.3679019993823, 785.1716439156744, 794.5629903553023, 800.0, 802.2659266770839, 4964.776585053682, 5234.536018474788, 5243.737813109406, 5271.868203294948, 5302.2046692996355, 58660.706696467096, 71773.0, 72630.63684681543, 73841.6307918457, 75594.24405755872, 66520.33479665141, 67829.66085169543, 68567.0, 68965.0, 69437.0, 60375.39624603698, 60969.0, 61485.0, 61701.38298617046, 62198.378016220166, 10043.69868903934, 10058.40652726388, 10088.243381746252, 10140.847887281549, 10274.383536987805, 36381.81809090938, 36396.0, 37371.439428408055, 40280.59719402886, 44168.779156104014, 54834.72582637061, 55423.0, 55835.72082139563, 56403.43596564146, 56479.71760141337, 12378.133530653127, 12406.739047562496, 12474.313912734524, 12626.747465050832, 12672.493100275886, 14639.48761793332, 14660.486882959472, 14960.251987400805, 15213.923930380277, 15411.152386618394, 13634.181949083088, 13672.384742686801, 13937.09408888419, 14403.42386304536, 14442.494512692005, 14669.779953300922, 14711.3379897907, 14986.100833949999, 15086.24568771579, 15506.612334691723, 14692.779608306098, 14734.189619571027, 14804.555863324118, 14898.137732783402, 14940.178290194144, 12048.939755301168, 12308.753824923631, 12432.440540175894, 12608.306543140216, 12646.645469315104, 10009.69970900874, 11867.202495201453, 12157.1489995703, 12210.816837747263, 12432.875671243171], "value": 7346.350507080706, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 115.0, 113.0, 115.0, 115.0, 114.0, 114.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 118.0, 169.0, 119.0, 118.0, 120.0, 118.0, 150.0, 118.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 163.0, 163.0, 161.0, 164.0, 162.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 119.0, 76.0, 78.0, 76.0, 76.0, 96.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 83.0, 83.0, 84.0, 101.0, 82.0, 82.0, 110.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 60.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 85.0, 84.0, 85.0, 81.0, 81.0, 85.0, 80.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 126.0, 133.0, 127.0, 127.0, 125.0, 157.0, 162.0, 143.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 178.0, 170.0, 174.0, 174.0, 171.0, 171.0, 171.0, 169.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 69.0, 62.0, 63.0, 62.0, 63.0, 66.0, 64.0, 61.0], "value": 64.2, "unit": "score"}]}]} 09:25:56 INFO - Return code: 0 09:25:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:56 ERROR - # TBPL SUCCESS # 09:25:56 INFO - Running post-action listener: _resource_record_post_action 09:25:56 INFO - [mozharness: 2017-03-06 17:25:56.501628Z] Finished run-tests step (success) 09:25:56 INFO - Running post-run listener: _resource_record_post_run 09:25:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 364859392; Read time: 0; Write time: 211592 09:25:56 INFO - TinderboxPrint: CPU usage
13.2% 09:25:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:25:56 INFO - TinderboxPrint: I/O write bytes / time
364,859,392 / 211,592 09:25:56 INFO - TinderboxPrint: CPU idle
8,289.5 (86.8%) 09:25:56 INFO - TinderboxPrint: CPU user
1,215.7 (12.7%) 09:25:56 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111407104; Read time: 0; Write time: 72436 09:25:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 253452288; Read time: 0; Write time: 139156 09:25:57 INFO - Running post-run listener: _upload_blobber_files 09:25:57 INFO - Blob upload gear active. 09:25:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:58 INFO - (blobuploader) - INFO - Done attempting. 09:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:59 INFO - (blobuploader) - INFO - Done attempting. 09:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:00 INFO - (blobuploader) - INFO - Done attempting. 09:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:03 INFO - (blobuploader) - INFO - Done attempting. 09:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:03 INFO - Return code: 0 09:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaef62344b9e5ef3b1b0f664a171cc1919d26e1910b5bdaf2add237fb8069dfcdcc0803e6e235ee1a6de88dad10204902161509fe76850c1870d0a991b09db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/862d82bb160689e7828e938cee521ceee1518ab189a6ad373f7944ffa82f7f958c5c7220eabfa724b7ec5cc49fa76402b7dc1ed99507f2dfea81975250257940", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c55d0b3c995fc2be4f46972dd4bc0b814d96af21e550114749c7bbe4bc234f12ca281c46588ba94428ea1f908cbea176dc77f35bacfb51eb28229cc8c05744b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bd854eb612511e61024eeb4a2b5c22411fb1ea0cf9dbcc32e17feff4ee36c275d4a33c8f7e80ae4b0598206f8a1b3dc4d32d637894dcb0ed5bada1441966a"} 09:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:03 INFO - Contents: 09:26:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaef62344b9e5ef3b1b0f664a171cc1919d26e1910b5bdaf2add237fb8069dfcdcc0803e6e235ee1a6de88dad10204902161509fe76850c1870d0a991b09db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/862d82bb160689e7828e938cee521ceee1518ab189a6ad373f7944ffa82f7f958c5c7220eabfa724b7ec5cc49fa76402b7dc1ed99507f2dfea81975250257940", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c55d0b3c995fc2be4f46972dd4bc0b814d96af21e550114749c7bbe4bc234f12ca281c46588ba94428ea1f908cbea176dc77f35bacfb51eb28229cc8c05744b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bd854eb612511e61024eeb4a2b5c22411fb1ea0cf9dbcc32e17feff4ee36c275d4a33c8f7e80ae4b0598206f8a1b3dc4d32d637894dcb0ed5bada1441966a"} 09:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:03 INFO - Copying logs to upload dir... 09:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.026319 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-06 09:26:03.238769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 09:26:03.242462) ========= 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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 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/sha512/4aaef62344b9e5ef3b1b0f664a171cc1919d26e1910b5bdaf2add237fb8069dfcdcc0803e6e235ee1a6de88dad10204902161509fe76850c1870d0a991b09db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/862d82bb160689e7828e938cee521ceee1518ab189a6ad373f7944ffa82f7f958c5c7220eabfa724b7ec5cc49fa76402b7dc1ed99507f2dfea81975250257940", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c55d0b3c995fc2be4f46972dd4bc0b814d96af21e550114749c7bbe4bc234f12ca281c46588ba94428ea1f908cbea176dc77f35bacfb51eb28229cc8c05744b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bd854eb612511e61024eeb4a2b5c22411fb1ea0cf9dbcc32e17feff4ee36c275d4a33c8f7e80ae4b0598206f8a1b3dc4d32d637894dcb0ed5bada1441966a"} build_url:https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/Q4cI9DpLRMe6aVNfvclp-g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aaef62344b9e5ef3b1b0f664a171cc1919d26e1910b5bdaf2add237fb8069dfcdcc0803e6e235ee1a6de88dad10204902161509fe76850c1870d0a991b09db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/862d82bb160689e7828e938cee521ceee1518ab189a6ad373f7944ffa82f7f958c5c7220eabfa724b7ec5cc49fa76402b7dc1ed99507f2dfea81975250257940", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c55d0b3c995fc2be4f46972dd4bc0b814d96af21e550114749c7bbe4bc234f12ca281c46588ba94428ea1f908cbea176dc77f35bacfb51eb28229cc8c05744b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/648bd854eb612511e61024eeb4a2b5c22411fb1ea0cf9dbcc32e17feff4ee36c275d4a33c8f7e80ae4b0598206f8a1b3dc4d32d637894dcb0ed5bada1441966a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 09:26:03.267639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:26:03.267964) ========= 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=3297cc2eebb5444a7688c33f000001b5-1488819104.944872-1881454877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:26:03.351941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 09:26:03.352266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 09:26:03.352562) ========= ========= Total master_lag: 0.19 =========