builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1490369355.59 results: success (0) revision: 073e0a5f1fd515d258064c3622de8f79187f15ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.594468) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.594892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.595176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.610167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.610533) ========= 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=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-24 08:29:16-- 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% 42.7M=0s 2017-03-24 08:29:16 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.731683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.732113) ========= 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=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015301 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:15.783213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 08:29:15.783829) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 073e0a5f1fd515d258064c3622de8f79187f15ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 073e0a5f1fd515d258064c3622de8f79187f15ba --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=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-24 08:29:16,432 truncating revision to first 12 chars 2017-03-24 08:29:16,433 Setting DEBUG logging. 2017-03-24 08:29:16,433 attempt 1/10 2017-03-24 08:29:16,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/073e0a5f1fd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 08:29:17,399 unpacking tar archive at: mozilla-aurora-073e0a5f1fd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 08:29:17.111727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:17.112055) ========= script_repo_revision: 073e0a5f1fd515d258064c3622de8f79187f15ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:17.112447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:17.112704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 08:29:17.123636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-24 08:29:17.124040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:17 INFO - MultiFileLogger online at 20170324 08:29:17 in /builds/slave/test 08:29:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 08:29:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:17 INFO - {'append_to_log': False, 08:29:17 INFO - 'base_work_dir': '/builds/slave/test', 08:29:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 08:29:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:17 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 08:29:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:17 INFO - 'config_files': ('talos/linux_config.py',), 08:29:17 INFO - 'default_actions': ('clobber', 08:29:17 INFO - 'read-buildbot-config', 08:29:17 INFO - 'download-and-extract', 08:29:17 INFO - 'populate-webroot', 08:29:17 INFO - 'create-virtualenv', 08:29:17 INFO - 'install', 08:29:17 INFO - 'run-tests'), 08:29:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:17 INFO - 'download_minidump_stackwalk': True, 08:29:17 INFO - 'download_symbols': 'ondemand', 08:29:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:17 INFO - 'gecko_profile': False, 08:29:17 INFO - 'gecko_profile_interval': 0, 08:29:17 INFO - 'installer_path': 'installer.exe', 08:29:17 INFO - 'log_level': 'info', 08:29:17 INFO - 'log_name': 'talos', 08:29:17 INFO - 'log_to_console': True, 08:29:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:17 INFO - 'opt_config_files': (), 08:29:17 INFO - 'pip_index': False, 08:29:17 INFO - 'suite': 'dromaeojs', 08:29:17 INFO - 'system_bits': '32', 08:29:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:17 INFO - 'title': 'talos-linux64-ix-048', 08:29:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:17 INFO - 'use_talos_json': True, 08:29:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:17 INFO - 'work_dir': 'build'} 08:29:17 INFO - [mozharness: 2017-03-24 15:29:17.861964Z] Running clobber step. 08:29:17 INFO - Running pre-action listener: _resource_record_pre_action 08:29:17 INFO - Running main action method: clobber 08:29:17 INFO - rmtree: /builds/slave/test/build 08:29:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:19 INFO - Running post-action listener: _resource_record_post_action 08:29:19 INFO - [mozharness: 2017-03-24 15:29:19.394950Z] Finished clobber step (success) 08:29:19 INFO - [mozharness: 2017-03-24 15:29:19.395048Z] Running read-buildbot-config step. 08:29:19 INFO - Running pre-action listener: _resource_record_pre_action 08:29:19 INFO - Running main action method: read_buildbot_config 08:29:19 INFO - Using buildbot properties: 08:29:19 INFO - { 08:29:19 INFO - "project": "", 08:29:19 INFO - "product": "firefox", 08:29:19 INFO - "who": "ffxbld@noreply.mozilla.org", 08:29:19 INFO - "installer_path": "public/build/target.tar.bz2", 08:29:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:29:19 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:29:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 08:29:19 INFO - "stage_platform": "linux64", 08:29:19 INFO - "basedir": "/builds/slave/test", 08:29:19 INFO - "buildnumber": 88, 08:29:19 INFO - "platform": "ubuntu64_hw", 08:29:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:29:19 INFO - "slavebuilddir": "test", 08:29:19 INFO - "taskId": "EMGhC3tDRvevQYgHSU5HzA", 08:29:19 INFO - "branch": "mozilla-aurora", 08:29:19 INFO - "script_repo_revision": "production", 08:29:19 INFO - "revision": "073e0a5f1fd515d258064c3622de8f79187f15ba", 08:29:19 INFO - "slavename": "talos-linux64-ix-048", 08:29:19 INFO - "repo_path": "releases/mozilla-aurora" 08:29:19 INFO - } 08:29:19 INFO - Finding installer, test and symbols from parent task. 08:29:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMGhC3tDRvevQYgHSU5HzA'}, attempt #1 08:29:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EMGhC3tDRvevQYgHSU5HzA'}, attempt #1 08:29:20 INFO - Task dependencies: HW4EDsCfS0i16Lrs_l0lhw 08:29:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw'}, attempt #1 08:29:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 08:29:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/test_packages.json 08:29:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.crashreporter-symbols.zip 08:29:20 INFO - Running post-action listener: _resource_record_post_action 08:29:20 INFO - [mozharness: 2017-03-24 15:29:20.781876Z] Finished read-buildbot-config step (success) 08:29:20 INFO - [mozharness: 2017-03-24 15:29:20.782094Z] Running download-and-extract step. 08:29:20 INFO - Running pre-action listener: _resource_record_pre_action 08:29:20 INFO - Running main action method: download_and_extract 08:29:20 INFO - mkdir: /builds/slave/test/build/tests 08:29:20 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')]} 08:29:20 INFO - trying https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.test_packages.json 08:29:20 INFO - Downloading https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:29:21 INFO - Downloaded 896 bytes. 08:29:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:29:21 INFO - Using the following test package requirements: 08:29:21 INFO - {u'common': [u'target.common.tests.zip'], 08:29:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:29:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:29:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:29:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:29:21 INFO - u'mozbase': [u'target.common.tests.zip'], 08:29:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:29:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:29:21 INFO - u'web-platform': [u'target.common.tests.zip', 08:29:21 INFO - u'target.web-platform.tests.zip'], 08:29:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:29:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:29:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip 08:29:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:29:21 INFO - Fetch https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip into memory 08:29:22 INFO - Expected file size: 59539053 08:29:22 INFO - Obtained file size: 59539053 08:29:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:29:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip 08:29:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:29:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.common.tests.zip into memory 08:29:33 INFO - Expected file size: 59539053 08:29:33 INFO - Obtained file size: 59539053 08:29:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.talos.tests.zip 08:29:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:29:44 INFO - Fetch https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.talos.tests.zip into memory 08:29:44 INFO - Expected file size: 14404438 08:29:44 INFO - Obtained file size: 14404438 08:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:45 INFO - trying https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 08:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:29:46 INFO - Downloaded 66693085 bytes. 08:29:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 08:29:46 INFO - mkdir: /builds/slave/test/properties 08:29:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:46 INFO - Contents: 08:29:46 INFO - build_url:https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 08:29:46 INFO - Running post-action listener: _resource_record_post_action 08:29:46 INFO - Running post-action listener: set_extra_try_arguments 08:29:46 INFO - [mozharness: 2017-03-24 15:29:46.193459Z] Finished download-and-extract step (success) 08:29:46 INFO - [mozharness: 2017-03-24 15:29:46.193556Z] Running populate-webroot step. 08:29:46 INFO - Running pre-action listener: _resource_record_pre_action 08:29:46 INFO - Running main action method: populate_webroot 08:29:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:46 INFO - '--tppagecycles', 08:29:46 INFO - '7'], 08:29:46 INFO - 'tests': ['tsvgm']}}, 08:29:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['damp', 'tps']}, 08:29:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'tests': ['damp', 'tps']}, 08:29:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['dromaeo_dom']}, 08:29:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['basic_compositor_video']}, 08:29:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['a11yr', 08:29:46 INFO - 'ts_paint', 08:29:46 INFO - 'tpaint', 08:29:46 INFO - 'sessionrestore', 08:29:46 INFO - 'sessionrestore_no_auto_restore', 08:29:46 INFO - 'tabpaint']}, 08:29:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['tsvgx', 08:29:46 INFO - 'tsvgr_opacity', 08:29:46 INFO - 'tart', 08:29:46 INFO - 'tscrollx', 08:29:46 INFO - 'cart', 08:29:46 INFO - 'tsvg_static']}, 08:29:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:46 INFO - 'tsvgr_opacity', 08:29:46 INFO - 'tart', 08:29:46 INFO - 'tscrollx', 08:29:46 INFO - 'cart', 08:29:46 INFO - 'tsvg_static']}, 08:29:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'talos_options': ['--disable-e10s'], 08:29:46 INFO - 'tests': ['tp5o']}, 08:29:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:29:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'talos_options': ['--disable-e10s', 08:29:46 INFO - '--xperf_path', 08:29:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:46 INFO - 'tests': ['tp5n']}, 08:29:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:29:46 INFO - 'talos_options': ['--xperf_path', 08:29:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:46 INFO - 'tests': ['tp5n']}}, 08:29:46 INFO - 'talos.zip': {'path': '', 08:29:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:46 INFO - Running post-action listener: _resource_record_post_action 08:29:46 INFO - [mozharness: 2017-03-24 15:29:46.206660Z] Finished populate-webroot step (success) 08:29:46 INFO - [mozharness: 2017-03-24 15:29:46.206751Z] Running create-virtualenv step. 08:29:46 INFO - Running pre-action listener: _resource_record_pre_action 08:29:46 INFO - Running main action method: create_virtualenv 08:29:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:46 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 08:29:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:46 INFO - Using real prefix '/usr' 08:29:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:48 INFO - Installing pip.................done. 08:29:48 INFO - Return code: 0 08:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:29:48 INFO - Reading from file tmpfile_stdout 08:29:48 INFO - Output received: 08:29:48 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) 08:29:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:49 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:49 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 08:29:49 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 08:29:49 INFO - Using env: {'DISPLAY': ':0', 08:29:49 INFO - 'HOME': '/home/cltbld', 08:29:49 INFO - 'LANG': 'en_US.UTF-8', 08:29:49 INFO - 'LANGUAGE': 'en_US:en', 08:29:49 INFO - 'LOGNAME': 'cltbld', 08:29:49 INFO - 'MAIL': '/var/mail/cltbld', 08:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:49 INFO - 'MOZ_NO_REMOTE': '1', 08:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:49 INFO - 'NO_EM_RESTART': '1', 08:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:49 INFO - 'PWD': '/builds/slave/test', 08:29:49 INFO - 'SHELL': '/bin/bash', 08:29:49 INFO - 'SHLVL': '1', 08:29:49 INFO - 'TERM': 'linux', 08:29:49 INFO - 'TMOUT': '86400', 08:29:49 INFO - 'USER': 'cltbld', 08:29:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:49 INFO - '_': '/tools/buildbot/bin/python'} 08:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:49 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 08:29:49 INFO - Cleaning up... 08:29:49 INFO - Return code: 0 08:29:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:49 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:49 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 08:29:49 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 08:29:49 INFO - Using env: {'DISPLAY': ':0', 08:29:49 INFO - 'HOME': '/home/cltbld', 08:29:49 INFO - 'LANG': 'en_US.UTF-8', 08:29:49 INFO - 'LANGUAGE': 'en_US:en', 08:29:49 INFO - 'LOGNAME': 'cltbld', 08:29:49 INFO - 'MAIL': '/var/mail/cltbld', 08:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:49 INFO - 'MOZ_NO_REMOTE': '1', 08:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:49 INFO - 'NO_EM_RESTART': '1', 08:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:49 INFO - 'PWD': '/builds/slave/test', 08:29:49 INFO - 'SHELL': '/bin/bash', 08:29:49 INFO - 'SHLVL': '1', 08:29:49 INFO - 'TERM': 'linux', 08:29:49 INFO - 'TMOUT': '86400', 08:29:49 INFO - 'USER': 'cltbld', 08:29:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:49 INFO - '_': '/tools/buildbot/bin/python'} 08:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:49 INFO - Downloading/unpacking psutil>=3.1.1 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:51 INFO - Installing collected packages: psutil 08:29:51 INFO - Running setup.py install for psutil 08:29:51 INFO - building 'psutil._psutil_linux' extension 08:29:51 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 08:29:51 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 08:29:51 INFO - building 'psutil._psutil_posix' extension 08:29:51 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 08:29:51 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 08:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:52 INFO - Successfully installed psutil 08:29:52 INFO - Cleaning up... 08:29:52 INFO - Return code: 0 08:29:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:29:52 INFO - Using env: {'DISPLAY': ':0', 08:29:52 INFO - 'HOME': '/home/cltbld', 08:29:52 INFO - 'LANG': 'en_US.UTF-8', 08:29:52 INFO - 'LANGUAGE': 'en_US:en', 08:29:52 INFO - 'LOGNAME': 'cltbld', 08:29:52 INFO - 'MAIL': '/var/mail/cltbld', 08:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:52 INFO - 'MOZ_NO_REMOTE': '1', 08:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:52 INFO - 'NO_EM_RESTART': '1', 08:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:52 INFO - 'PWD': '/builds/slave/test', 08:29:52 INFO - 'SHELL': '/bin/bash', 08:29:52 INFO - 'SHLVL': '1', 08:29:52 INFO - 'TERM': 'linux', 08:29:52 INFO - 'TMOUT': '86400', 08:29:52 INFO - 'USER': 'cltbld', 08:29:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:52 INFO - '_': '/tools/buildbot/bin/python'} 08:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:52 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 08:29:52 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 08:29:52 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 08:29:52 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 08:29:52 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 08:29:52 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 08:29:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:54 INFO - Installing collected packages: mozsystemmonitor 08:29:54 INFO - Running setup.py install for mozsystemmonitor 08:29:54 INFO - Successfully installed mozsystemmonitor 08:29:54 INFO - Cleaning up... 08:29:54 INFO - Return code: 0 08:29:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:54 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:54 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 08:29:54 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 08:29:54 INFO - Using env: {'DISPLAY': ':0', 08:29:54 INFO - 'HOME': '/home/cltbld', 08:29:54 INFO - 'LANG': 'en_US.UTF-8', 08:29:54 INFO - 'LANGUAGE': 'en_US:en', 08:29:54 INFO - 'LOGNAME': 'cltbld', 08:29:54 INFO - 'MAIL': '/var/mail/cltbld', 08:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:54 INFO - 'MOZ_NO_REMOTE': '1', 08:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:54 INFO - 'NO_EM_RESTART': '1', 08:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:54 INFO - 'PWD': '/builds/slave/test', 08:29:54 INFO - 'SHELL': '/bin/bash', 08:29:54 INFO - 'SHLVL': '1', 08:29:54 INFO - 'TERM': 'linux', 08:29:54 INFO - 'TMOUT': '86400', 08:29:54 INFO - 'USER': 'cltbld', 08:29:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:54 INFO - '_': '/tools/buildbot/bin/python'} 08:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:54 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 08:29:54 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 08:29:54 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 08:29:54 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 08:29:54 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 08:29:54 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 08:29:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:57 INFO - warning: no files found matching '*.txt' 08:29:57 INFO - no previously-included directories found matching 'build' 08:29:57 INFO - no previously-included directories found matching 'dist' 08:29:57 INFO - no previously-included directories found matching '.git*' 08:29:57 INFO - Installing collected packages: jsonschema, functools32 08:29:57 INFO - Running setup.py install for functools32 08:29:57 INFO - warning: no files found matching '*.txt' 08:29:57 INFO - no previously-included directories found matching 'build' 08:29:57 INFO - no previously-included directories found matching 'dist' 08:29:57 INFO - no previously-included directories found matching '.git*' 08:29:57 INFO - Successfully installed jsonschema functools32 08:29:57 INFO - Cleaning up... 08:29:57 INFO - Return code: 0 08:29:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:29:57 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')]} 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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')]} 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:57 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 08:29:57 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 08:29:57 INFO - Using env: {'DISPLAY': ':0', 08:29:57 INFO - 'HOME': '/home/cltbld', 08:29:57 INFO - 'LANG': 'en_US.UTF-8', 08:29:57 INFO - 'LANGUAGE': 'en_US:en', 08:29:57 INFO - 'LOGNAME': 'cltbld', 08:29:57 INFO - 'MAIL': '/var/mail/cltbld', 08:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:57 INFO - 'MOZ_NO_REMOTE': '1', 08:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:57 INFO - 'NO_EM_RESTART': '1', 08:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:57 INFO - 'PWD': '/builds/slave/test', 08:29:57 INFO - 'SHELL': '/bin/bash', 08:29:57 INFO - 'SHLVL': '1', 08:29:57 INFO - 'TERM': 'linux', 08:29:57 INFO - 'TMOUT': '86400', 08:29:57 INFO - 'USER': 'cltbld', 08:29:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:57 INFO - '_': '/tools/buildbot/bin/python'} 08:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:29:57 INFO - Cleaning up... 08:29:57 INFO - Return code: 0 08:29:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:57 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')]} 08:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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')]} 08:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:57 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:29:57 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 08:29:57 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 08:29:57 INFO - Using env: {'DISPLAY': ':0', 08:29:57 INFO - 'HOME': '/home/cltbld', 08:29:57 INFO - 'LANG': 'en_US.UTF-8', 08:29:57 INFO - 'LANGUAGE': 'en_US:en', 08:29:57 INFO - 'LOGNAME': 'cltbld', 08:29:57 INFO - 'MAIL': '/var/mail/cltbld', 08:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:57 INFO - 'MOZ_NO_REMOTE': '1', 08:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:57 INFO - 'NO_EM_RESTART': '1', 08:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:57 INFO - 'PWD': '/builds/slave/test', 08:29:57 INFO - 'SHELL': '/bin/bash', 08:29:57 INFO - 'SHLVL': '1', 08:29:57 INFO - 'TERM': 'linux', 08:29:57 INFO - 'TMOUT': '86400', 08:29:57 INFO - 'USER': 'cltbld', 08:29:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:57 INFO - '_': '/tools/buildbot/bin/python'} 08:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:57 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 08:29:57 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 08:29:57 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 08:29:57 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 08:29:57 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 08:29:57 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 08:29:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:59 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 08:29:59 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 08:29:59 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 08:29:59 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 08:29:59 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 08:29:59 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 08:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:30:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:30:00 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 08:30:00 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 08:30:00 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 08:30:00 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 08:30:00 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 08:30:00 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 08:30:00 INFO - Downloading docopt-0.6.1.tar.gz 08:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:30:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:30:00 INFO - Running setup.py install for blobuploader 08:30:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:30:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:30:00 INFO - Running setup.py install for requests 08:30:01 INFO - Running setup.py install for docopt 08:30:01 INFO - Successfully installed blobuploader requests docopt 08:30:01 INFO - Cleaning up... 08:30:01 INFO - Return code: 0 08:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:01 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:30:01 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 08:30:01 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 08:30:01 INFO - Using env: {'DISPLAY': ':0', 08:30:01 INFO - 'HOME': '/home/cltbld', 08:30:01 INFO - 'LANG': 'en_US.UTF-8', 08:30:01 INFO - 'LANGUAGE': 'en_US:en', 08:30:01 INFO - 'LOGNAME': 'cltbld', 08:30:01 INFO - 'MAIL': '/var/mail/cltbld', 08:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:01 INFO - 'MOZ_NO_REMOTE': '1', 08:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:01 INFO - 'NO_EM_RESTART': '1', 08:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:01 INFO - 'PWD': '/builds/slave/test', 08:30:01 INFO - 'SHELL': '/bin/bash', 08:30:01 INFO - 'SHLVL': '1', 08:30:01 INFO - 'TERM': 'linux', 08:30:01 INFO - 'TMOUT': '86400', 08:30:01 INFO - 'USER': 'cltbld', 08:30:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:01 INFO - '_': '/tools/buildbot/bin/python'} 08:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:01 INFO - Running setup.py (path:/tmp/pip-UJpdSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:01 INFO - Running setup.py (path:/tmp/pip-knSo49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:01 INFO - Running setup.py (path:/tmp/pip-DBsoe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:01 INFO - Running setup.py (path:/tmp/pip-_W1OlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:01 INFO - Running setup.py (path:/tmp/pip-MlnarR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:01 INFO - Running setup.py (path:/tmp/pip-mv6eMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:01 INFO - Running setup.py (path:/tmp/pip-doDnj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:01 INFO - Running setup.py (path:/tmp/pip-cjcJ8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:01 INFO - Running setup.py (path:/tmp/pip-LZuzVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:02 INFO - Running setup.py (path:/tmp/pip-vy4yP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:02 INFO - Running setup.py (path:/tmp/pip-wpWPMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:02 INFO - Running setup.py (path:/tmp/pip-ifN_0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:02 INFO - Running setup.py (path:/tmp/pip-RI3Qpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:02 INFO - Running setup.py (path:/tmp/pip-0wDw48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:02 INFO - Running setup.py (path:/tmp/pip-F_NGtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:02 INFO - Running setup.py (path:/tmp/pip-UzysU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:02 INFO - Running setup.py (path:/tmp/pip-SekXbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:30:02 INFO - Running setup.py install for manifestparser 08:30:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:30:02 INFO - Running setup.py install for mozcrash 08:30:02 INFO - Running setup.py install for mozdebug 08:30:02 INFO - Running setup.py install for mozdevice 08:30:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for mozfile 08:30:03 INFO - Running setup.py install for mozhttpd 08:30:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for mozinfo 08:30:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for mozInstall 08:30:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for mozleak 08:30:03 INFO - Running setup.py install for mozlog 08:30:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for moznetwork 08:30:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Running setup.py install for mozprocess 08:30:03 INFO - Running setup.py install for mozprofile 08:30:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:30:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:30:04 INFO - Running setup.py install for mozrunner 08:30:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:30:04 INFO - Running setup.py install for mozscreenshot 08:30:04 INFO - Running setup.py install for moztest 08:30:04 INFO - Running setup.py install for mozversion 08:30:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:30:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:30:04 INFO - Cleaning up... 08:30:04 INFO - Return code: 0 08:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:04 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:30:04 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 08:30:04 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 08:30:04 INFO - Using env: {'DISPLAY': ':0', 08:30:04 INFO - 'HOME': '/home/cltbld', 08:30:04 INFO - 'LANG': 'en_US.UTF-8', 08:30:04 INFO - 'LANGUAGE': 'en_US:en', 08:30:04 INFO - 'LOGNAME': 'cltbld', 08:30:04 INFO - 'MAIL': '/var/mail/cltbld', 08:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:04 INFO - 'MOZ_NO_REMOTE': '1', 08:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:04 INFO - 'NO_EM_RESTART': '1', 08:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:04 INFO - 'PWD': '/builds/slave/test', 08:30:04 INFO - 'SHELL': '/bin/bash', 08:30:04 INFO - 'SHLVL': '1', 08:30:04 INFO - 'TERM': 'linux', 08:30:04 INFO - 'TMOUT': '86400', 08:30:04 INFO - 'USER': 'cltbld', 08:30:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:04 INFO - '_': '/tools/buildbot/bin/python'} 08:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:30:04 INFO - Running setup.py (path:/tmp/pip-qkIUcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:30:04 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)) 08:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:30:04 INFO - Running setup.py (path:/tmp/pip-ikLW2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:30:04 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)) 08:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:30:04 INFO - Running setup.py (path:/tmp/pip-_Tkxdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:30:04 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)) 08:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:30:04 INFO - Running setup.py (path:/tmp/pip-bZmK_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:30:04 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)) 08:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:30:04 INFO - Running setup.py (path:/tmp/pip-0vU9ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:30:05 INFO - Running setup.py (path:/tmp/pip-tnRpCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:30:05 INFO - Running setup.py (path:/tmp/pip-f2AtyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:30:05 INFO - Running setup.py (path:/tmp/pip-zOBHA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:30:05 INFO - Running setup.py (path:/tmp/pip-pVef0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:30:05 INFO - Running setup.py (path:/tmp/pip-PhgjE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:30:05 INFO - Running setup.py (path:/tmp/pip-I4QfAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:30:05 INFO - Running setup.py (path:/tmp/pip-h8kUvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:30:05 INFO - Running setup.py (path:/tmp/pip-G4UC6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:30:05 INFO - Running setup.py (path:/tmp/pip-smYrWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:05 INFO - Running setup.py (path:/tmp/pip-gocAfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:30:05 INFO - Running setup.py (path:/tmp/pip-0SW73i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:30:05 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)) 08:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:30:05 INFO - Running setup.py (path:/tmp/pip-4kEGdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:30:05 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)) 08:30:05 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)) 08:30:05 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)) 08:30:05 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)) 08:30:05 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)) 08:30:05 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)) 08:30:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:05 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 08:30:07 INFO - Downloading blessings-1.6.tar.gz 08:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:30:07 INFO - Installing collected packages: blessings 08:30:07 INFO - Running setup.py install for blessings 08:30:08 INFO - Successfully installed blessings 08:30:08 INFO - Cleaning up... 08:30:08 INFO - Return code: 0 08:30:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:08 INFO - Reading from file tmpfile_stdout 08:30:08 INFO - Current package versions: 08:30:08 INFO - argparse == 1.2.1 08:30:08 INFO - blessings == 1.6 08:30:08 INFO - blobuploader == 1.2.4 08:30:08 INFO - docopt == 0.6.1 08:30:08 INFO - functools32 == 3.2.3-2 08:30:08 INFO - jsonschema == 2.5.1 08:30:08 INFO - manifestparser == 1.1 08:30:08 INFO - mozInstall == 1.12 08:30:08 INFO - mozcrash == 1.0 08:30:08 INFO - mozdebug == 0.1 08:30:08 INFO - mozdevice == 0.49 08:30:08 INFO - mozfile == 1.2 08:30:08 INFO - mozhttpd == 0.7 08:30:08 INFO - mozinfo == 0.9 08:30:08 INFO - mozleak == 0.1 08:30:08 INFO - mozlog == 3.4 08:30:08 INFO - moznetwork == 0.27 08:30:08 INFO - mozprocess == 0.25 08:30:08 INFO - mozprofile == 0.28 08:30:08 INFO - mozrunner == 6.13 08:30:08 INFO - mozscreenshot == 0.1 08:30:08 INFO - mozsystemmonitor == 0.3 08:30:08 INFO - moztest == 0.8 08:30:08 INFO - mozversion == 1.4 08:30:08 INFO - psutil == 3.1.1 08:30:08 INFO - requests == 1.2.3 08:30:08 INFO - wsgiref == 0.1.2 08:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:30:08 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 08:30:08 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 08:30:08 INFO - Using env: {'DISPLAY': ':0', 08:30:08 INFO - 'HOME': '/home/cltbld', 08:30:08 INFO - 'LANG': 'en_US.UTF-8', 08:30:08 INFO - 'LANGUAGE': 'en_US:en', 08:30:08 INFO - 'LOGNAME': 'cltbld', 08:30:08 INFO - 'MAIL': '/var/mail/cltbld', 08:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:08 INFO - 'MOZ_NO_REMOTE': '1', 08:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:08 INFO - 'NO_EM_RESTART': '1', 08:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:08 INFO - 'PWD': '/builds/slave/test', 08:30:08 INFO - 'SHELL': '/bin/bash', 08:30:08 INFO - 'SHLVL': '1', 08:30:08 INFO - 'TERM': 'linux', 08:30:08 INFO - 'TMOUT': '86400', 08:30:08 INFO - 'USER': 'cltbld', 08:30:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:08 INFO - '_': '/tools/buildbot/bin/python'} 08:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 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)) 08:30:08 INFO - Cleaning up... 08:30:08 INFO - Return code: 0 08:30:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:08 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 0x21d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, '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': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', '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 08:30:08 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 08:30:08 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 08:30:08 INFO - Using env: {'DISPLAY': ':0', 08:30:08 INFO - 'HOME': '/home/cltbld', 08:30:08 INFO - 'LANG': 'en_US.UTF-8', 08:30:08 INFO - 'LANGUAGE': 'en_US:en', 08:30:08 INFO - 'LOGNAME': 'cltbld', 08:30:08 INFO - 'MAIL': '/var/mail/cltbld', 08:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:08 INFO - 'MOZ_NO_REMOTE': '1', 08:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:08 INFO - 'NO_EM_RESTART': '1', 08:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:08 INFO - 'PWD': '/builds/slave/test', 08:30:08 INFO - 'SHELL': '/bin/bash', 08:30:08 INFO - 'SHLVL': '1', 08:30:08 INFO - 'TERM': 'linux', 08:30:08 INFO - 'TMOUT': '86400', 08:30:08 INFO - 'USER': 'cltbld', 08:30:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:08 INFO - '_': '/tools/buildbot/bin/python'} 08:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:30:08 INFO - Cleaning up... 08:30:08 INFO - Return code: 0 08:30:08 INFO - Running post-action listener: _resource_record_post_action 08:30:08 INFO - Running post-action listener: _start_resource_monitoring 08:30:08 INFO - Starting resource monitoring. 08:30:08 INFO - [mozharness: 2017-03-24 15:30:08.883331Z] Finished create-virtualenv step (success) 08:30:08 INFO - [mozharness: 2017-03-24 15:30:08.883799Z] Running install step. 08:30:08 INFO - Running pre-action listener: _resource_record_pre_action 08:30:08 INFO - Running main action method: install 08:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:30:09 INFO - Reading from file tmpfile_stdout 08:30:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:30:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:30:09 INFO - Reading from file tmpfile_stdout 08:30:09 INFO - Output received: 08:30:09 INFO - Usage: mozinstall [options] installer 08:30:09 INFO - Options: 08:30:09 INFO - -h, --help show this help message and exit 08:30:09 INFO - -d DEST, --destination=DEST 08:30:09 INFO - Directory to install application into. [default: 08:30:09 INFO - "/builds/slave/test"] 08:30:09 INFO - --app=APP Application being installed. [default: firefox] 08:30:09 INFO - mkdir: /builds/slave/test/build/application 08:30:09 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'] 08:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:30:25 INFO - Reading from file tmpfile_stdout 08:30:25 INFO - Output received: 08:30:25 INFO - /builds/slave/test/build/application/firefox/firefox 08:30:25 INFO - Running post-action listener: _resource_record_post_action 08:30:25 INFO - [mozharness: 2017-03-24 15:30:25.903559Z] Finished install step (success) 08:30:25 INFO - [mozharness: 2017-03-24 15:30:25.903835Z] Running run-tests step. 08:30:25 INFO - Running pre-action listener: _resource_record_pre_action 08:30:25 INFO - Running main action method: run_tests 08:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:25 INFO - Python 2.7.3 08:30:25 INFO - Return code: 0 08:30:25 INFO - grabbing minidump binary from tooltool 08:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:25 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 0x2474400>, '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 0x24753b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:25 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 08:30:25 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 08:30:25 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 08:30:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:25 INFO - Return code: 0 08:30:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:30:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:25 INFO - ENV: RUST_BACKTRACE is now 1 08:30:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:30:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 08:30:25 INFO - Using env: {'DISPLAY': ':0', 08:30:25 INFO - 'HOME': '/home/cltbld', 08:30:25 INFO - 'LANG': 'en_US.UTF-8', 08:30:25 INFO - 'LANGUAGE': 'en_US:en', 08:30:25 INFO - 'LOGNAME': 'cltbld', 08:30:25 INFO - 'MAIL': '/var/mail/cltbld', 08:30:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:25 INFO - 'MOZ_NO_REMOTE': '1', 08:30:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:30:25 INFO - 'NO_EM_RESTART': '1', 08:30:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:25 INFO - 'PWD': '/builds/slave/test', 08:30:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:25 INFO - 'RUST_BACKTRACE': '1', 08:30:25 INFO - 'SHELL': '/bin/bash', 08:30:25 INFO - 'SHLVL': '1', 08:30:25 INFO - 'TERM': 'linux', 08:30:25 INFO - 'TMOUT': '86400', 08:30:25 INFO - 'USER': 'cltbld', 08:30:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059', 08:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:25 INFO - '_': '/tools/buildbot/bin/python'} 08:30:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:30:26 INFO - mozversion application_buildid: 20170324143418 08:30:26 INFO - mozversion application_changeset: 073e0a5f1fd515d258064c3622de8f79187f15ba 08:30:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:30:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:26 INFO - mozversion application_name: Firefox 08:30:26 INFO - mozversion application_remotingname: firefox-dev 08:30:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:26 INFO - mozversion application_vendor: Mozilla 08:30:26 INFO - mozversion application_version: 54.0a2 08:30:26 INFO - mozversion platform_buildid: 20170324143418 08:30:26 INFO - mozversion platform_changeset: 073e0a5f1fd515d258064c3622de8f79187f15ba 08:30:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:30:26 INFO - mozversion platform_version: 54.0a2 08:30:26 INFO - using testdate: 1490369426 08:30:26 INFO - actual date: 1490369426 08:30:26 INFO - starting webserver on 'localhost:33751' 08:30:26 INFO - SUITE-START | Running 2 tests 08:30:26 INFO - TEST-START | dromaeo_css 08:30:26 INFO - operating with platform_type : linux_ 08:30:26 INFO - Initialising browser for dromaeo_css test... 08:30:26 INFO - TEST-INFO | started process 9133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxHDDa/profile http://localhost:33751/getInfo.html) 08:30:30 INFO - PROCESS | 9133 | __metrics Screen width/height:1600/1200 08:30:30 INFO - PROCESS | 9133 | colorDepth:24 08:30:30 INFO - PROCESS | 9133 | Browser inner width/height: 1024/697 08:30:30 INFO - PROCESS | 9133 | __metrics 08:30:31 INFO - PROCESS | 9133 | 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" 08:30:31 INFO - PROCESS | 9133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:32 INFO - TEST-INFO | 9133: exit 0 08:30:32 INFO - Browser initialized. 08:30:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:32 INFO - TEST-INFO | started process 9225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxHDDa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:44 INFO - PROCESS | 9225 | RSS: Main: 139796480 08:30:44 INFO - PROCESS | 9225 | 08:33:45 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33751/tests/dromaeo/cssquery-ext.html) 08:33:47 INFO - PROCESS | 9225 | RSS: Main: 266678272 08:33:47 INFO - PROCESS | 9225 | 08:35:33 INFO - PROCESS | 9225 | ************************* 08:35:33 INFO - PROCESS | 9225 | A coding exception was thrown and uncaught in a Task. 08:35:33 INFO - PROCESS | 9225 | 08:35:33 ERROR - PROCESS | 9225 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:35:33 INFO - PROCESS | 9225 | Full stack: 08:35:33 INFO - PROCESS | 9225 | ************************* 08:36:49 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-ext.html (next: http://localhost:33751/tests/dromaeo/cssquery-jquery.html) 08:36:49 INFO - PROCESS | 9225 | RSS: Main: 231653376 08:36:49 INFO - PROCESS | 9225 | 08:39:51 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33751/tests/dromaeo/cssquery-mootools.html) 08:39:52 INFO - PROCESS | 9225 | RSS: Main: 218906624 08:39:52 INFO - PROCESS | 9225 | 08:42:54 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33751/tests/dromaeo/cssquery-prototype.html) 08:42:54 INFO - PROCESS | 9225 | RSS: Main: 170909696 08:42:54 INFO - PROCESS | 9225 | 08:45:57 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33751/tests/dromaeo/cssquery-yui.html) 08:45:58 INFO - PROCESS | 9225 | RSS: Main: 173383680 08:45:58 INFO - PROCESS | 9225 | 08:49:00 INFO - PROCESS | 9225 | Cycle 1(1): loaded http://localhost:33751/tests/dromaeo/cssquery-yui.html (next: http://localhost:33751/tests/dromaeo/cssquery-dojo.html) 08:49:01 INFO - PROCESS | 9225 | RSS: Main: 259952640 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | __start_tp_report 08:49:01 INFO - PROCESS | 9225 | _x_x_mozilla_page_load 08:49:01 INFO - PROCESS | 9225 | _x_x_mozilla_page_load_details 08:49:01 INFO - PROCESS | 9225 | |i|pagename|runs| 08:49:01 INFO - PROCESS | 9225 | |0;dojo.html;3386.1873150443894;3387.441072223082;3420.1962538803377;3425.0752296879828;3430.5883294004725;5705.25831641886;5706.543476521879;5794.333651630064;5794.5943783935145;5824.708764561771;5687.6303040302355;5740.5981581289225;5755.39568345324;5765.682887441189;5771.278590176228;5229.790808367661;5237.13587258102;5243.05624987504;5248.422673505921;5310.495502927216;5181.455947125554;5299.867503312409;5301.7084060376665;5310.123829568117;5345.278387417708;5210.505002024802;5245.239440281157;5276.34045744282;5298.337707786527;5304.36347638282;5366.356037275533;5379.193121031837;5379.865503362408;5385.138377859563;5389.003034438641;5277.86805329866;5283.815066472655;5292.391374991848;5346.866328341784;5347.572194224492;5574.665520068768;5611.2144299798065;5646.181303710939;5682.488576028136;5742.167385729046;6148.415900489446;6170.321264660884;6180.412860778264;6182.505399568024;6189.412005859436;6222.160008398853;6224.751009959597;6228.96885515574;6232.563720539564;6233.657148856811;5617.719114044322;5652.547796176254;5760.481556659837;5792.855178620526;5805.216295800013;6319.9052014218905;6360.713767880364;6363.172787537591;6363.681815909186;6380.234371875405;6059.27288725347;6079.726412311456;6115.235595550556;6121.081837724377;6132.264128304632;5964.7315870785915;6002.039673652282;6232.283287421914;6235.095911092866;6236.594621349598;6095.66473843934;6123.130109042722;6124.513502334683;6125.215553761287;6130.776598292009;5972.85067873298;6011.398860113954;6017.308009578867;6186.041163619556;6202.875942481125;4666.533346665306;4692.671512994058;4701.95298047022;4708.176069187878;4716.905661886812;4218.535961044283;4221.451211342506;4236.978815105905;4252;4263.317869140923;5848.064309710426;5887.1463637772285;5969.432903874125;6009.549283803733;6011.27864656244;6205.379462053758;6243.906341404882;6243.96878015607;6249.593776404519;6251.937480625226;6033.429268317053;6062.636241825505;6063.242094738158;6073.635581865102;6074.3925607438905;5141.922871156936;5157.613179011514;5299.523042926078;5301.973490132602;5323.22813192085;6428.903566446507;6432.06735023419;6545.869082618321;6571.507136964651;6578.210614726264;6136.570440069152;6236.968815155895;6246.9062964054665;6247.406496382836;6249.343818899132;6325.778597749057;6579.342065793382;6590.670466476753;6592.80221593353;6596.637184954873;6006.549508786771;6064.332923378337;6096.207493026056;6156.107364432221;6156.722947467285;6276.246850377984;6279.780207692892;6283.403076707706;6284.120223168668;6284.277308109626;6043.576949613484;6100.23747031621;6100.359462256399;6105.419985101408;6108.450239478469;5839.941600584109;5876.030454975053;5978.581499295007;6024.90962635552;6064.727087280995;6051.697415129138;6055.061465472859;6056.757729690939;6057.030875059969;6084.60450070744;5914.792982245601;5965.761369545169;6039.879202416015;6107.572469927062;6119.541034422347;5887.20522729426;5898.528117750656;5968.552358573038;6001.099835024606;6010.939890601038 08:49:01 INFO - PROCESS | 9225 | |1;ext.html;749.5802350683614;812.3338862133049;828.7596596986874;889.3374436045143;900.5812297281763;30971.845140774294;44012.559874401246;44069.338959915585;48395.75802120985;48554;44729;44797.10405791891;44819.77590112053;44943.55056449435;45086.09827803442;7713.5757533335645;8809.515476648798;8974.326925480615;9058.547072646374;9061.45631262123;7662.885056724153;10581.206409519278;10781.784364312709;11147.498362573662;11148.888511114907;10963.232573719843;10984.231103822736;10985.450727463634;10986.560537578487;10989.890101098967;10875.45622718861;10930.781384372269;10936.671899842939;10946.39794811285;10950.780984380348;10666.786664266749;10694.518746656342;10715.410652414113;10723.46382680863;10728.088112510446;41099.7945010276;41334;41361.58638413608;41411;41412;4099.631033207026;4145.0880806222585;4181.519125300599;4233.555476674936;4267.829286828523;30240.395192096254;30421.087367379016;30580.54129188064;30657.846710766302;31927.84036079828;4153.293940030202;4248.299030659938;4268.807903644343;4297.849575264882;4367.3448982652535;283734;286643;286817;286862;287610;45353.54646453559;45626.77186614046;45627.771861140485;45663.31505027427;45667.77166114148;37012.259754804756;37348.25303493969;37401.62598373982;37482.625173748456;37578.43632345517;15294.158821264715;15340.079595224322;15387.076775393512;15575.454859079879;15578.766318505232;11239.887601124048;11549.076073914066;13546.254955977516;13552.119112257671;13563.59309220725;11753;11820.408979550988;11838.230515016669;12719.682007949876;12975.221486710827;5405.864853378697;5435.728213589305;5479.150731636602;5507.642003269774;5612.07400778875;1008.1178968402647;1022.7392015036119;1022.867027286448;1028.8456731490187;1038.2213339995003;27539.86230068877;27584.172474825788;27726;28124.71875281262;28231.43537129246;1093.436880006797;1094.3488624268548;1109.3399427340719;1116.3246236027248;1117.8155604325357;14681.632959175893;14838;14914.776278355834;14924.477643282433;15134.772978405334;334242;334496;335930;337045;337532;59448.40551594515;59461;59510.10734838981;59779.701101495084;59835.70082149649;1485.7399955007832;1512.311898086368;1540.3838464614244;1551.604340893065;1555.129127688498;25292.241232763048;26620.06829760949;26849.731502685503;27021.324466888484;27201.455970880077;44161.33757993569;44205.77897110494;44294.335584966895;44323.556764431945;44364.33453498135;294640;295447;295463;295847;295903;32743.18142046468;33326.50010249897;33598.66401336053;33603.66396336005;33621.663783362834;44043.55956440394;45032.77483612561;45413;45727.314090289336;46096.235913932396;37913.620863792115;38015.481914490665;38020.80989595034;39000.41499377568;39339.80330098331;37182;37451.625483744814;37948;38659.6134038656;38981;38600.42099368456;38816.22367552577;38958.80520597379;39736;40055.39916901307;31661.8416907914;32838.179045524055;33047.17382065467;33338.66661333453;33553.32893342168;25878.894532656203;25917.6112358311;26160;26206.213813585622;26323.60514592321 08:49:01 INFO - PROCESS | 9225 | |2;jquery.html;408.8834682115598;461.52001918005277;474.4757043466968;480.4882799818196;489.5569509593817;17976.370827021055;19033;20070.2975395861;20869;21036.896310368993;15777.526674199764;20988.05553750081;22188;22275;22905.885470572623;6879.5184337096425;7064.505484616079;7080.53976491529;7099.580083983198;7156.4274858011495;6842.281560436158;7052.471064670144;7055.223925368231;7059.188193357752;7061.89407158893;6830.6584670766515;6973.616451095213;7047.295270472963;7063.117110361205;7072.575645461289;6770.593764374154;6899.689513971884;6967.512274140812;7012.544184628008;7017.982392553051;6779.118714567124;6782.966085169543;6785.084013658142;6787.423069039138;6810.421114205298;26083.73916260832;26829.46341073187;26862;27141.1857644271;27152.72847271522;3569.5002699622073;3615.8891473409853;3628.51015112959;3714.312852122366;3719.497867787868;16428.096454694987;16508.092054936973;16945.237464314134;16945.322187112502;17456.127193640266;2324.5815753164425;2412.8552286862846;2438.9146379876797;2451.2156110044793;2516.4589613233243;95602.6026225203;96715.51642241814;96841.51579242059;98420.50789746077;99087.50456247745;18823.529411764815;18827;18857.90571047136;18935.90532047331;19550.31573894907;34658.653413465545;34844;34862;34875.65124348775;35196.648033519334;9765.609375625038;9949.104580587782;10256.38461692286;10400.47997600117;10422.322549034288;8649.567521623894;8747.256483198873;8791.868121978176;8931.464112153162;8948.373613847098;10226.795464090825;10360.689179324632;10412.344852062826;10518.211134164969;10777.83833242502;3690.261947610435;3794.9241015180096;3888.9027774305305;3902.946204524819;3951.8814435566405;935.9204467620192;968.8934217236099;1002.1331548210891;1012.4836333469983;1021.3454204189261;18953.336633217772;19166.137523811463;19217;19836.50408739793;21012.579748405253;1010.4392062405288;1013.964511242103;1018.6587493189717;1024.4928760263717;1026.4200726589602;10975.615853445252;11268.323900565993;11308.434578271053;11322.320660760215;11346.3759493227;444137;444826;637395;650210;652441;114145;118313.40843295728;118954;119520.4023979892;121626.3918680401;1325.840899092115;1368.6304697731557;1396.2858795603847;1400.9439622415193;1405.508072174751;19059.237630494627;19345.709814352515;19457.416277511697;19494.805051949297;19529.804701953366;42947.57052429561;46536;52827;53106.46893531015;53988.92022159456;65033.67483162743;72005.6399717998;74865.6256718713;75089.62455187908;76171;9310.929243137127;9371.671991480265;12909;13422.865771342553;13582.320883955961;14626.561203163923;14643.12141271527;14655.560333190022;14691.85308146905;14724.631884202981;12198.451069702061;12378.566750164062;12414.255144691348;12441.93779031099;12598.244105353708;11632.53469861196;11862.22895511789;12080.75838483243;12577.182483138567;13094;6747.561408508432;11881.287122772661;12535.623931282076;13277.734445310847;13559.186448812708;12435.253884766942;12620.990320774132;12679.30263835461;12738.617841464771;12821.358932053174;12208.145429820182;12372.566960156351;12470.875291247334;12519.186252893896;12674.366281686063 08:49:01 INFO - PROCESS | 9225 | |3;mootools.html;1559.8206206286281;1587.3888552907126;1598.4565247815744;1613.9919300403496;1625.658611691545;10955.671329860097;11632.883671163307;11662.766744665112;11667.70830729231;11674;11340.092792576595;11473.139514536402;11806.291622502635;12086.21439606425;12139.635810925663;2500.4999000199987;2543.2878793937634;2545.0456078970387;2546.567083595793;2546.8726563671835;2437.683101196842;2457.447074408262;2494.7006359236825;2496.251124662594;2498.712648045471;2453.264020793764;2455.398427385293;2471.666325046123;2492.464120214154;2494.663220465232;2385.844920080198;2401.2076014915124;2405.8797060147012;2411.9276421707377;2453.325335532743;2372.074890792592;2413.2518919135123;2435.6711843901203;2442.9511409771703;2445.9143929962543;11733.237339572901;11814.822777658343;11817.763644727143;11829.526818927232;11831.585894493737;5814.447627475383;5971;5974.97012514939;5980.760769569212;5983.820485385445;3246.2858171202297;3290.555774970372;3314.93370132596;3366.663333666638;3415.504751810998;1315.5592876386422;1332.9533466328633;1347.1916849890085;1383.0526089628636;1399.02068552014;15007.399704011827;15364.692706145926;15783.921080394639;15876.12681302528;16849.494515164442;4532.116237333688;4666.696664716783;4666.69666471685;4686.203345431285;4688.413948256468;11188.776224475465;11476.770464590662;13230.669233269246;13231;13248.602541923758;5800.984827655144;5973.253343332083;6033.9698301508215;6037.72830222641;6042.818715438544;5510.233647894543;5513.09034009384;5557.055300598908;5576.749046292926;5580.246666700024;4104.117614712851;4118.052847845012;4158.771267580312;4168.499780026416;4204.768737719455;1045.696747943088;1058.333250052462;1066.8773091094467;1071.507106730897;1078.3907092492716;931.9720408387759;940.2290122099812;944.820484108031;949.050949050949;973.1047436358567;7072.9646351767915;7187.676554555058;7197.928020719831;7260.6732697028765;7300.525465844703;1050.0811789684026;1101.0695961912172;1113.1595645287919;1115.760111576015;1130.7342774447998;4873.147199240118;4880.292357608127;4943.604511639061;4953.801847926043;5066.873328166826;14646.487372941896;15214.391424342903;15261.771073433907;15263.389464421522;15264.084154950739;13975.231362275172;14377.64055898611;14454.349554270084;14491.20298383578;14499.565013049625;10640.627578034886;10795.46022698862;10843.891561084445;10861.185411094042;10865.674029779118;7115.715371385087;7378.409727221702;7391.630418478947;7501.6249187539315;7506.099268087646;12201.69495762613;12250.264984100626;12334.876651233373;12336.938315308365;12357.93821030889;12432.316222607844;12438.689032773891;12540.122191446511;12574.434150463068;12719;9809.362391444532;10136.493175341351;10141.138003269509;10144.847827282449;10147.898521014695;10990.560377584807;11165.609203677832;11258.155638326994;11262.436878156223;11302.717432063935;9532.189763870148;9600.615975360908;9658.179054780423;9733.951330243304;9822;9510.1440870322;9563.37838040553;9617.086376794194;9852.113309802153;9993.400395975974;8494.575271236537;8514.70198543048;8536;8653;8659.134086591543;5944.64332140073;6082.60463069899;6101.725422355916;6133.509319254538;6193.938060619516;6475.611463312216;6494.383033611799;6505.154329937078;6672.165979252593;6719.260881302955 08:49:01 INFO - PROCESS | 9225 | |4;prototype.html;428.37457312323994;431.874756320667;436.89077730567357;437.5602519467934;439.7251717676452;5133.768980395882;5236.6857988520715;5302.390225124112;5306.452902606747;5325.707086110262;5171.0692075426405;5175.03348727484;5175.922361164586;5178.093833579127;5209.843704688856;4244.363345498169;4364.978175109136;4369.803358848843;4379.321205213197;4390.748636638558;4374.147041326943;4384.7149935254265;4389.912201755963;4409.713368631029;4414.337849322611;4396.164728701552;4407.625351845097;4408.360787685784;4423.4249547558775;4442.3114417265215;4221.430106935571;4372.781360931973;4403.515613282536;4408.435005573039;4461.308497182942;4122.773247471388;4127.484064491939;4141.627253547195;4148.253314403406;4154.50145982481;5022.1211288024815;5081.466446023188;5087.923681144785;5090.796368145269;5096.9490305097215;4998.475160108209;4998.600111991032;5102.668326558762;5127.974360128175;5144.845654630367;5389.978757965763;5405.972970135163;5443.891122177574;5465.316835395575;5508.91736623951;4603.424571928509;4610.654200934943;4617.653675974282;4630.513796051433;4646.326282689025;5376.596755243372;5491.2312276281355;5525.475079867406;5642.294713160855;5721.799737009184;4572.268437050056;4639.652026098056;4653.464851542116;4688.671792974459;4712.43450785901;4721.386219791474;4738;4751;4756.7859446325;4778.37881075458;4789.856304310876;4990.226514890198;5037.4458809530925;5058.898822023539;5098.719570423588;5407.945920540823;5428.185772134132;5433;5443.455654434525;5476.370217424967;1631.3230009545905;1636.860866826333;1648.9422870199485;1651.2404294024643;1652.702513547573;1241.485177012373;1279.2580303423993;1293.353323338331;1294.50484690183;1299.9545015924398;5175.550845763192;5449.836504904859;5450.72956226269;5461.15352120414;5465.508104270635;5486.478784515464;5490.56075513958;5560.833175004756;5569.582281328835;5583;5354.4645535446925;5369.328833895763;5374.946250537523;5402.783888644411;5449.427810079885;2832.909329907959;2935.4295451933112;2942.9111228845463;2966.7539633354045;2996.2659148508756;5919.970400147971;5926.881462370815;5931.614445061057;5937.910931336033;5963.135345374896;5755.712214389264;5779;5793.971030144822;5810;5827.475527202572;5656.2929633795775;5851.912221316684;5899.7050147492455;5903.498202652822;5968.46283834457;5661.745221465127;5681.874968767079;5695.917775622618;5696.857578560569;5744.856378590402;5447.9025575153055;5536.972315138399;5584.357798853184;5614.659277729745;5665.801696940587;5561.944380556142;5669.3480249770155;5794.275715535558;5884.529237661062;5902.2327097477055;4668.323093151542;4670.136024835417;4691.437027556579;4698.154332220233;4733.1716949533;5415.945840541702;5545.838871843011;5607.812952948435;5629.437056294338;5651.208830763779;5443.673379597237;5447.618666693294;5466.899825131151;5472.753726082416;5478.698671572943;5439.972800135974;5467.890642187054;5475.945240547543;5477.4796394342475;5487.560995120461;5280.419153893145;5440.4365140832815;5466.988607107698;5469.562435005269;5484.945150548603;5353.812616558402;5434.184872269191;5499.945000549943;5500.779968801203;5506.155437928179;5338.345113014978;5353.277307563585;5425.430329815313;5446.910617876361;5469.42571030052 08:49:01 INFO - PROCESS | 9225 | |5;yui.html;748.6705849426252;786.2059320086711;849.46908182386;881.2289246908955;893.6514759243894;16327.183640817957;17047.914760426196;17052.403165889165;17101.31594736209;18049.63900721985;17959.461216163538;18443.90778046111;18525.814741852577;18548.629027419443;18657.813421865776;856.4732689396008;865.4720620421538;884.2528063786091;887.0552861202831;911.9922485653357;895.5164211325877;897.7935074932769;898.874157617934;899.0784445942895;899.8110396816644;946.049220533363;949.5062567464914;949.7008442340675;950.3347656640345;950.686273529737;942.6747772018642;944.3531181140906;944.919681827042;944.9385789923667;946.1531928923644;693.3517161454057;693.5907814389534;693.930606939307;694.1808665774385;694.6144889586277;17605.383811566662;17628.383006594835;17801;18712.90643546787;18889.905550472296;14987.250637468083;15125.773113403307;15138.545843624708;15260.160691161982;15613.765793513106;13414.731705365837;13862.4455021799;14053.718925621533;14108.576742697736;14286.142831430148;3962.405639154121;3992.5208974922903;4026.4765580474646;4094.651954583864;4132.896677583054;86640.56679716625;87130.56434717849;88766;91626.5418672909;91643.08356916413;11953.22304050234;12146.75706485883;12153.756924861453;12156.817647735292;12167.574134905413;23992.880035599712;24013.7598624015;24044.639330410057;24145.15491957773;24317.878410607835;8768.956155219183;8888.3333749969;8922.73231803047;8965.910340896638;9040.321975851837;5021.949780502148;5022.673526220784;5080.466551012164;5083.364579427572;5162.432132465426;3841.635044670808;3933.331333673282;3938.6258305460933;3938.9606103938595;3954.584768599313;619.0435776724971;629.3266205160435;630.9936900630935;632.7279269913981;634.6731433311849;801.3428988229596;827.954462504556;847.3221422861686;852.7538700763631;859.6045818923241;11319.660410187707;11541.884581154249;11659.300441973508;11740.765184696258;12025.398730063462;846.5894041389921;854.9444286121383;855.2431098477892;865.2429124516049;865.3942240431597;5587.860303492445;5652.378238393773;5696.658200507983;5723.399043100498;5726.799562015392;66824;71146.64426677834;78778;81975;82629.58685206536;52928.47071529235;55114.448855511735;55651.443485564625;61147.38852611506;66282.33717662859;61730.382696173365;62349.37650623526;62417.37582624116;62690.37309626846;63798.68100659467;11008.284461509977;11299.943500282447;11392.373419461677;11696.739395689856;11894.940525297317;40510.59489405068;41142.382864257655;41967.790161049;42145.578544215394;42709.57290427056;47462.76268618635;47489.28766068443;47902.28146577734;48165.518344816104;49424.752876236824;13507.189568625914;13654.180749155083;13656.180629162282;13949.930250348683;14092.718145637235;14177.716445670823;14547;14662.413503459742;14740.926295368454;15154.924225379244;14949.925250373679;14999;15226.162561059247;15332.77000844966;15401.69196616039;15008.324625392102;15171.544853654408;15273.694526109193;15874.841251587337;16031.679366412372;13710.520131795738;13937.442502299795;13982.370793314529;14001.579952601438;14067.155970641385;11469.942650286695;11754.471048802996;11812.409379530816;12194.329311887932;12198.207116537396;11547.364894930859;11631.941840290745;11796.88203117992;11842.230255033395;11906.642800715992 08:49:01 INFO - PROCESS | 9225 | __end_tp_report 08:49:01 INFO - PROCESS | 9225 | __start_cc_report 08:49:01 INFO - PROCESS | 9225 | _x_x_mozilla_cycle_collect,1202 08:49:01 INFO - PROCESS | 9225 | __end_cc_report 08:49:01 INFO - PROCESS | 9225 | __startTimestamp1490370541041__endTimestamp 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | ------- Summary: start ------- 08:49:01 INFO - PROCESS | 9225 | Number of tests: 6 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#0] dojo.html Cycles:165 Average:5762.29 Median:6010.94 stddev:656.06 (10.9%) stddev-sans-first:631.03 08:49:01 INFO - PROCESS | 9225 | Values: 3386.2 3387.4 3420.2 3425.1 3430.6 5705.3 5706.5 5794.3 5794.6 5824.7 5687.6 5740.6 5755.4 5765.7 5771.3 5229.8 5237.1 5243.1 5248.4 5310.5 5181.5 5299.9 5301.7 5310.1 5345.3 5210.5 5245.2 5276.3 5298.3 5304.4 5366.4 5379.2 5379.9 5385.1 5389.0 5277.9 5283.8 5292.4 5346.9 5347.6 5574.7 5611.2 5646.2 5682.5 5742.2 6148.4 6170.3 6180.4 6182.5 6189.4 6222.2 6224.8 6229.0 6232.6 6233.7 5617.7 5652.5 5760.5 5792.9 5805.2 6319.9 6360.7 6363.2 6363.7 6380.2 6059.3 6079.7 6115.2 6121.1 6132.3 5964.7 6002.0 6232.3 6235.1 6236.6 6095.7 6123.1 6124.5 6125.2 6130.8 5972.9 6011.4 6017.3 6186.0 6202.9 4666.5 4692.7 4702.0 4708.2 4716.9 4218.5 4221.5 4237.0 4252.0 4263.3 5848.1 5887.1 5969.4 6009.5 6011.3 6205.4 6243.9 6244.0 6249.6 6251.9 6033.4 6062.6 6063.2 6073.6 6074.4 5141.9 5157.6 5299.5 5302.0 5323.2 6428.9 6432.1 6545.9 6571.5 6578.2 6136.6 6237.0 6246.9 6247.4 6249.3 6325.8 6579.3 6590.7 6592.8 6596.6 6006.5 6064.3 6096.2 6156.1 6156.7 6276.2 6279.8 6283.4 6284.1 6284.3 6043.6 6100.2 6100.4 6105.4 6108.5 5839.9 5876.0 5978.6 6024.9 6064.7 6051.7 6055.1 6056.8 6057.0 6084.6 5914.8 5965.8 6039.9 6107.6 6119.5 5887.2 5898.5 5968.6 6001.1 6010.9 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#1] ext.html Cycles:180 Average:47158.95 Median:183790.33 stddev:80125.57 (43.6%) stddev-sans-first:80274.57 08:49:01 INFO - PROCESS | 9225 | Values: 749.6 812.3 828.8 889.3 900.6 30971.8 44012.6 44069.3 48395.8 48554.0 44729.0 44797.1 44819.8 44943.6 45086.1 7713.6 8809.5 8974.3 9058.5 9061.5 7662.9 10581.2 10781.8 11147.5 11148.9 10963.2 10984.2 10985.5 10986.6 10989.9 10875.5 10930.8 10936.7 10946.4 10950.8 10666.8 10694.5 10715.4 10723.5 10728.1 41099.8 41334.0 41361.6 41411.0 41412.0 4099.6 4145.1 4181.5 4233.6 4267.8 30240.4 30421.1 30580.5 30657.8 31927.8 4153.3 4248.3 4268.8 4297.8 4367.3 283734.0 286643.0 286817.0 286862.0 287610.0 45353.5 45626.8 45627.8 45663.3 45667.8 37012.3 37348.3 37401.6 37482.6 37578.4 15294.2 15340.1 15387.1 15575.5 15578.8 11239.9 11549.1 13546.3 13552.1 13563.6 11753.0 11820.4 11838.2 12719.7 12975.2 5405.9 5435.7 5479.2 5507.6 5612.1 1008.1 1022.7 1022.9 1028.8 1038.2 27539.9 27584.2 27726.0 28124.7 28231.4 1093.4 1094.3 1109.3 1116.3 1117.8 14681.6 14838.0 14914.8 14924.5 15134.8 334242.0 334496.0 335930.0 337045.0 337532.0 59448.4 59461.0 59510.1 59779.7 59835.7 1485.7 1512.3 1540.4 1551.6 1555.1 25292.2 26620.1 26849.7 27021.3 27201.5 44161.3 44205.8 44294.3 44323.6 44364.3 294640.0 295447.0 295463.0 295847.0 295903.0 32743.2 33326.5 33598.7 33603.7 33621.7 44043.6 45032.8 45413.0 45727.3 46096.2 37913.6 38015.5 38020.8 39000.4 39339.8 37182.0 37451.6 37948.0 38659.6 38981.0 38600.4 38816.2 38958.8 39736.0 40055.4 31661.8 32838.2 33047.2 33338.7 33553.3 25878.9 25917.6 26160.0 26206.2 26323.6 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#2] jquery.html Cycles:180 Average:34954.12 Median:22231.50 stddev:95030.50 (427.5%) stddev-sans-first:95261.68 08:49:01 INFO - PROCESS | 9225 | Values: 408.9 461.5 474.5 480.5 489.6 17976.4 19033.0 20070.3 20869.0 21036.9 15777.5 20988.1 22188.0 22275.0 22905.9 6879.5 7064.5 7080.5 7099.6 7156.4 6842.3 7052.5 7055.2 7059.2 7061.9 6830.7 6973.6 7047.3 7063.1 7072.6 6770.6 6899.7 6967.5 7012.5 7018.0 6779.1 6783.0 6785.1 6787.4 6810.4 26083.7 26829.5 26862.0 27141.2 27152.7 3569.5 3615.9 3628.5 3714.3 3719.5 16428.1 16508.1 16945.2 16945.3 17456.1 2324.6 2412.9 2438.9 2451.2 2516.5 95602.6 96715.5 96841.5 98420.5 99087.5 18823.5 18827.0 18857.9 18935.9 19550.3 34658.7 34844.0 34862.0 34875.7 35196.6 9765.6 9949.1 10256.4 10400.5 10422.3 8649.6 8747.3 8791.9 8931.5 8948.4 10226.8 10360.7 10412.3 10518.2 10777.8 3690.3 3794.9 3888.9 3902.9 3951.9 935.9 968.9 1002.1 1012.5 1021.3 18953.3 19166.1 19217.0 19836.5 21012.6 1010.4 1014.0 1018.7 1024.5 1026.4 10975.6 11268.3 11308.4 11322.3 11346.4 444137.0 444826.0 637395.0 650210.0 652441.0 114145.0 118313.4 118954.0 119520.4 121626.4 1325.8 1368.6 1396.3 1400.9 1405.5 19059.2 19345.7 19457.4 19494.8 19529.8 42947.6 46536.0 52827.0 53106.5 53988.9 65033.7 72005.6 74865.6 75089.6 76171.0 9310.9 9371.7 12909.0 13422.9 13582.3 14626.6 14643.1 14655.6 14691.9 14724.6 12198.5 12378.6 12414.3 12441.9 12598.2 11632.5 11862.2 12080.8 12577.2 13094.0 6747.6 11881.3 12535.6 13277.7 13559.2 12435.3 12621.0 12679.3 12738.6 12821.4 12208.1 12372.6 12470.9 12519.2 12674.4 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#3] mootools.html Cycles:180 Average:7162.96 Median:2454.36 stddev:4481.14 (182.6%) stddev-sans-first:4473.93 08:49:01 INFO - PROCESS | 9225 | Values: 1559.8 1587.4 1598.5 1614.0 1625.7 10955.7 11632.9 11662.8 11667.7 11674.0 11340.1 11473.1 11806.3 12086.2 12139.6 2500.5 2543.3 2545.0 2546.6 2546.9 2437.7 2457.4 2494.7 2496.3 2498.7 2453.3 2455.4 2471.7 2492.5 2494.7 2385.8 2401.2 2405.9 2411.9 2453.3 2372.1 2413.3 2435.7 2443.0 2445.9 11733.2 11814.8 11817.8 11829.5 11831.6 5814.4 5971.0 5975.0 5980.8 5983.8 3246.3 3290.6 3314.9 3366.7 3415.5 1315.6 1333.0 1347.2 1383.1 1399.0 15007.4 15364.7 15783.9 15876.1 16849.5 4532.1 4666.7 4666.7 4686.2 4688.4 11188.8 11476.8 13230.7 13231.0 13248.6 5801.0 5973.3 6034.0 6037.7 6042.8 5510.2 5513.1 5557.1 5576.7 5580.2 4104.1 4118.1 4158.8 4168.5 4204.8 1045.7 1058.3 1066.9 1071.5 1078.4 932.0 940.2 944.8 949.1 973.1 7073.0 7187.7 7197.9 7260.7 7300.5 1050.1 1101.1 1113.2 1115.8 1130.7 4873.1 4880.3 4943.6 4953.8 5066.9 14646.5 15214.4 15261.8 15263.4 15264.1 13975.2 14377.6 14454.3 14491.2 14499.6 10640.6 10795.5 10843.9 10861.2 10865.7 7115.7 7378.4 7391.6 7501.6 7506.1 12201.7 12250.3 12334.9 12336.9 12357.9 12432.3 12438.7 12540.1 12574.4 12719.0 9809.4 10136.5 10141.1 10144.8 10147.9 10990.6 11165.6 11258.2 11262.4 11302.7 9532.2 9600.6 9658.2 9734.0 9822.0 9510.1 9563.4 9617.1 9852.1 9993.4 8494.6 8514.7 8536.0 8653.0 8659.1 5944.6 6082.6 6101.7 6133.5 6193.9 6475.6 6494.4 6505.2 6672.2 6719.3 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#4] prototype.html Cycles:180 Average:4790.09 Median:5316.08 stddev:1270.33 (23.9%) stddev-sans-first:1230.98 08:49:01 INFO - PROCESS | 9225 | Values: 428.4 431.9 436.9 437.6 439.7 5133.8 5236.7 5302.4 5306.5 5325.7 5171.1 5175.0 5175.9 5178.1 5209.8 4244.4 4365.0 4369.8 4379.3 4390.7 4374.1 4384.7 4389.9 4409.7 4414.3 4396.2 4407.6 4408.4 4423.4 4442.3 4221.4 4372.8 4403.5 4408.4 4461.3 4122.8 4127.5 4141.6 4148.3 4154.5 5022.1 5081.5 5087.9 5090.8 5096.9 4998.5 4998.6 5102.7 5128.0 5144.8 5390.0 5406.0 5443.9 5465.3 5508.9 4603.4 4610.7 4617.7 4630.5 4646.3 5376.6 5491.2 5525.5 5642.3 5721.8 4572.3 4639.7 4653.5 4688.7 4712.4 4721.4 4738.0 4751.0 4756.8 4778.4 4789.9 4990.2 5037.4 5058.9 5098.7 5407.9 5428.2 5433.0 5443.5 5476.4 1631.3 1636.9 1648.9 1651.2 1652.7 1241.5 1279.3 1293.4 1294.5 1300.0 5175.6 5449.8 5450.7 5461.2 5465.5 5486.5 5490.6 5560.8 5569.6 5583.0 5354.5 5369.3 5374.9 5402.8 5449.4 2832.9 2935.4 2942.9 2966.8 2996.3 5920.0 5926.9 5931.6 5937.9 5963.1 5755.7 5779.0 5794.0 5810.0 5827.5 5656.3 5851.9 5899.7 5903.5 5968.5 5661.7 5681.9 5695.9 5696.9 5744.9 5447.9 5537.0 5584.4 5614.7 5665.8 5561.9 5669.3 5794.3 5884.5 5902.2 4668.3 4670.1 4691.4 4698.2 4733.2 5415.9 5545.8 5607.8 5629.4 5651.2 5443.7 5447.6 5466.9 5472.8 5478.7 5440.0 5467.9 5475.9 5477.5 5487.6 5280.4 5440.4 5467.0 5469.6 5484.9 5353.8 5434.2 5499.9 5500.8 5506.2 5338.3 5353.3 5425.4 5446.9 5469.4 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - PROCESS | 9225 | [#5] yui.html Cycles:180 Average:18056.16 Median:22637.64 stddev:22024.33 (97.3%) stddev-sans-first:22047.77 08:49:01 INFO - PROCESS | 9225 | Values: 748.7 786.2 849.5 881.2 893.7 16327.2 17047.9 17052.4 17101.3 18049.6 17959.5 18443.9 18525.8 18548.6 18657.8 856.5 865.5 884.3 887.1 912.0 895.5 897.8 898.9 899.1 899.8 946.0 949.5 949.7 950.3 950.7 942.7 944.4 944.9 944.9 946.2 693.4 693.6 693.9 694.2 694.6 17605.4 17628.4 17801.0 18712.9 18889.9 14987.3 15125.8 15138.5 15260.2 15613.8 13414.7 13862.4 14053.7 14108.6 14286.1 3962.4 3992.5 4026.5 4094.7 4132.9 86640.6 87130.6 88766.0 91626.5 91643.1 11953.2 12146.8 12153.8 12156.8 12167.6 23992.9 24013.8 24044.6 24145.2 24317.9 8769.0 8888.3 8922.7 8965.9 9040.3 5021.9 5022.7 5080.5 5083.4 5162.4 3841.6 3933.3 3938.6 3939.0 3954.6 619.0 629.3 631.0 632.7 634.7 801.3 828.0 847.3 852.8 859.6 11319.7 11541.9 11659.3 11740.8 12025.4 846.6 854.9 855.2 865.2 865.4 5587.9 5652.4 5696.7 5723.4 5726.8 66824.0 71146.6 78778.0 81975.0 82629.6 52928.5 55114.4 55651.4 61147.4 66282.3 61730.4 62349.4 62417.4 62690.4 63798.7 11008.3 11299.9 11392.4 11696.7 11894.9 40510.6 41142.4 41967.8 42145.6 42709.6 47462.8 47489.3 47902.3 48165.5 49424.8 13507.2 13654.2 13656.2 13949.9 14092.7 14177.7 14547.0 14662.4 14740.9 15154.9 14949.9 14999.0 15226.2 15332.8 15401.7 15008.3 15171.5 15273.7 15874.8 16031.7 13710.5 13937.4 13982.4 14001.6 14067.2 11469.9 11754.5 11812.4 12194.3 12198.2 11547.4 11631.9 11796.9 11842.2 11906.6 08:49:01 INFO - PROCESS | 9225 | -------- Summary: end -------- 08:49:01 INFO - PROCESS | 9225 | 08:49:01 INFO - TEST-INFO | 9225: exit 0 08:49:01 INFO - TEST-OK | dromaeo_css | took 1115667ms 08:49:01 INFO - TEST-START | kraken 08:49:01 INFO - operating with platform_type : linux_ 08:49:01 INFO - Initialising browser for kraken test... 08:49:01 INFO - TEST-INFO | started process 9544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89Je1u/profile http://localhost:33751/getInfo.html) 08:49:06 INFO - PROCESS | 9544 | __metrics Screen width/height:1600/1200 08:49:06 INFO - PROCESS | 9544 | colorDepth:24 08:49:06 INFO - PROCESS | 9544 | Browser inner width/height: 1024/697 08:49:06 INFO - PROCESS | 9544 | __metrics 08:49:06 INFO - PROCESS | 9544 | 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" 08:49:06 INFO - PROCESS | 9544 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:08 INFO - TEST-INFO | 9544: exit 0 08:49:08 INFO - Browser initialized. 08:49:08 INFO - Running cycle 1/1 for kraken test... 08:49:08 INFO - TEST-INFO | started process 9634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89Je1u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:19 INFO - PROCESS | 9634 | RSS: Main: 139399168 08:49:19 INFO - PROCESS | 9634 | 08:49:22 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33751/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:23 INFO - PROCESS | 9634 | RSS: Main: 182923264 08:49:23 INFO - PROCESS | 9634 | 08:49:25 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33751/tests/kraken/driver.html?testName=audio-dft) 08:49:26 INFO - PROCESS | 9634 | RSS: Main: 173838336 08:49:26 INFO - PROCESS | 9634 | 08:49:29 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33751/tests/kraken/driver.html?testName=audio-fft) 08:49:29 INFO - PROCESS | 9634 | RSS: Main: 265478144 08:49:29 INFO - PROCESS | 9634 | 08:49:31 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33751/tests/kraken/driver.html?testName=audio-oscillator) 08:49:32 INFO - PROCESS | 9634 | RSS: Main: 172457984 08:49:32 INFO - PROCESS | 9634 | 08:49:34 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:35 INFO - PROCESS | 9634 | RSS: Main: 174616576 08:49:35 INFO - PROCESS | 9634 | 08:49:37 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33751/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:38 INFO - PROCESS | 9634 | RSS: Main: 213377024 08:49:38 INFO - PROCESS | 9634 | 08:49:41 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33751/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:42 INFO - PROCESS | 9634 | RSS: Main: 213028864 08:49:42 INFO - PROCESS | 9634 | 08:49:45 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33751/tests/kraken/driver.html?testName=json-parse-financial) 08:49:45 INFO - PROCESS | 9634 | RSS: Main: 210178048 08:49:45 INFO - PROCESS | 9634 | 08:49:47 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:47 INFO - PROCESS | 9634 | RSS: Main: 172978176 08:49:47 INFO - PROCESS | 9634 | 08:49:49 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:50 INFO - PROCESS | 9634 | RSS: Main: 179568640 08:49:50 INFO - PROCESS | 9634 | 08:49:52 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:52 INFO - PROCESS | 9634 | RSS: Main: 189116416 08:49:52 INFO - PROCESS | 9634 | 08:49:55 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:56 INFO - PROCESS | 9634 | RSS: Main: 197730304 08:49:56 INFO - PROCESS | 9634 | 08:49:58 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:59 INFO - PROCESS | 9634 | RSS: Main: 194887680 08:49:59 INFO - PROCESS | 9634 | 08:50:00 INFO - PROCESS | 9634 | Cycle 1(1): loaded http://localhost:33751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33751/tests/kraken/driver.html?testName=ai-astar) 08:50:01 INFO - PROCESS | 9634 | RSS: Main: 246112256 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | __start_tp_report 08:50:01 INFO - PROCESS | 9634 | _x_x_mozilla_page_load 08:50:01 INFO - PROCESS | 9634 | _x_x_mozilla_page_load_details 08:50:01 INFO - PROCESS | 9634 | |i|pagename|runs| 08:50:01 INFO - PROCESS | 9634 | |0;ai-astar;102;113;111;112;112;112;112;112;111;111 08:50:01 INFO - PROCESS | 9634 | |1;audio-beat-detection;145;113;115;159;115;116;115;114;141;115 08:50:01 INFO - PROCESS | 9634 | |2;audio-dft;160;162;161;160;162;163;163;162;161;161 08:50:01 INFO - PROCESS | 9634 | |3;audio-fft;74;75;76;115;74;75;78;75;90;76 08:50:01 INFO - PROCESS | 9634 | |4;audio-oscillator;82;81;111;81;82;81;94;81;82;113 08:50:01 INFO - PROCESS | 9634 | |5;imaging-gaussian-blur;113;113;113;114;112;113;113;113;112;113 08:50:01 INFO - PROCESS | 9634 | |6;imaging-darkroom;146;148;147;146;146;147;146;146;146;146 08:50:01 INFO - PROCESS | 9634 | |7;imaging-desaturate;94;93;93;94;93;94;94;95;95;94 08:50:01 INFO - PROCESS | 9634 | |8;json-parse-financial;54;56;54;54;54;54;55;54;55;55 08:50:01 INFO - PROCESS | 9634 | |9;json-stringify-tinderbox;52;53;53;53;53;52;53;53;52;53 08:50:01 INFO - PROCESS | 9634 | |10;stanford-crypto-aes;79;76;80;77;76;76;77;83;79;78 08:50:01 INFO - PROCESS | 9634 | |11;stanford-crypto-ccm;124;119;128;129;123;119;122;120;158;120 08:50:01 INFO - PROCESS | 9634 | |12;stanford-crypto-pbkdf2;164;158;160;159;156;158;157;158;157;157 08:50:01 INFO - PROCESS | 9634 | |13;stanford-crypto-sha256-iterative;61;61;67;59;61;60;65;59;59;58 08:50:01 INFO - PROCESS | 9634 | __end_tp_report 08:50:01 INFO - PROCESS | 9634 | __start_cc_report 08:50:01 INFO - PROCESS | 9634 | _x_x_mozilla_cycle_collect,1663 08:50:01 INFO - PROCESS | 9634 | __end_cc_report 08:50:01 INFO - PROCESS | 9634 | __startTimestamp1490370601162__endTimestamp 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | ------- Summary: start ------- 08:50:01 INFO - PROCESS | 9634 | Number of tests: 14 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.16 (2.8%) stddev-sans-first:0.67 08:50:01 INFO - PROCESS | 9634 | Values: 102.0 113.0 111.0 112.0 112.0 112.0 112.0 112.0 111.0 111.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:115.50 stddev:16.86 (14.6%) stddev-sans-first:16.22 08:50:01 INFO - PROCESS | 9634 | Values: 145.0 113.0 115.0 159.0 115.0 116.0 115.0 114.0 141.0 115.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 08:50:01 INFO - PROCESS | 9634 | Values: 160.0 162.0 161.0 160.0 162.0 163.0 163.0 162.0 161.0 161.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.92 (17.1%) stddev-sans-first:13.46 08:50:01 INFO - PROCESS | 9634 | Values: 74.0 75.0 76.0 115.0 74.0 75.0 78.0 75.0 90.0 76.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:81.50 stddev:12.86 (15.8%) stddev-sans-first:13.40 08:50:01 INFO - PROCESS | 9634 | Values: 82.0 81.0 111.0 81.0 82.0 81.0 94.0 81.0 82.0 113.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:50:01 INFO - PROCESS | 9634 | Values: 113.0 113.0 113.0 114.0 112.0 113.0 113.0 113.0 112.0 113.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:50:01 INFO - PROCESS | 9634 | Values: 146.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 08:50:01 INFO - PROCESS | 9634 | Values: 94.0 93.0 93.0 94.0 93.0 94.0 94.0 95.0 95.0 94.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 08:50:01 INFO - PROCESS | 9634 | Values: 54.0 56.0 54.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 08:50:01 INFO - PROCESS | 9634 | Values: 52.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 52.0 53.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:2.23 (2.8%) stddev-sans-first:2.35 08:50:01 INFO - PROCESS | 9634 | Values: 79.0 76.0 80.0 77.0 76.0 76.0 77.0 83.0 79.0 78.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:123.50 stddev:11.72 (9.5%) stddev-sans-first:12.40 08:50:01 INFO - PROCESS | 9634 | Values: 124.0 119.0 128.0 129.0 123.0 119.0 122.0 120.0 158.0 120.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.00 stddev:2.27 (1.4%) stddev-sans-first:1.20 08:50:01 INFO - PROCESS | 9634 | Values: 164.0 158.0 160.0 159.0 156.0 158.0 157.0 158.0 157.0 157.0 08:50:01 INFO - PROCESS | 9634 | 08:50:01 INFO - PROCESS | 9634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:2.87 (4.7%) stddev-sans-first:3.04 08:50:01 INFO - PROCESS | 9634 | Values: 61.0 61.0 67.0 59.0 61.0 60.0 65.0 59.0 59.0 58.0 08:50:01 INFO - PROCESS | 9634 | -------- Summary: end -------- 08:50:01 INFO - PROCESS | 9634 | 08:50:02 INFO - TEST-INFO | 9634: exit 0 08:50:02 INFO - TEST-OK | kraken | took 60308ms 08:50:02 INFO - SUITE-END | took 1175s 08:50:02 INFO - Completed test suite (00:19:36) 08:50:02 INFO - javascript benchmark 08:50:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7869.516077923503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3386.1873150443894, 3387.441072223082, 3420.1962538803377, 3425.0752296879828, 3430.5883294004725, 5705.25831641886, 5706.543476521879, 5794.333651630064, 5794.5943783935145, 5824.708764561771, 5687.6303040302355, 5740.5981581289225, 5755.39568345324, 5765.682887441189, 5771.278590176228, 5229.790808367661, 5237.13587258102, 5243.05624987504, 5248.422673505921, 5310.495502927216, 5181.455947125554, 5299.867503312409, 5301.7084060376665, 5310.123829568117, 5345.278387417708, 5210.505002024802, 5245.239440281157, 5276.34045744282, 5298.337707786527, 5304.36347638282, 5366.356037275533, 5379.193121031837, 5379.865503362408, 5385.138377859563, 5389.003034438641, 5277.86805329866, 5283.815066472655, 5292.391374991848, 5346.866328341784, 5347.572194224492, 5574.665520068768, 5611.2144299798065, 5646.181303710939, 5682.488576028136, 5742.167385729046, 6148.415900489446, 6170.321264660884, 6180.412860778264, 6182.505399568024, 6189.412005859436, 6222.160008398853, 6224.751009959597, 6228.96885515574, 6232.563720539564, 6233.657148856811, 5617.719114044322, 5652.547796176254, 5760.481556659837, 5792.855178620526, 5805.216295800013, 6319.9052014218905, 6360.713767880364, 6363.172787537591, 6363.681815909186, 6380.234371875405, 6059.27288725347, 6079.726412311456, 6115.235595550556, 6121.081837724377, 6132.264128304632, 5964.7315870785915, 6002.039673652282, 6232.283287421914, 6235.095911092866, 6236.594621349598, 6095.66473843934, 6123.130109042722, 6124.513502334683, 6125.215553761287, 6130.776598292009, 5972.85067873298, 6011.398860113954, 6017.308009578867, 6186.041163619556, 6202.875942481125, 4666.533346665306, 4692.671512994058, 4701.95298047022, 4708.176069187878, 4716.905661886812, 4218.535961044283, 4221.451211342506, 4236.978815105905, 4252.0, 4263.317869140923, 5848.064309710426, 5887.1463637772285, 5969.432903874125, 6009.549283803733, 6011.27864656244, 6205.379462053758, 6243.906341404882, 6243.96878015607, 6249.593776404519, 6251.937480625226, 6033.429268317053, 6062.636241825505, 6063.242094738158, 6073.635581865102, 6074.3925607438905, 5141.922871156936, 5157.613179011514, 5299.523042926078, 5301.973490132602, 5323.22813192085, 6428.903566446507, 6432.06735023419, 6545.869082618321, 6571.507136964651, 6578.210614726264, 6136.570440069152, 6236.968815155895, 6246.9062964054665, 6247.406496382836, 6249.343818899132, 6325.778597749057, 6579.342065793382, 6590.670466476753, 6592.80221593353, 6596.637184954873, 6006.549508786771, 6064.332923378337, 6096.207493026056, 6156.107364432221, 6156.722947467285, 6276.246850377984, 6279.780207692892, 6283.403076707706, 6284.120223168668, 6284.277308109626, 6043.576949613484, 6100.23747031621, 6100.359462256399, 6105.419985101408, 6108.450239478469, 5839.941600584109, 5876.030454975053, 5978.581499295007, 6024.90962635552, 6064.727087280995, 6051.697415129138, 6055.061465472859, 6056.757729690939, 6057.030875059969, 6084.60450070744, 5914.792982245601, 5965.761369545169, 6039.879202416015, 6107.572469927062, 6119.541034422347, 5887.20522729426, 5898.528117750656, 5968.552358573038, 6001.099835024606, 6010.939890601038], "value": 5718.387555297262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5802350683614, 812.3338862133049, 828.7596596986874, 889.3374436045143, 900.5812297281763, 30971.845140774294, 44012.559874401246, 44069.338959915585, 48395.75802120985, 48554.0, 44729.0, 44797.10405791891, 44819.77590112053, 44943.55056449435, 45086.09827803442, 7713.5757533335645, 8809.515476648798, 8974.326925480615, 9058.547072646374, 9061.45631262123, 7662.885056724153, 10581.206409519278, 10781.784364312709, 11147.498362573662, 11148.888511114907, 10963.232573719843, 10984.231103822736, 10985.450727463634, 10986.560537578487, 10989.890101098967, 10875.45622718861, 10930.781384372269, 10936.671899842939, 10946.39794811285, 10950.780984380348, 10666.786664266749, 10694.518746656342, 10715.410652414113, 10723.46382680863, 10728.088112510446, 41099.7945010276, 41334.0, 41361.58638413608, 41411.0, 41412.0, 4099.631033207026, 4145.0880806222585, 4181.519125300599, 4233.555476674936, 4267.829286828523, 30240.395192096254, 30421.087367379016, 30580.54129188064, 30657.846710766302, 31927.84036079828, 4153.293940030202, 4248.299030659938, 4268.807903644343, 4297.849575264882, 4367.3448982652535, 283734.0, 286643.0, 286817.0, 286862.0, 287610.0, 45353.54646453559, 45626.77186614046, 45627.771861140485, 45663.31505027427, 45667.77166114148, 37012.259754804756, 37348.25303493969, 37401.62598373982, 37482.625173748456, 37578.43632345517, 15294.158821264715, 15340.079595224322, 15387.076775393512, 15575.454859079879, 15578.766318505232, 11239.887601124048, 11549.076073914066, 13546.254955977516, 13552.119112257671, 13563.59309220725, 11753.0, 11820.408979550988, 11838.230515016669, 12719.682007949876, 12975.221486710827, 5405.864853378697, 5435.728213589305, 5479.150731636602, 5507.642003269774, 5612.07400778875, 1008.1178968402647, 1022.7392015036119, 1022.867027286448, 1028.8456731490187, 1038.2213339995003, 27539.86230068877, 27584.172474825788, 27726.0, 28124.71875281262, 28231.43537129246, 1093.436880006797, 1094.3488624268548, 1109.3399427340719, 1116.3246236027248, 1117.8155604325357, 14681.632959175893, 14838.0, 14914.776278355834, 14924.477643282433, 15134.772978405334, 334242.0, 334496.0, 335930.0, 337045.0, 337532.0, 59448.40551594515, 59461.0, 59510.10734838981, 59779.701101495084, 59835.70082149649, 1485.7399955007832, 1512.311898086368, 1540.3838464614244, 1551.604340893065, 1555.129127688498, 25292.241232763048, 26620.06829760949, 26849.731502685503, 27021.324466888484, 27201.455970880077, 44161.33757993569, 44205.77897110494, 44294.335584966895, 44323.556764431945, 44364.33453498135, 294640.0, 295447.0, 295463.0, 295847.0, 295903.0, 32743.18142046468, 33326.50010249897, 33598.66401336053, 33603.66396336005, 33621.663783362834, 44043.55956440394, 45032.77483612561, 45413.0, 45727.314090289336, 46096.235913932396, 37913.620863792115, 38015.481914490665, 38020.80989595034, 39000.41499377568, 39339.80330098331, 37182.0, 37451.625483744814, 37948.0, 38659.6134038656, 38981.0, 38600.42099368456, 38816.22367552577, 38958.80520597379, 39736.0, 40055.39916901307, 31661.8416907914, 32838.179045524055, 33047.17382065467, 33338.66661333453, 33553.32893342168, 25878.894532656203, 25917.6112358311, 26160.0, 26206.213813585622, 26323.60514592321], "value": 18964.90105967056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.8834682115598, 461.52001918005277, 474.4757043466968, 480.4882799818196, 489.5569509593817, 17976.370827021055, 19033.0, 20070.2975395861, 20869.0, 21036.896310368993, 15777.526674199764, 20988.05553750081, 22188.0, 22275.0, 22905.885470572623, 6879.5184337096425, 7064.505484616079, 7080.53976491529, 7099.580083983198, 7156.4274858011495, 6842.281560436158, 7052.471064670144, 7055.223925368231, 7059.188193357752, 7061.89407158893, 6830.6584670766515, 6973.616451095213, 7047.295270472963, 7063.117110361205, 7072.575645461289, 6770.593764374154, 6899.689513971884, 6967.512274140812, 7012.544184628008, 7017.982392553051, 6779.118714567124, 6782.966085169543, 6785.084013658142, 6787.423069039138, 6810.421114205298, 26083.73916260832, 26829.46341073187, 26862.0, 27141.1857644271, 27152.72847271522, 3569.5002699622073, 3615.8891473409853, 3628.51015112959, 3714.312852122366, 3719.497867787868, 16428.096454694987, 16508.092054936973, 16945.237464314134, 16945.322187112502, 17456.127193640266, 2324.5815753164425, 2412.8552286862846, 2438.9146379876797, 2451.2156110044793, 2516.4589613233243, 95602.6026225203, 96715.51642241814, 96841.51579242059, 98420.50789746077, 99087.50456247745, 18823.529411764815, 18827.0, 18857.90571047136, 18935.90532047331, 19550.31573894907, 34658.653413465545, 34844.0, 34862.0, 34875.65124348775, 35196.648033519334, 9765.609375625038, 9949.104580587782, 10256.38461692286, 10400.47997600117, 10422.322549034288, 8649.567521623894, 8747.256483198873, 8791.868121978176, 8931.464112153162, 8948.373613847098, 10226.795464090825, 10360.689179324632, 10412.344852062826, 10518.211134164969, 10777.83833242502, 3690.261947610435, 3794.9241015180096, 3888.9027774305305, 3902.946204524819, 3951.8814435566405, 935.9204467620192, 968.8934217236099, 1002.1331548210891, 1012.4836333469983, 1021.3454204189261, 18953.336633217772, 19166.137523811463, 19217.0, 19836.50408739793, 21012.579748405253, 1010.4392062405288, 1013.964511242103, 1018.6587493189717, 1024.4928760263717, 1026.4200726589602, 10975.615853445252, 11268.323900565993, 11308.434578271053, 11322.320660760215, 11346.3759493227, 444137.0, 444826.0, 637395.0, 650210.0, 652441.0, 114145.0, 118313.40843295728, 118954.0, 119520.4023979892, 121626.3918680401, 1325.840899092115, 1368.6304697731557, 1396.2858795603847, 1400.9439622415193, 1405.508072174751, 19059.237630494627, 19345.709814352515, 19457.416277511697, 19494.805051949297, 19529.804701953366, 42947.57052429561, 46536.0, 52827.0, 53106.46893531015, 53988.92022159456, 65033.67483162743, 72005.6399717998, 74865.6256718713, 75089.62455187908, 76171.0, 9310.929243137127, 9371.671991480265, 12909.0, 13422.865771342553, 13582.320883955961, 14626.561203163923, 14643.12141271527, 14655.560333190022, 14691.85308146905, 14724.631884202981, 12198.451069702061, 12378.566750164062, 12414.255144691348, 12441.93779031099, 12598.244105353708, 11632.53469861196, 11862.22895511789, 12080.75838483243, 12577.182483138567, 13094.0, 6747.561408508432, 11881.287122772661, 12535.623931282076, 13277.734445310847, 13559.186448812708, 12435.253884766942, 12620.990320774132, 12679.30263835461, 12738.617841464771, 12821.358932053174, 12208.145429820182, 12372.566960156351, 12470.875291247334, 12519.186252893896, 12674.366281686063], "value": 11586.665025250471, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.8206206286281, 1587.3888552907126, 1598.4565247815744, 1613.9919300403496, 1625.658611691545, 10955.671329860097, 11632.883671163307, 11662.766744665112, 11667.70830729231, 11674.0, 11340.092792576595, 11473.139514536402, 11806.291622502635, 12086.21439606425, 12139.635810925663, 2500.4999000199987, 2543.2878793937634, 2545.0456078970387, 2546.567083595793, 2546.8726563671835, 2437.683101196842, 2457.447074408262, 2494.7006359236825, 2496.251124662594, 2498.712648045471, 2453.264020793764, 2455.398427385293, 2471.666325046123, 2492.464120214154, 2494.663220465232, 2385.844920080198, 2401.2076014915124, 2405.8797060147012, 2411.9276421707377, 2453.325335532743, 2372.074890792592, 2413.2518919135123, 2435.6711843901203, 2442.9511409771703, 2445.9143929962543, 11733.237339572901, 11814.822777658343, 11817.763644727143, 11829.526818927232, 11831.585894493737, 5814.447627475383, 5971.0, 5974.97012514939, 5980.760769569212, 5983.820485385445, 3246.2858171202297, 3290.555774970372, 3314.93370132596, 3366.663333666638, 3415.504751810998, 1315.5592876386422, 1332.9533466328633, 1347.1916849890085, 1383.0526089628636, 1399.02068552014, 15007.399704011827, 15364.692706145926, 15783.921080394639, 15876.12681302528, 16849.494515164442, 4532.116237333688, 4666.696664716783, 4666.69666471685, 4686.203345431285, 4688.413948256468, 11188.776224475465, 11476.770464590662, 13230.669233269246, 13231.0, 13248.602541923758, 5800.984827655144, 5973.253343332083, 6033.9698301508215, 6037.72830222641, 6042.818715438544, 5510.233647894543, 5513.09034009384, 5557.055300598908, 5576.749046292926, 5580.246666700024, 4104.117614712851, 4118.052847845012, 4158.771267580312, 4168.499780026416, 4204.768737719455, 1045.696747943088, 1058.333250052462, 1066.8773091094467, 1071.507106730897, 1078.3907092492716, 931.9720408387759, 940.2290122099812, 944.820484108031, 949.050949050949, 973.1047436358567, 7072.9646351767915, 7187.676554555058, 7197.928020719831, 7260.6732697028765, 7300.525465844703, 1050.0811789684026, 1101.0695961912172, 1113.1595645287919, 1115.760111576015, 1130.7342774447998, 4873.147199240118, 4880.292357608127, 4943.604511639061, 4953.801847926043, 5066.873328166826, 14646.487372941896, 15214.391424342903, 15261.771073433907, 15263.389464421522, 15264.084154950739, 13975.231362275172, 14377.64055898611, 14454.349554270084, 14491.20298383578, 14499.565013049625, 10640.627578034886, 10795.46022698862, 10843.891561084445, 10861.185411094042, 10865.674029779118, 7115.715371385087, 7378.409727221702, 7391.630418478947, 7501.6249187539315, 7506.099268087646, 12201.69495762613, 12250.264984100626, 12334.876651233373, 12336.938315308365, 12357.93821030889, 12432.316222607844, 12438.689032773891, 12540.122191446511, 12574.434150463068, 12719.0, 9809.362391444532, 10136.493175341351, 10141.138003269509, 10144.847827282449, 10147.898521014695, 10990.560377584807, 11165.609203677832, 11258.155638326994, 11262.436878156223, 11302.717432063935, 9532.189763870148, 9600.615975360908, 9658.179054780423, 9733.951330243304, 9822.0, 9510.1440870322, 9563.37838040553, 9617.086376794194, 9852.113309802153, 9993.400395975974, 8494.575271236537, 8514.70198543048, 8536.0, 8653.0, 8659.134086591543, 5944.64332140073, 6082.60463069899, 6101.725422355916, 6133.509319254538, 6193.938060619516, 6475.611463312216, 6494.383033611799, 6505.154329937078, 6672.165979252593, 6719.260881302955], "value": 5439.358118986691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.37457312323994, 431.874756320667, 436.89077730567357, 437.5602519467934, 439.7251717676452, 5133.768980395882, 5236.6857988520715, 5302.390225124112, 5306.452902606747, 5325.707086110262, 5171.0692075426405, 5175.03348727484, 5175.922361164586, 5178.093833579127, 5209.843704688856, 4244.363345498169, 4364.978175109136, 4369.803358848843, 4379.321205213197, 4390.748636638558, 4374.147041326943, 4384.7149935254265, 4389.912201755963, 4409.713368631029, 4414.337849322611, 4396.164728701552, 4407.625351845097, 4408.360787685784, 4423.4249547558775, 4442.3114417265215, 4221.430106935571, 4372.781360931973, 4403.515613282536, 4408.435005573039, 4461.308497182942, 4122.773247471388, 4127.484064491939, 4141.627253547195, 4148.253314403406, 4154.50145982481, 5022.1211288024815, 5081.466446023188, 5087.923681144785, 5090.796368145269, 5096.9490305097215, 4998.475160108209, 4998.600111991032, 5102.668326558762, 5127.974360128175, 5144.845654630367, 5389.978757965763, 5405.972970135163, 5443.891122177574, 5465.316835395575, 5508.91736623951, 4603.424571928509, 4610.654200934943, 4617.653675974282, 4630.513796051433, 4646.326282689025, 5376.596755243372, 5491.2312276281355, 5525.475079867406, 5642.294713160855, 5721.799737009184, 4572.268437050056, 4639.652026098056, 4653.464851542116, 4688.671792974459, 4712.43450785901, 4721.386219791474, 4738.0, 4751.0, 4756.7859446325, 4778.37881075458, 4789.856304310876, 4990.226514890198, 5037.4458809530925, 5058.898822023539, 5098.719570423588, 5407.945920540823, 5428.185772134132, 5433.0, 5443.455654434525, 5476.370217424967, 1631.3230009545905, 1636.860866826333, 1648.9422870199485, 1651.2404294024643, 1652.702513547573, 1241.485177012373, 1279.2580303423993, 1293.353323338331, 1294.50484690183, 1299.9545015924398, 5175.550845763192, 5449.836504904859, 5450.72956226269, 5461.15352120414, 5465.508104270635, 5486.478784515464, 5490.56075513958, 5560.833175004756, 5569.582281328835, 5583.0, 5354.4645535446925, 5369.328833895763, 5374.946250537523, 5402.783888644411, 5449.427810079885, 2832.909329907959, 2935.4295451933112, 2942.9111228845463, 2966.7539633354045, 2996.2659148508756, 5919.970400147971, 5926.881462370815, 5931.614445061057, 5937.910931336033, 5963.135345374896, 5755.712214389264, 5779.0, 5793.971030144822, 5810.0, 5827.475527202572, 5656.2929633795775, 5851.912221316684, 5899.7050147492455, 5903.498202652822, 5968.46283834457, 5661.745221465127, 5681.874968767079, 5695.917775622618, 5696.857578560569, 5744.856378590402, 5447.9025575153055, 5536.972315138399, 5584.357798853184, 5614.659277729745, 5665.801696940587, 5561.944380556142, 5669.3480249770155, 5794.275715535558, 5884.529237661062, 5902.2327097477055, 4668.323093151542, 4670.136024835417, 4691.437027556579, 4698.154332220233, 4733.1716949533, 5415.945840541702, 5545.838871843011, 5607.812952948435, 5629.437056294338, 5651.208830763779, 5443.673379597237, 5447.618666693294, 5466.899825131151, 5472.753726082416, 5478.698671572943, 5439.972800135974, 5467.890642187054, 5475.945240547543, 5477.4796394342475, 5487.560995120461, 5280.419153893145, 5440.4365140832815, 5466.988607107698, 5469.562435005269, 5484.945150548603, 5353.812616558402, 5434.184872269191, 5499.945000549943, 5500.779968801203, 5506.155437928179, 5338.345113014978, 5353.277307563585, 5425.430329815313, 5446.910617876361, 5469.42571030052], "value": 4425.682804375599, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.6705849426252, 786.2059320086711, 849.46908182386, 881.2289246908955, 893.6514759243894, 16327.183640817957, 17047.914760426196, 17052.403165889165, 17101.31594736209, 18049.63900721985, 17959.461216163538, 18443.90778046111, 18525.814741852577, 18548.629027419443, 18657.813421865776, 856.4732689396008, 865.4720620421538, 884.2528063786091, 887.0552861202831, 911.9922485653357, 895.5164211325877, 897.7935074932769, 898.874157617934, 899.0784445942895, 899.8110396816644, 946.049220533363, 949.5062567464914, 949.7008442340675, 950.3347656640345, 950.686273529737, 942.6747772018642, 944.3531181140906, 944.919681827042, 944.9385789923667, 946.1531928923644, 693.3517161454057, 693.5907814389534, 693.930606939307, 694.1808665774385, 694.6144889586277, 17605.383811566662, 17628.383006594835, 17801.0, 18712.90643546787, 18889.905550472296, 14987.250637468083, 15125.773113403307, 15138.545843624708, 15260.160691161982, 15613.765793513106, 13414.731705365837, 13862.4455021799, 14053.718925621533, 14108.576742697736, 14286.142831430148, 3962.405639154121, 3992.5208974922903, 4026.4765580474646, 4094.651954583864, 4132.896677583054, 86640.56679716625, 87130.56434717849, 88766.0, 91626.5418672909, 91643.08356916413, 11953.22304050234, 12146.75706485883, 12153.756924861453, 12156.817647735292, 12167.574134905413, 23992.880035599712, 24013.7598624015, 24044.639330410057, 24145.15491957773, 24317.878410607835, 8768.956155219183, 8888.3333749969, 8922.73231803047, 8965.910340896638, 9040.321975851837, 5021.949780502148, 5022.673526220784, 5080.466551012164, 5083.364579427572, 5162.432132465426, 3841.635044670808, 3933.331333673282, 3938.6258305460933, 3938.9606103938595, 3954.584768599313, 619.0435776724971, 629.3266205160435, 630.9936900630935, 632.7279269913981, 634.6731433311849, 801.3428988229596, 827.954462504556, 847.3221422861686, 852.7538700763631, 859.6045818923241, 11319.660410187707, 11541.884581154249, 11659.300441973508, 11740.765184696258, 12025.398730063462, 846.5894041389921, 854.9444286121383, 855.2431098477892, 865.2429124516049, 865.3942240431597, 5587.860303492445, 5652.378238393773, 5696.658200507983, 5723.399043100498, 5726.799562015392, 66824.0, 71146.64426677834, 78778.0, 81975.0, 82629.58685206536, 52928.47071529235, 55114.448855511735, 55651.443485564625, 61147.38852611506, 66282.33717662859, 61730.382696173365, 62349.37650623526, 62417.37582624116, 62690.37309626846, 63798.68100659467, 11008.284461509977, 11299.943500282447, 11392.373419461677, 11696.739395689856, 11894.940525297317, 40510.59489405068, 41142.382864257655, 41967.790161049, 42145.578544215394, 42709.57290427056, 47462.76268618635, 47489.28766068443, 47902.28146577734, 48165.518344816104, 49424.752876236824, 13507.189568625914, 13654.180749155083, 13656.180629162282, 13949.930250348683, 14092.718145637235, 14177.716445670823, 14547.0, 14662.413503459742, 14740.926295368454, 15154.924225379244, 14949.925250373679, 14999.0, 15226.162561059247, 15332.77000844966, 15401.69196616039, 15008.324625392102, 15171.544853654408, 15273.694526109193, 15874.841251587337, 16031.679366412372, 13710.520131795738, 13937.442502299795, 13982.370793314529, 14001.579952601438, 14067.155970641385, 11469.942650286695, 11754.471048802996, 11812.409379530816, 12194.329311887932, 12198.207116537396, 11547.364894930859, 11631.941840290745, 11796.88203117992, 11842.230255033395, 11906.642800715992], "value": 7851.255664314341, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 115.0, 159.0, 115.0, 116.0, 115.0, 114.0, 141.0, 115.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 115.0, 74.0, 75.0, 78.0, 75.0, 90.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 81.0, 82.0, 81.0, 94.0, 81.0, 82.0, 113.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 52.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 80.0, 77.0, 76.0, 76.0, 77.0, 83.0, 79.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 119.0, 128.0, 129.0, 123.0, 119.0, 122.0, 120.0, 158.0, 120.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 160.0, 159.0, 156.0, 158.0, 157.0, 158.0, 157.0, 157.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 67.0, 59.0, 61.0, 60.0, 65.0, 59.0, 59.0, 58.0], "value": 61.0, "unit": "score"}]}]} 08:50:02 INFO - Return code: 0 08:50:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:50:02 ERROR - # TBPL SUCCESS # 08:50:02 INFO - Running post-action listener: _resource_record_post_action 08:50:02 INFO - [mozharness: 2017-03-24 15:50:02.496948Z] Finished run-tests step (success) 08:50:02 INFO - Running post-run listener: _resource_record_post_run 08:50:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363614208; Read time: 8; Write time: 396332 08:50:02 INFO - TinderboxPrint: CPU usage
13.1% 08:50:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:50:02 INFO - TinderboxPrint: I/O write bytes / time
363,614,208 / 396,332 08:50:02 INFO - TinderboxPrint: CPU idle
8,269.0 (86.8%) 08:50:02 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 08:50:02 INFO - TinderboxPrint: Swap in / out
0 / 0 08:50:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111017984; Read time: 0; Write time: 161956 08:50:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 252104704; Read time: 0; Write time: 234240 08:50:03 INFO - Running post-run listener: _upload_blobber_files 08:50:03 INFO - Blob upload gear active. 08:50:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:50:03 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 08:50:03 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:50:03 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:50:03 INFO - (blobuploader) - INFO - Open directory for files ... 08:50:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:06 INFO - (blobuploader) - INFO - Done attempting. 08:50:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:50:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:50:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:07 INFO - (blobuploader) - INFO - Done attempting. 08:50:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:50:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:50:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:08 INFO - (blobuploader) - INFO - Done attempting. 08:50:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:50:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:09 INFO - (blobuploader) - INFO - Done attempting. 08:50:09 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:09 INFO - Return code: 0 08:50:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58cd78c32ab84c0b6db9af4e38eff61595e26652735351e5683777d10050f81875ea7cc51a1106904051f5dd25cb1ef605cff806e9a22950da2cef6f731e669f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f1567275af2bde5bb228bbfdbc495c63c747090a7abd8dce88059fe5a99adb9e62f49c3b3b9729aa1d56cfb3e04fecf7c93afd4751525dcb79e3f55f266c1700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f3ba1efb92b6299de76a8ff9e2543eb187faa72f15f67b71dc4f8156fe5cac6bee4a81d58a97cc6aa74cb1dab17be9bcdcc2d568d2978246437463bf9dfbc68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a917c65d995bf5f67be55ba6e633e43bc4abea279ea26281ea17831d4fcb46043a974841fff74f09511de8206d9a5433ae5748b3f97e477f7c704b3d2ff5e8a6"} 08:50:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:09 INFO - Contents: 08:50:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58cd78c32ab84c0b6db9af4e38eff61595e26652735351e5683777d10050f81875ea7cc51a1106904051f5dd25cb1ef605cff806e9a22950da2cef6f731e669f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f1567275af2bde5bb228bbfdbc495c63c747090a7abd8dce88059fe5a99adb9e62f49c3b3b9729aa1d56cfb3e04fecf7c93afd4751525dcb79e3f55f266c1700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f3ba1efb92b6299de76a8ff9e2543eb187faa72f15f67b71dc4f8156fe5cac6bee4a81d58a97cc6aa74cb1dab17be9bcdcc2d568d2978246437463bf9dfbc68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a917c65d995bf5f67be55ba6e633e43bc4abea279ea26281ea17831d4fcb46043a974841fff74f09511de8206d9a5433ae5748b3f97e477f7c704b3d2ff5e8a6"} 08:50:09 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:09 INFO - Copying logs to upload dir... 08:50:09 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.626618 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-24 08:50:08.759740) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 08:50:08.763449) ========= 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=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58cd78c32ab84c0b6db9af4e38eff61595e26652735351e5683777d10050f81875ea7cc51a1106904051f5dd25cb1ef605cff806e9a22950da2cef6f731e669f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f1567275af2bde5bb228bbfdbc495c63c747090a7abd8dce88059fe5a99adb9e62f49c3b3b9729aa1d56cfb3e04fecf7c93afd4751525dcb79e3f55f266c1700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f3ba1efb92b6299de76a8ff9e2543eb187faa72f15f67b71dc4f8156fe5cac6bee4a81d58a97cc6aa74cb1dab17be9bcdcc2d568d2978246437463bf9dfbc68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a917c65d995bf5f67be55ba6e633e43bc4abea279ea26281ea17831d4fcb46043a974841fff74f09511de8206d9a5433ae5748b3f97e477f7c704b3d2ff5e8a6"} build_url:https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/HW4EDsCfS0i16Lrs_l0lhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/58cd78c32ab84c0b6db9af4e38eff61595e26652735351e5683777d10050f81875ea7cc51a1106904051f5dd25cb1ef605cff806e9a22950da2cef6f731e669f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f1567275af2bde5bb228bbfdbc495c63c747090a7abd8dce88059fe5a99adb9e62f49c3b3b9729aa1d56cfb3e04fecf7c93afd4751525dcb79e3f55f266c1700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f3ba1efb92b6299de76a8ff9e2543eb187faa72f15f67b71dc4f8156fe5cac6bee4a81d58a97cc6aa74cb1dab17be9bcdcc2d568d2978246437463bf9dfbc68a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a917c65d995bf5f67be55ba6e633e43bc4abea279ea26281ea17831d4fcb46043a974841fff74f09511de8206d9a5433ae5748b3f97e477f7c704b3d2ff5e8a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 08:50:08.789120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:50:08.789419) ========= 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=fa44defc139c4ba8574fe040000001db-1490369355.504036-1044369059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 08:50:08.872880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 08:50:08.873193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 08:50:08.873485) ========= ========= Total master_lag: 0.17 =========