builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1491851938.26 results: success (0) revision: 8c1af10581c25ff8948370a4503101efb0c163d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.263047) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.264138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.264862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.281801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.282498) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-10 12:18:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-04-10 12:18:58 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.416799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.417639) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014184 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:58.469863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 12:18:58.470635) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c1af10581c25ff8948370a4503101efb0c163d2 --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 8c1af10581c25ff8948370a4503101efb0c163d2 --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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-10 12:18:58,565 truncating revision to first 12 chars 2017-04-10 12:18:58,565 Setting DEBUG logging. 2017-04-10 12:18:58,565 attempt 1/10 2017-04-10 12:18:58,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8c1af10581c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 12:18:59,352 unpacking tar archive at: mozilla-aurora-8c1af10581c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.084619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 12:18:59.576927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:59.577740) ========= script_repo_revision: 8c1af10581c25ff8948370a4503101efb0c163d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:59.578170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:59.578476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 12:18:59.589536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 12:18:59.589843) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:59 INFO - MultiFileLogger online at 20170410 12:18:59 in /builds/slave/test 12:18:59 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 12:18:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:59 INFO - {'append_to_log': False, 12:18:59 INFO - 'base_work_dir': '/builds/slave/test', 12:18:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 12:18:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:59 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 12:18:59 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:59 INFO - 'config_files': ('talos/linux_config.py',), 12:18:59 INFO - 'default_actions': ('clobber', 12:18:59 INFO - 'read-buildbot-config', 12:18:59 INFO - 'download-and-extract', 12:18:59 INFO - 'populate-webroot', 12:18:59 INFO - 'create-virtualenv', 12:18:59 INFO - 'install', 12:18:59 INFO - 'run-tests'), 12:18:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:59 INFO - 'download_minidump_stackwalk': True, 12:18:59 INFO - 'download_symbols': 'ondemand', 12:18:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:59 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:59 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:59 INFO - 'gecko_profile': False, 12:18:59 INFO - 'gecko_profile_interval': 0, 12:18:59 INFO - 'installer_path': 'installer.exe', 12:18:59 INFO - 'log_level': 'info', 12:18:59 INFO - 'log_name': 'talos', 12:18:59 INFO - 'log_to_console': True, 12:18:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:59 INFO - 'opt_config_files': (), 12:18:59 INFO - 'pip_index': False, 12:18:59 INFO - 'suite': 'dromaeojs', 12:18:59 INFO - 'system_bits': '32', 12:18:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:59 INFO - 'title': 'talos-linux64-ix-033', 12:18:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:59 INFO - 'use_talos_json': True, 12:18:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:59 INFO - 'work_dir': 'build'} 12:18:59 INFO - [mozharness: 2017-04-10 19:18:59.783985Z] Running clobber step. 12:18:59 INFO - Running pre-action listener: _resource_record_pre_action 12:18:59 INFO - Running main action method: clobber 12:18:59 INFO - rmtree: /builds/slave/test/build 12:18:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:00 INFO - Running post-action listener: _resource_record_post_action 12:19:00 INFO - [mozharness: 2017-04-10 19:19:00.830318Z] Finished clobber step (success) 12:19:00 INFO - [mozharness: 2017-04-10 19:19:00.830421Z] Running read-buildbot-config step. 12:19:00 INFO - Running pre-action listener: _resource_record_pre_action 12:19:00 INFO - Running main action method: read_buildbot_config 12:19:00 INFO - Using buildbot properties: 12:19:00 INFO - { 12:19:00 INFO - "project": "", 12:19:00 INFO - "product": "firefox", 12:19:00 INFO - "who": "paul@paul.cx", 12:19:00 INFO - "installer_path": "public/build/target.tar.bz2", 12:19:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:19:00 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 12:19:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 12:19:00 INFO - "stage_platform": "linux64", 12:19:00 INFO - "basedir": "/builds/slave/test", 12:19:00 INFO - "buildnumber": 126, 12:19:00 INFO - "platform": "ubuntu64_hw", 12:19:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:19:00 INFO - "slavebuilddir": "test", 12:19:00 INFO - "taskId": "WhWmcVIeS2irDQWBTM6zkQ", 12:19:00 INFO - "branch": "mozilla-aurora", 12:19:00 INFO - "script_repo_revision": "production", 12:19:00 INFO - "revision": "8c1af10581c25ff8948370a4503101efb0c163d2", 12:19:00 INFO - "slavename": "talos-linux64-ix-033", 12:19:00 INFO - "repo_path": "releases/mozilla-aurora" 12:19:00 INFO - } 12:19:00 INFO - Finding installer, test and symbols from parent task. 12:19:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WhWmcVIeS2irDQWBTM6zkQ'}, attempt #1 12:19:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WhWmcVIeS2irDQWBTM6zkQ'}, attempt #1 12:19:01 INFO - Task dependencies: G6559U_nRp2hiSkWBMgYpQ 12:19:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ'}, attempt #1 12:19:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 12:19:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/test_packages.json 12:19:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.crashreporter-symbols.zip 12:19:02 INFO - Running post-action listener: _resource_record_post_action 12:19:02 INFO - [mozharness: 2017-04-10 19:19:02.179927Z] Finished read-buildbot-config step (success) 12:19:02 INFO - [mozharness: 2017-04-10 19:19:02.180146Z] Running download-and-extract step. 12:19:02 INFO - Running pre-action listener: _resource_record_pre_action 12:19:02 INFO - Running main action method: download_and_extract 12:19:02 INFO - mkdir: /builds/slave/test/build/tests 12:19:02 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')]} 12:19:02 INFO - trying https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.test_packages.json 12:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:19:02 INFO - Downloaded 896 bytes. 12:19:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:19:02 INFO - Using the following test package requirements: 12:19:02 INFO - {u'common': [u'target.common.tests.zip'], 12:19:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:19:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:19:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:19:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:19:02 INFO - u'mozbase': [u'target.common.tests.zip'], 12:19:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:19:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:19:02 INFO - u'web-platform': [u'target.common.tests.zip', 12:19:02 INFO - u'target.web-platform.tests.zip'], 12:19:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:19:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:19:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip 12:19:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:19:02 INFO - Fetch https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip into memory 12:19:03 INFO - Expected file size: 59541730 12:19:03 INFO - Obtained file size: 59541730 12:19:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip 12:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.common.tests.zip into memory 12:19:14 INFO - Expected file size: 59541730 12:19:14 INFO - Obtained file size: 59541730 12:19:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.talos.tests.zip 12:19:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:19:25 INFO - Fetch https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.talos.tests.zip into memory 12:19:25 INFO - Expected file size: 14404424 12:19:25 INFO - Obtained file size: 14404424 12:19:26 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')]} 12:19:26 INFO - trying https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 12:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:19:29 INFO - Downloaded 66684140 bytes. 12:19:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 12:19:29 INFO - mkdir: /builds/slave/test/properties 12:19:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:29 INFO - Contents: 12:19:29 INFO - build_url:https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 12:19:29 INFO - Running post-action listener: _resource_record_post_action 12:19:29 INFO - Running post-action listener: set_extra_try_arguments 12:19:29 INFO - [mozharness: 2017-04-10 19:19:29.500162Z] Finished download-and-extract step (success) 12:19:29 INFO - [mozharness: 2017-04-10 19:19:29.500269Z] Running populate-webroot step. 12:19:29 INFO - Running pre-action listener: _resource_record_pre_action 12:19:29 INFO - Running main action method: populate_webroot 12:19:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:29 INFO - '--tppagecycles', 12:19:29 INFO - '7'], 12:19:29 INFO - 'tests': ['tsvgm']}}, 12:19:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['damp', 'tps']}, 12:19:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'tests': ['damp', 'tps']}, 12:19:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['dromaeo_dom']}, 12:19:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['basic_compositor_video']}, 12:19:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:19:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['a11yr', 12:19:29 INFO - 'ts_paint', 12:19:29 INFO - 'tpaint', 12:19:29 INFO - 'sessionrestore', 12:19:29 INFO - 'sessionrestore_no_auto_restore', 12:19:29 INFO - 'tabpaint']}, 12:19:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['tsvgx', 12:19:29 INFO - 'tsvgr_opacity', 12:19:29 INFO - 'tart', 12:19:29 INFO - 'tscrollx', 12:19:29 INFO - 'cart', 12:19:29 INFO - 'tsvg_static']}, 12:19:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:29 INFO - 'tsvgr_opacity', 12:19:29 INFO - 'tart', 12:19:29 INFO - 'tscrollx', 12:19:29 INFO - 'cart', 12:19:29 INFO - 'tsvg_static']}, 12:19:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'talos_options': ['--disable-e10s'], 12:19:29 INFO - 'tests': ['tp5o']}, 12:19:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:19:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'talos_options': ['--disable-e10s', 12:19:29 INFO - '--xperf_path', 12:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:29 INFO - 'tests': ['tp5n']}, 12:19:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:19:29 INFO - 'talos_options': ['--xperf_path', 12:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:29 INFO - 'tests': ['tp5n']}}, 12:19:29 INFO - 'talos.zip': {'path': '', 12:19:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:29 INFO - Running post-action listener: _resource_record_post_action 12:19:29 INFO - [mozharness: 2017-04-10 19:19:29.513561Z] Finished populate-webroot step (success) 12:19:29 INFO - [mozharness: 2017-04-10 19:19:29.513651Z] Running create-virtualenv step. 12:19:29 INFO - Running pre-action listener: _resource_record_pre_action 12:19:29 INFO - Running main action method: create_virtualenv 12:19:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:19:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:29 INFO - Using real prefix '/usr' 12:19:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:32 INFO - Installing pip.................done. 12:19:32 INFO - Return code: 0 12:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:19:32 INFO - Reading from file tmpfile_stdout 12:19:32 INFO - Output received: 12:19:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:19:32 INFO - Using env: {'DISPLAY': ':0', 12:19:32 INFO - 'HOME': '/home/cltbld', 12:19:32 INFO - 'LANG': 'en_US.UTF-8', 12:19:32 INFO - 'LANGUAGE': 'en_US:en', 12:19:32 INFO - 'LOGNAME': 'cltbld', 12:19:32 INFO - 'MAIL': '/var/mail/cltbld', 12:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:32 INFO - 'MOZ_NO_REMOTE': '1', 12:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:32 INFO - 'NO_EM_RESTART': '1', 12:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:32 INFO - 'PWD': '/builds/slave/test', 12:19:32 INFO - 'SHELL': '/bin/bash', 12:19:32 INFO - 'SHLVL': '1', 12:19:32 INFO - 'TERM': 'linux', 12:19:32 INFO - 'TMOUT': '86400', 12:19:32 INFO - 'USER': 'cltbld', 12:19:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:32 INFO - '_': '/tools/buildbot/bin/python'} 12:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:19:32 INFO - Cleaning up... 12:19:32 INFO - Return code: 0 12:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:19:32 INFO - Using env: {'DISPLAY': ':0', 12:19:32 INFO - 'HOME': '/home/cltbld', 12:19:32 INFO - 'LANG': 'en_US.UTF-8', 12:19:32 INFO - 'LANGUAGE': 'en_US:en', 12:19:32 INFO - 'LOGNAME': 'cltbld', 12:19:32 INFO - 'MAIL': '/var/mail/cltbld', 12:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:32 INFO - 'MOZ_NO_REMOTE': '1', 12:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:32 INFO - 'NO_EM_RESTART': '1', 12:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:32 INFO - 'PWD': '/builds/slave/test', 12:19:32 INFO - 'SHELL': '/bin/bash', 12:19:32 INFO - 'SHLVL': '1', 12:19:32 INFO - 'TERM': 'linux', 12:19:32 INFO - 'TMOUT': '86400', 12:19:32 INFO - 'USER': 'cltbld', 12:19:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:32 INFO - '_': '/tools/buildbot/bin/python'} 12:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:32 INFO - Downloading/unpacking psutil>=3.1.1 12:19:32 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 12:19:32 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 12:19:32 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 12:19:32 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 12:19:32 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 12:19:32 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 12:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:34 INFO - Installing collected packages: psutil 12:19:34 INFO - Running setup.py install for psutil 12:19:34 INFO - building 'psutil._psutil_linux' extension 12:19:34 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 12:19:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:19:35 INFO - building 'psutil._psutil_posix' extension 12:19:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:19:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:35 INFO - Successfully installed psutil 12:19:35 INFO - Cleaning up... 12:19:35 INFO - Return code: 0 12:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:19:35 INFO - Using env: {'DISPLAY': ':0', 12:19:35 INFO - 'HOME': '/home/cltbld', 12:19:35 INFO - 'LANG': 'en_US.UTF-8', 12:19:35 INFO - 'LANGUAGE': 'en_US:en', 12:19:35 INFO - 'LOGNAME': 'cltbld', 12:19:35 INFO - 'MAIL': '/var/mail/cltbld', 12:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:35 INFO - 'MOZ_NO_REMOTE': '1', 12:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:35 INFO - 'NO_EM_RESTART': '1', 12:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:35 INFO - 'PWD': '/builds/slave/test', 12:19:35 INFO - 'SHELL': '/bin/bash', 12:19:35 INFO - 'SHLVL': '1', 12:19:35 INFO - 'TERM': 'linux', 12:19:35 INFO - 'TMOUT': '86400', 12:19:35 INFO - 'USER': 'cltbld', 12:19:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:35 INFO - '_': '/tools/buildbot/bin/python'} 12:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19:35 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 12:19:35 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 12:19:35 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 12:19:35 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 12:19:35 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 12:19:35 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 12:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:37 INFO - Installing collected packages: mozsystemmonitor 12:19:37 INFO - Running setup.py install for mozsystemmonitor 12:19:37 INFO - Successfully installed mozsystemmonitor 12:19:37 INFO - Cleaning up... 12:19:37 INFO - Return code: 0 12:19:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:37 INFO - Using env: {'DISPLAY': ':0', 12:19:37 INFO - 'HOME': '/home/cltbld', 12:19:37 INFO - 'LANG': 'en_US.UTF-8', 12:19:37 INFO - 'LANGUAGE': 'en_US:en', 12:19:37 INFO - 'LOGNAME': 'cltbld', 12:19:37 INFO - 'MAIL': '/var/mail/cltbld', 12:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:37 INFO - 'MOZ_NO_REMOTE': '1', 12:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:37 INFO - 'NO_EM_RESTART': '1', 12:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:37 INFO - 'PWD': '/builds/slave/test', 12:19:37 INFO - 'SHELL': '/bin/bash', 12:19:37 INFO - 'SHLVL': '1', 12:19:37 INFO - 'TERM': 'linux', 12:19:37 INFO - 'TMOUT': '86400', 12:19:37 INFO - 'USER': 'cltbld', 12:19:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:37 INFO - '_': '/tools/buildbot/bin/python'} 12:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:40 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:40 INFO - warning: no files found matching '*.txt' 12:19:40 INFO - no previously-included directories found matching 'build' 12:19:40 INFO - no previously-included directories found matching 'dist' 12:19:40 INFO - no previously-included directories found matching '.git*' 12:19:40 INFO - Installing collected packages: jsonschema, functools32 12:19:40 INFO - Running setup.py install for functools32 12:19:40 INFO - warning: no files found matching '*.txt' 12:19:40 INFO - no previously-included directories found matching 'build' 12:19:40 INFO - no previously-included directories found matching 'dist' 12:19:40 INFO - no previously-included directories found matching '.git*' 12:19:40 INFO - Successfully installed jsonschema functools32 12:19:40 INFO - Cleaning up... 12:19:40 INFO - Return code: 0 12:19:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:19:40 INFO - Using env: {'DISPLAY': ':0', 12:19:40 INFO - 'HOME': '/home/cltbld', 12:19:40 INFO - 'LANG': 'en_US.UTF-8', 12:19:40 INFO - 'LANGUAGE': 'en_US:en', 12:19:40 INFO - 'LOGNAME': 'cltbld', 12:19:40 INFO - 'MAIL': '/var/mail/cltbld', 12:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:40 INFO - 'MOZ_NO_REMOTE': '1', 12:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:40 INFO - 'NO_EM_RESTART': '1', 12:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:40 INFO - 'PWD': '/builds/slave/test', 12:19:40 INFO - 'SHELL': '/bin/bash', 12:19:40 INFO - 'SHLVL': '1', 12:19:40 INFO - 'TERM': 'linux', 12:19:40 INFO - 'TMOUT': '86400', 12:19:40 INFO - 'USER': 'cltbld', 12:19:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:40 INFO - '_': '/tools/buildbot/bin/python'} 12:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:40 INFO - Cleaning up... 12:19:40 INFO - Return code: 0 12:19:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:40 INFO - Using env: {'DISPLAY': ':0', 12:19:40 INFO - 'HOME': '/home/cltbld', 12:19:40 INFO - 'LANG': 'en_US.UTF-8', 12:19:40 INFO - 'LANGUAGE': 'en_US:en', 12:19:40 INFO - 'LOGNAME': 'cltbld', 12:19:40 INFO - 'MAIL': '/var/mail/cltbld', 12:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:40 INFO - 'MOZ_NO_REMOTE': '1', 12:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:40 INFO - 'NO_EM_RESTART': '1', 12:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:40 INFO - 'PWD': '/builds/slave/test', 12:19:40 INFO - 'SHELL': '/bin/bash', 12:19:40 INFO - 'SHLVL': '1', 12:19:40 INFO - 'TERM': 'linux', 12:19:40 INFO - 'TMOUT': '86400', 12:19:40 INFO - 'USER': 'cltbld', 12:19:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:40 INFO - '_': '/tools/buildbot/bin/python'} 12:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:42 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:43 INFO - Downloading docopt-0.6.1.tar.gz 12:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:43 INFO - Running setup.py install for blobuploader 12:19:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:43 INFO - Running setup.py install for requests 12:19:44 INFO - Running setup.py install for docopt 12:19:44 INFO - Successfully installed blobuploader requests docopt 12:19:44 INFO - Cleaning up... 12:19:44 INFO - Return code: 0 12:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:19:44 INFO - Using env: {'DISPLAY': ':0', 12:19:44 INFO - 'HOME': '/home/cltbld', 12:19:44 INFO - 'LANG': 'en_US.UTF-8', 12:19:44 INFO - 'LANGUAGE': 'en_US:en', 12:19:44 INFO - 'LOGNAME': 'cltbld', 12:19:44 INFO - 'MAIL': '/var/mail/cltbld', 12:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:44 INFO - 'MOZ_NO_REMOTE': '1', 12:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:44 INFO - 'NO_EM_RESTART': '1', 12:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:44 INFO - 'PWD': '/builds/slave/test', 12:19:44 INFO - 'SHELL': '/bin/bash', 12:19:44 INFO - 'SHLVL': '1', 12:19:44 INFO - 'TERM': 'linux', 12:19:44 INFO - 'TMOUT': '86400', 12:19:44 INFO - 'USER': 'cltbld', 12:19:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:44 INFO - '_': '/tools/buildbot/bin/python'} 12:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:44 INFO - Running setup.py (path:/tmp/pip-hno1U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:44 INFO - Running setup.py (path:/tmp/pip-9XZiCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:44 INFO - Running setup.py (path:/tmp/pip-UUXGkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:44 INFO - Running setup.py (path:/tmp/pip-LzE2ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:44 INFO - Running setup.py (path:/tmp/pip-Y7u0gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:45 INFO - Running setup.py (path:/tmp/pip-00rjC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:45 INFO - Running setup.py (path:/tmp/pip-P6bUs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:45 INFO - Running setup.py (path:/tmp/pip-rJAzzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:45 INFO - Running setup.py (path:/tmp/pip-lQaMmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:45 INFO - Running setup.py (path:/tmp/pip-A6a7zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:45 INFO - Running setup.py (path:/tmp/pip-7VOx70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:45 INFO - Running setup.py (path:/tmp/pip-vERcwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:45 INFO - Running setup.py (path:/tmp/pip-cdD94U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:45 INFO - Running setup.py (path:/tmp/pip-scsKGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:45 INFO - Running setup.py (path:/tmp/pip-5OQJOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:45 INFO - Running setup.py (path:/tmp/pip-usnF3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:45 INFO - Running setup.py (path:/tmp/pip-5iQCvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:45 INFO - Running setup.py install for manifestparser 12:19:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for mozcrash 12:19:46 INFO - Running setup.py install for mozdebug 12:19:46 INFO - Running setup.py install for mozdevice 12:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for mozfile 12:19:46 INFO - Running setup.py install for mozhttpd 12:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for mozinfo 12:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for mozInstall 12:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for mozleak 12:19:46 INFO - Running setup.py install for mozlog 12:19:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:46 INFO - Running setup.py install for moznetwork 12:19:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Running setup.py install for mozprocess 12:19:47 INFO - Running setup.py install for mozprofile 12:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Running setup.py install for mozrunner 12:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Running setup.py install for mozscreenshot 12:19:47 INFO - Running setup.py install for moztest 12:19:47 INFO - Running setup.py install for mozversion 12:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:47 INFO - Cleaning up... 12:19:47 INFO - Return code: 0 12:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:47 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 12:19:47 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 12:19:47 INFO - Using env: {'DISPLAY': ':0', 12:19:47 INFO - 'HOME': '/home/cltbld', 12:19:47 INFO - 'LANG': 'en_US.UTF-8', 12:19:47 INFO - 'LANGUAGE': 'en_US:en', 12:19:47 INFO - 'LOGNAME': 'cltbld', 12:19:47 INFO - 'MAIL': '/var/mail/cltbld', 12:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:47 INFO - 'MOZ_NO_REMOTE': '1', 12:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:47 INFO - 'NO_EM_RESTART': '1', 12:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:47 INFO - 'PWD': '/builds/slave/test', 12:19:47 INFO - 'SHELL': '/bin/bash', 12:19:47 INFO - 'SHLVL': '1', 12:19:47 INFO - 'TERM': 'linux', 12:19:47 INFO - 'TMOUT': '86400', 12:19:47 INFO - 'USER': 'cltbld', 12:19:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:47 INFO - '_': '/tools/buildbot/bin/python'} 12:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:47 INFO - Running setup.py (path:/tmp/pip-Qj6PvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:48 INFO - Running setup.py (path:/tmp/pip-0wFJEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:48 INFO - Running setup.py (path:/tmp/pip-jkzDx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:48 INFO - Running setup.py (path:/tmp/pip-go5u8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:48 INFO - Running setup.py (path:/tmp/pip-20qgeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:48 INFO - Running setup.py (path:/tmp/pip-7ZFlQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:48 INFO - Running setup.py (path:/tmp/pip-YPzLuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:48 INFO - Running setup.py (path:/tmp/pip-ke6scb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:48 INFO - Running setup.py (path:/tmp/pip-w4Ct3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:48 INFO - Running setup.py (path:/tmp/pip-TJNlZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:48 INFO - Running setup.py (path:/tmp/pip-6WMEHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:48 INFO - Running setup.py (path:/tmp/pip-hArSa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:48 INFO - Running setup.py (path:/tmp/pip-qQQ6kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:48 INFO - Running setup.py (path:/tmp/pip-0xqO8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:48 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)) 12:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:48 INFO - Running setup.py (path:/tmp/pip-MLEDaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:49 INFO - Running setup.py (path:/tmp/pip-IAiTXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:49 INFO - Running setup.py (path:/tmp/pip-FITEzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:51 INFO - Downloading blessings-1.6.tar.gz 12:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:51 INFO - Installing collected packages: blessings 12:19:51 INFO - Running setup.py install for blessings 12:19:51 INFO - Successfully installed blessings 12:19:51 INFO - Cleaning up... 12:19:51 INFO - Return code: 0 12:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:51 INFO - Reading from file tmpfile_stdout 12:19:51 INFO - Current package versions: 12:19:51 INFO - argparse == 1.2.1 12:19:51 INFO - blessings == 1.6 12:19:51 INFO - blobuploader == 1.2.4 12:19:51 INFO - docopt == 0.6.1 12:19:51 INFO - functools32 == 3.2.3-2 12:19:51 INFO - jsonschema == 2.5.1 12:19:51 INFO - manifestparser == 1.1 12:19:51 INFO - mozInstall == 1.12 12:19:51 INFO - mozcrash == 1.0 12:19:51 INFO - mozdebug == 0.1 12:19:51 INFO - mozdevice == 0.49 12:19:51 INFO - mozfile == 1.2 12:19:51 INFO - mozhttpd == 0.7 12:19:51 INFO - mozinfo == 0.9 12:19:51 INFO - mozleak == 0.1 12:19:51 INFO - mozlog == 3.4 12:19:51 INFO - moznetwork == 0.27 12:19:51 INFO - mozprocess == 0.25 12:19:51 INFO - mozprofile == 0.28 12:19:51 INFO - mozrunner == 6.13 12:19:51 INFO - mozscreenshot == 0.1 12:19:51 INFO - mozsystemmonitor == 0.3 12:19:51 INFO - moztest == 0.8 12:19:51 INFO - mozversion == 1.4 12:19:51 INFO - psutil == 3.1.1 12:19:51 INFO - requests == 1.2.3 12:19:51 INFO - wsgiref == 0.1.2 12:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:51 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 12:19:51 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 12:19:51 INFO - Using env: {'DISPLAY': ':0', 12:19:51 INFO - 'HOME': '/home/cltbld', 12:19:51 INFO - 'LANG': 'en_US.UTF-8', 12:19:51 INFO - 'LANGUAGE': 'en_US:en', 12:19:51 INFO - 'LOGNAME': 'cltbld', 12:19:51 INFO - 'MAIL': '/var/mail/cltbld', 12:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:51 INFO - 'MOZ_NO_REMOTE': '1', 12:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:51 INFO - 'NO_EM_RESTART': '1', 12:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:51 INFO - 'PWD': '/builds/slave/test', 12:19:51 INFO - 'SHELL': '/bin/bash', 12:19:51 INFO - 'SHLVL': '1', 12:19:51 INFO - 'TERM': 'linux', 12:19:51 INFO - 'TMOUT': '86400', 12:19:51 INFO - 'USER': 'cltbld', 12:19:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:51 INFO - '_': '/tools/buildbot/bin/python'} 12:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 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)) 12:19:51 INFO - Cleaning up... 12:19:51 INFO - Return code: 0 12:19:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:51 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 0x134f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ed310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', '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 12:19:51 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 12:19:51 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 12:19:51 INFO - Using env: {'DISPLAY': ':0', 12:19:51 INFO - 'HOME': '/home/cltbld', 12:19:51 INFO - 'LANG': 'en_US.UTF-8', 12:19:51 INFO - 'LANGUAGE': 'en_US:en', 12:19:51 INFO - 'LOGNAME': 'cltbld', 12:19:51 INFO - 'MAIL': '/var/mail/cltbld', 12:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:51 INFO - 'MOZ_NO_REMOTE': '1', 12:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:51 INFO - 'NO_EM_RESTART': '1', 12:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:51 INFO - 'PWD': '/builds/slave/test', 12:19:51 INFO - 'SHELL': '/bin/bash', 12:19:51 INFO - 'SHLVL': '1', 12:19:51 INFO - 'TERM': 'linux', 12:19:51 INFO - 'TMOUT': '86400', 12:19:51 INFO - 'USER': 'cltbld', 12:19:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:51 INFO - '_': '/tools/buildbot/bin/python'} 12:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:52 INFO - Cleaning up... 12:19:52 INFO - Return code: 0 12:19:52 INFO - Running post-action listener: _resource_record_post_action 12:19:52 INFO - Running post-action listener: _start_resource_monitoring 12:19:52 INFO - Starting resource monitoring. 12:19:52 INFO - [mozharness: 2017-04-10 19:19:52.186289Z] Finished create-virtualenv step (success) 12:19:52 INFO - [mozharness: 2017-04-10 19:19:52.186815Z] Running install step. 12:19:52 INFO - Running pre-action listener: _resource_record_pre_action 12:19:52 INFO - Running main action method: install 12:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:52 INFO - Reading from file tmpfile_stdout 12:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:52 INFO - Reading from file tmpfile_stdout 12:19:52 INFO - Output received: 12:19:52 INFO - Usage: mozinstall [options] installer 12:19:52 INFO - Options: 12:19:52 INFO - -h, --help show this help message and exit 12:19:52 INFO - -d DEST, --destination=DEST 12:19:52 INFO - Directory to install application into. [default: 12:19:52 INFO - "/builds/slave/test"] 12:19:52 INFO - --app=APP Application being installed. [default: firefox] 12:19:52 INFO - mkdir: /builds/slave/test/build/application 12:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:20:09 INFO - Reading from file tmpfile_stdout 12:20:09 INFO - Output received: 12:20:09 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:09 INFO - Running post-action listener: _resource_record_post_action 12:20:09 INFO - [mozharness: 2017-04-10 19:20:09.032594Z] Finished install step (success) 12:20:09 INFO - [mozharness: 2017-04-10 19:20:09.032876Z] Running run-tests step. 12:20:09 INFO - Running pre-action listener: _resource_record_pre_action 12:20:09 INFO - Running main action method: run_tests 12:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:09 INFO - Python 2.7.3 12:20:09 INFO - Return code: 0 12:20:09 INFO - grabbing minidump binary from tooltool 12:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:09 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 0x15ea400>, '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 0x15eb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:09 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 12:20:09 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 12:20:09 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 12:20:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:09 INFO - Return code: 0 12:20:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:09 INFO - ENV: RUST_BACKTRACE is now 1 12:20:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:09 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/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 12:20:09 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/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 12:20:09 INFO - Using env: {'DISPLAY': ':0', 12:20:09 INFO - 'HOME': '/home/cltbld', 12:20:09 INFO - 'LANG': 'en_US.UTF-8', 12:20:09 INFO - 'LANGUAGE': 'en_US:en', 12:20:09 INFO - 'LOGNAME': 'cltbld', 12:20:09 INFO - 'MAIL': '/var/mail/cltbld', 12:20:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:09 INFO - 'MOZ_NO_REMOTE': '1', 12:20:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:09 INFO - 'NO_EM_RESTART': '1', 12:20:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:09 INFO - 'PWD': '/builds/slave/test', 12:20:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:09 INFO - 'RUST_BACKTRACE': '1', 12:20:09 INFO - 'SHELL': '/bin/bash', 12:20:09 INFO - 'SHLVL': '1', 12:20:09 INFO - 'TERM': 'linux', 12:20:09 INFO - 'TMOUT': '86400', 12:20:09 INFO - 'USER': 'cltbld', 12:20:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391', 12:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:09 INFO - '_': '/tools/buildbot/bin/python'} 12:20:09 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/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 12:20:09 INFO - mozversion application_buildid: 20170410181642 12:20:09 INFO - mozversion application_changeset: 8c1af10581c25ff8948370a4503101efb0c163d2 12:20:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:20:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:09 INFO - mozversion application_name: Firefox 12:20:09 INFO - mozversion application_remotingname: firefox-dev 12:20:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:20:09 INFO - mozversion application_vendor: Mozilla 12:20:09 INFO - mozversion application_version: 54.0a2 12:20:09 INFO - mozversion platform_buildid: 20170410181642 12:20:09 INFO - mozversion platform_changeset: 8c1af10581c25ff8948370a4503101efb0c163d2 12:20:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:20:09 INFO - mozversion platform_version: 54.0a2 12:20:09 INFO - using testdate: 1491852009 12:20:09 INFO - actual date: 1491852009 12:20:09 INFO - starting webserver on 'localhost:49259' 12:20:09 INFO - SUITE-START | Running 2 tests 12:20:09 INFO - TEST-START | dromaeo_css 12:20:09 INFO - operating with platform_type : linux_ 12:20:09 INFO - Initialising browser for dromaeo_css test... 12:20:09 INFO - TEST-INFO | started process 11239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfiLFy7/profile http://localhost:49259/getInfo.html) 12:20:13 INFO - PROCESS | 11239 | __metrics Screen width/height:1600/1200 12:20:13 INFO - PROCESS | 11239 | colorDepth:24 12:20:13 INFO - PROCESS | 11239 | Browser inner width/height: 1024/697 12:20:13 INFO - PROCESS | 11239 | __metrics 12:20:14 INFO - PROCESS | 11239 | 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" 12:20:14 INFO - PROCESS | 11239 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:15 INFO - TEST-INFO | 11239: exit 0 12:20:15 INFO - Browser initialized. 12:20:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:15 INFO - TEST-INFO | started process 11332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfiLFy7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:27 INFO - PROCESS | 11332 | RSS: Main: 140132352 12:20:27 INFO - PROCESS | 11332 | 12:23:28 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49259/tests/dromaeo/cssquery-ext.html) 12:23:29 INFO - PROCESS | 11332 | RSS: Main: 286494720 12:23:29 INFO - PROCESS | 11332 | 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | A coding exception was thrown and uncaught in a Task. 12:25:16 INFO - PROCESS | 11332 | 12:25:16 ERROR - PROCESS | 11332 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:16 INFO - PROCESS | 11332 | Full stack: 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | A coding exception was thrown and uncaught in a Task. 12:25:16 INFO - PROCESS | 11332 | 12:25:16 ERROR - PROCESS | 11332 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:16 INFO - PROCESS | 11332 | Full stack: 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | A coding exception was thrown and uncaught in a Task. 12:25:16 INFO - PROCESS | 11332 | 12:25:16 ERROR - PROCESS | 11332 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:16 INFO - PROCESS | 11332 | Full stack: 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | ************************* 12:25:16 INFO - PROCESS | 11332 | A coding exception was thrown and uncaught in a Task. 12:25:16 INFO - PROCESS | 11332 | 12:25:16 ERROR - PROCESS | 11332 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:16 INFO - PROCESS | 11332 | Full stack: 12:25:16 INFO - PROCESS | 11332 | ************************* 12:26:32 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-ext.html (next: http://localhost:49259/tests/dromaeo/cssquery-jquery.html) 12:26:32 INFO - PROCESS | 11332 | RSS: Main: 218869760 12:26:32 INFO - PROCESS | 11332 | 12:29:34 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49259/tests/dromaeo/cssquery-mootools.html) 12:29:35 INFO - PROCESS | 11332 | RSS: Main: 169242624 12:29:35 INFO - PROCESS | 11332 | 12:32:37 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49259/tests/dromaeo/cssquery-prototype.html) 12:32:37 INFO - PROCESS | 11332 | RSS: Main: 170835968 12:32:37 INFO - PROCESS | 11332 | 12:35:40 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49259/tests/dromaeo/cssquery-yui.html) 12:35:41 INFO - PROCESS | 11332 | RSS: Main: 178978816 12:35:41 INFO - PROCESS | 11332 | 12:38:43 INFO - PROCESS | 11332 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-yui.html (next: http://localhost:49259/tests/dromaeo/cssquery-dojo.html) 12:38:44 INFO - PROCESS | 11332 | RSS: Main: 251940864 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | __start_tp_report 12:38:44 INFO - PROCESS | 11332 | _x_x_mozilla_page_load 12:38:44 INFO - PROCESS | 11332 | _x_x_mozilla_page_load_details 12:38:44 INFO - PROCESS | 11332 | |i|pagename|runs| 12:38:44 INFO - PROCESS | 11332 | |0;dojo.html;3397.2186397128658;3422.6748458896404;3427.4858771184317;3443.4834774783794;3463.0995941055335;5769.624974376663;5844.795432159875;5859.414058594139;5861.76552937883;5871.9412805871925;5843.941560584393;5889.793857214999;5899.941000589993;5900.026495628227;5906.675132867691;5274.472552744734;5323.707196104213;5339.172428273624;5362.8123015694455;5434.347878254615;5173.224016397552;5392.487713667196;5404.32445944257;5407.891842163174;5409.43200963897;5188.143956247215;5213.791448342062;5233.110371236899;5319.281896943921;5330.147176451768;5309.495597918191;5343.198520221959;5346.4386239445075;5359;5403.027455058088;5282.81510147143;5322.414534401251;5331.906959073381;5383.488568585978;5400.729963501848;5558.221848941111;5598.216249725042;5717.799877004327;5758.654480731169;5774.538036957076;6270.498360131179;6275.6862156891975;6277.121203031579;6280.434760871498;6285.120083188357;6307.716152773136;6309;6312.021636646327;6325.462335701471;6336.841578960517;5577.107662773937;5614.578906582023;5777.133429985536;5786.7395967181155;5801.50687191585;6262.655553944485;6311.27420346666;6313.08460273267;6319.778807741707;6320.209973753189;6121.602095863755;6177.598456100429;6192.225971753531;6197.411245931629;6214.502839772807;6076.513878889678;6110.511159107261;6136.54971344134;6160.476359509492;6265.624062556261;6223.159873417121;6230.875382492415;6242.001279795211;6244.625322480575;6250.15622890913;6038.215032045894;6065;6069.514438844882;6218.720157592919;6230.59501132425;4230.386593943861;4265.829366825355;4266.893327666833;4278.187144442608;4284.871453856389;3824.8470061197795;3845.1732877430927;3846.4230365445405;3877.2439374322303;3894.3768996960916;6037.54718396122;6046.818595442144;6048.788292409745;6065;6072.392760723892;6268.686565671698;6278.780242691484;6280.340564240781;6299.370062993756;6309.905351419732;5814.505767009851;5842.649441033552;6031.4270144336215;6038.547108966845;6039.758409663565;5250.4749525047955;5265.131253343156;5307.3896501902;5310.893782124336;5313.07021271276;6526.347365263436;6553.213614366211;6562.475001999828;6564.671766411565;6566.573172743756;5952.285725712942;6270.15352927349;6300.21247344082;6309.242890853127;6310.589811662411;6346.90479642815;6426.742930282736;6453.1610890583925;6526.771562995463;6550.475961922939;6168.568200225941;6174.753009879554;6174.845628859314;6177.752889884354;6183.412575805291;6231.096491008869;6271.529635277464;6280.214973128359;6283.49732021428;6293.811185664437;5921.940780592311;5960.195373624505;6043.909341359971;6062.878742425215;6102.847428814315;6015.879682406415;6067.817965461043;6072.423119803611;6077.878442431215;6103.938960610337;5829.650220986754;6058.394160583906;6060.757569697163;6066;6066.878662426815;5974.924513587596;6048.879022419615;6078.848028799315;6123.234595675541;6164.137020817179;6028.246469191351;6029.035354343284;6029.969850150721;6037.335893051673;6057.030875059969 12:38:44 INFO - PROCESS | 11332 | |1;ext.html;785.5365334452675;850.2347886901788;873.4322690251336;917.5183028909826;930.7766136127332;29508;29999.70000299996;32474.18814529635;32521.83739081307;45997;45884.77057614716;46129.7693511532;46163.76918115413;46181;46210.30684539735;8938.642454301837;9059.864102038442;9065.637374505011;9070.818583628323;9072.501012444312;7409.444291678145;7562.546247225184;8986.281097512216;9089.181973622373;10698;10875.184361172904;10916.727081822939;10931.45342732864;10931.56273749053;10937.507812148473;10840.620578279762;10865.728356791064;10874.836877446845;10882.61910833125;10891.400972946485;10588.15294776416;10646.57413703451;10653.573857045709;10666.200034997328;10666.946665266702;39645;39724;39863.800680996406;39917;39984;3773.716971227169;3835.1562656215588;3842.4812650292133;3846.576876543578;3929.3123703352085;29647.70352296471;30061.699383006107;30186.886917915755;30199.547006794917;30722.078337649684;4080.1431699343175;4101.610347017028;4139.461869956916;4348.913021739548;4526.094781043771;250199;253579;375650.3652445215;380598.097009516;381495;45722.77138614286;46563;46573.30140047902;46607.30089048599;46632.76683616628;48024.519754802706;48272.75863620659;48346;48349;48377.27434088491;14779.852201478063;14795.334209960578;14902.329395177243;14925.626859328386;14932.62668433298;12892.290923999082;12897.419616117297;12904.29026403538;12911.096223264281;12917.677058073436;10863.402512861869;11048.502817373237;12641.11512194156;13120.343982800821;13213.471461141638;5351.598630102758;5416.458354164552;5429.457054294618;5553.278073850373;5583.246261754693;996;1014.3305418423805;1017.2218253036433;1018.8369860822232;1021.2442792333619;28607.713922860505;28642.140735777542;28765.424691506054;28889.7111028887;29176;1078.7087486378791;1079.7462596289865;1092.9289596176222;1094.5567045346488;1094.5567045346647;14241.287935603386;15348.155851428055;15358.846411535966;15451.38194472231;15573.14347710864;364157;365449;367669;367821;369183;57787;57921.42078579245;58052.70973645189;58129.70935145297;58157;1491.3363553218715;1520.8859335549878;1521.9847801522285;1534.7314220011453;1542.8534289242505;26839.060632877754;28050.438991219653;28457.573136402556;28515;28565.857170714015;42228;42245.577544224165;42376;42415.15169696527;42503.574964249965;321930;323779;324350;324408;325714;32164.839175804907;32564.185895352806;32755;33083;33155.171120722174;35515.28969420649;42497.78751106225;44070.118597627225;45307.32039019484;47218;30169.849150754108;30299.545506816976;30899.227519312197;33511.66488335085;34202.82898585491;30996.380072398875;31208.53187202239;31302.217444563157;31607.367852642357;31746;36212;36531.81734091419;37190;37353;37493.43759843659;30407.69592304137;30570;30625.23436914095;30763;31061.378772424876;23889.641655374835;25027.624585630867;25300.873495632404;25401.364965876;25409.77903243445 12:38:44 INFO - PROCESS | 11332 | |2;jquery.html;464.282683254372;466.815607834905;478.9976050119751;482.36568911880875;486.4575997762495;19616.215351385945;21449.892750536266;22318;22939.311820645366;23111.306660800205;22041.338759837232;22763.089476420966;22980.310590682264;23160.42098947527;23435.5312893742;6554.836129096787;6626.0723498710095;6718.764843230488;6760.695768690396;6791.830204244884;6657.766978155765;6783.050372947791;7058.223595404502;7368.815779605526;7400.370968467687;7232.927670723304;7525.435592330569;7530.887036694427;7541.358984486298;7552.622368881534;7246.311600397954;7527.0967483902;7596;7610.124835643889;7623.80940476487;7175.174854891702;7225.819354516127;7260.709571617129;7263.78208653736;7268.963655181743;24380.512389752104;24473.755262447325;24711.62932556013;25061.373465663506;25086.749132508623;3361.277325375056;3559.056849934769;3596.964030359689;3604.57683140156;3649.4525821126776;15729.685406291925;16053.357865685359;16237.756433653505;16278;17063.232154552952;2210.6462965925534;2232.48652809853;2235.7540670526228;2294.2199652118193;2306.6078766609717;76344.23655763427;81565;85010.57494712548;94594.23259136536;118571;15645.843541564438;17958.640827183382;18191.545211369557;18319.450416487525;18734.531636708918;31352.37295254082;31649.683503165135;31667.04998850038;31689.20776980594;31803.363932721215;10325.896741032493;10358.482075896174;10363.32638378503;10423.374597524173;10498;8600.655973761104;8629.482231066157;8661.696840610548;8812.823743525094;8865.64537418509;9026.45841249527;9124.771880703036;9187.106061590577;9262.351635385594;9297.302702297355;3530.534828046383;3552.8223588820456;3665.97152236601;3761.2101458693433;4045.19096180765;941.75985123793;966.0918736387773;972.2076507646245;984.9753756156153;1001.7245257554085;19545.218191272474;19878.50303742418;20940.267090652058;21125.049372777954;21175;977.140116697316;978.921686265097;979.3780949097375;992.4640694025146;1040.661784919889;10667.946660266649;10859.565617375216;11410.315381077162;11487.540498380138;11507.539698411969;722080;728333;728789;735540;747651;85449;114053.42973285247;115568;117610;119789.40105299417;1248.806435002576;1287.0925997171971;1300.1938797945145;1340.4638144741987;1358.1240100135556;18498.537536561154;19353.129109190402;19378.321758738377;19390.903045484683;19417.32039378615;52593.21110183274;52620.210696840346;52954.73522632516;53435.732821335645;53528.46471535235;70145.29854701388;70248.6487567559;70388.64805675938;71014.28985710077;71800;12098.213616114925;12981.221126732426;13112.147710398793;13131.277779722206;13485.056046076681;14449.133052016912;14508.492202773274;14520.782188266972;14568.125912445286;14592.927035364755;11746.70633234176;11827.112966527373;11891.643250702493;12785.872141278469;12927.224366538037;10896.564137434414;11103.611373601885;11117.833232501358;11206.719832004264;11560.248583842023;12318.199317044364;12525.37373131358;12676.809847852106;12786.68033299175;12798.68003299925;12567.245965242115;12580.370981450707;12608.873911261137;12638.304893230961;12719.537253215998;12611.68470788201;12631.178973366701;12665.620031399072;12686.175398599062;13096.672583185496 12:38:44 INFO - PROCESS | 11332 | |3;mootools.html;1552.6661767719938;1574.244362705901;1582.1614544291529;1596.5848879291384;1596.76048592711;10937.070349020332;11809.940950295259;11821.940890295547;11825.586104486356;11826.881731182686;11199.384033878134;11502.482388292527;11888.227265227753;11911.940440297787;11915.761684766321;1975.4666240115196;2012.6980952857043;2016.3144530859504;2018.021259689057;2019.0106847644622;2362.055177928825;2384.558856611524;2388.5581167483983;2429.3197904586655;2432.84186527876;2326.8603883766946;2331.335569362732;2339.333290012347;2344.074090734159;2431.416460049593;2277.1574517428658;2317.073170731704;2318.084356679111;2320.8607483550954;2324.31432727345;2342.8008619267384;2357.139644029934;2357.481354102095;2358.363241924688;2360.480694247263;11688.357140357277;11747.765044699143;11775.293482390998;11775.7056073598;11782.351970641612;5607.130894711286;5751.137329400582;5756.079027355603;5756.913646295267;5761.740721667535;3269;3369.696727294531;3537.3809583322814;3538.3630946429635;3547.7693949893433;1336.2116351352652;1368.9247091409968;1400.516821696513;1404.8805851502532;1430.8433999232143;14669.486567970176;15017.774733379008;16524.25640846153;17709.73435398457;17835.73246401305;4761.095391875532;4865.0999565079865;4879.048585525859;4891.2174052152195;4907.386576677915;12782;12815.871841281654;12819.038572107129;12832.486700531874;12838.03714721381;4980.477049909779;5116.386033675983;5707.258056452634;5844.503217226498;5852.297724273115;5470;5473.28847249855;5565.30433695788;5577.6932268724795;5579.69311687861;4085.836566537365;4154.629657205775;4185.037441388497;4189.031155356977;4209.452771139732;1008.4604736465956;1009.9495025248708;1017.1201910347496;1017.7099526635021;1018.5874720738113;1002.3584905660383;1007.4056306778889;1023.1763430438568;1027.4143738069229;1032.9535170917327;6385.7126429309865;6416.133821934072;6432.13166222554;6562.639054852029;6651.534392592569;1026.9229807764448;1059.2426415113232;1074.5486895503907;1099.6096385783092;1116.391566596207;4343.283358245854;4412.161689279091;4419.116176764595;4474.127545128734;4495.707778994421;14753.188574628284;15335.539933802003;15346.386144554315;15356;15364.308606112529;13746.65633359174;14217.289135543182;14827.332770025374;14838;14858.331375088146;10592.841107383396;10762.139028877671;10799.67600971972;10799.784004320027;10810.837837432446;6691.46468282546;6805.115335006418;6898.896516552356;6932.549384290005;6977.092977912839;12469.5012199511;12602.747945041232;12624.368781561068;12751;12786.041046921704;13326.86673133295;13426.99297552707;13446.529371471952;13448.529301474402;13496.32518374097;9562.90437095648;9588.232941364813;9734.318597698093;9762.51187440611;9852.704418867446;10334.741631459274;10397.948010260203;10415.68752937413;10469.110125639407;10511.579536818748;8750.737477875675;8836.160564746338;8843.46939183651;9041.412308199946;9077.727668169966;8903.955480222558;9015.368924175245;9122.90877091247;9157.358984871262;9322.627094916128;8400.663973440995;8408.159184081544;8433.156684331518;8502.277306429023;8575.914240857512;6184.81445556634;6211.782587609412;6215.502759779117;6246.094316324198;6401.0398440232475;6326;6359.07793369968;6386.265579458422;6417.582857114273;6479.676016199265 12:38:44 INFO - PROCESS | 11332 | |4;prototype.html;421.58052737526157;422.68087593866625;437.44007670182157;439.63290652305324;441.8144379360666;5169.844904652867;5305.336832895888;5328.227407025979;5352.384475785276;5360.490753378428;5212.348456442945;5239.292695486109;5263.736813159346;5271.341082364705;5278.419373868871;4304.117655880545;4368.453943257093;4465.240909045454;4471.4187155669715;4491.6855820092605;4441.622462090726;4454.710443821141;4476.507584165739;4479.955200448003;4496.595306422421;4507.301368287905;4524.796384162704;4524.841630542932;4527.4340707411575;4533.687819212192;4397.6042156206095;4481.095534397868;4489.034857505636;4493.258612328962;4527.796249168795;4159.9376009359885;4185.6232939035635;4188.350805625133;4202.571125817206;4202.760185745213;5062.924056139161;5104.259882317043;5177.559907407875;5181.870453238662;5207.947920520822;4932.309476673268;5064.2403639454005;5146.845594632167;5157.7936882524655;5163.397713480877;5508.366537848158;5515.4760297771645;5529.695866727328;5538.584606154514;5582.665040097607;4672.883177920545;4674.929876051862;4687.531246875319;4690.202665546865;4690.390249267573;5445.918311225335;5561;5608.663480191201;5721.511142652917;5820.912686309709;4907.380564413735;5010.949890501121;5032.345795046621;5039.596832253411;5048.964962182744;5082.796688132507;5118.411382690963;5121.180611102281;5134.8973020540125;5150.639455238173;5089.3638295213095;5279.709615971082;5298.470152984671;5336.359636843526;5353.7055461949185;5522;5522.889542209134;5523.613347065747;5523.861903452365;5533;1764.5588602849289;1783.7502749615064;1785.3215778004276;1787.2672204396135;1791.758112654801;1295.1905059337914;1373.7595920713836;1375.9862401376058;1389.2359202438618;1484.7995520604795;5465.890682186334;5477.4248703886315;5516.200150978086;5525.585581081435;5529.474699903502;5614.466625670555;5716.1997320375185;5740.339860916049;5755.798547050833;5762.394948530427;5184.637075404686;5448.891022179534;5453.781848726086;5492.423295553989;5505.449455054462;2982.463156631827;2993.8473687629985;3005.894793682254;3017.400777587838;3017.532282496217;5679.971600142056;5843.211166492469;5871.6770577618645;5878.500327472213;5878.853028674317;5764.751746818744;5810.970945145247;5838.883222335615;5840.29916410025;5853.853653658607;5872.677002764889;5886.970565147147;5917.733701983507;5919.822405327847;5946.464818166386;5428.173137937823;5653.886922261614;5679.716014199356;5707.5433965281845;5740.684262365443;5314.28257185275;5595.5803314752375;5635.774569017193;5641.5204707600315;5643.492085712305;5776.364599893925;5816.36020037804;5822.922759289376;5862.296524417097;5916.852078698067;4760.619150468024;4770.165221086366;4775.116603428377;4789.161896668139;4824.975875120602;5535.916961245504;5689.374168841341;5710.971445142748;5806.274215723035;5827.970860145672;5525.613207075467;5529.502344788988;5536;5548.639338443149;5552.472515111058;5449.482299181572;5463.012001239038;5504.201890725903;5572.665640061609;5585.832425027255;5347.973260133675;5477;5532.75102620375;5538.806141785019;5545.972270138624;5475;5475.6440831345835;5513.338399392099;5578.414266501959;5622.746976385991;5165.251038599457;5398.946010540001;5478.506934375925;5521.2270282159725;5532.253145825262 12:38:44 INFO - PROCESS | 11332 | |5;yui.html;822.3010441125048;871.6252011634995;903.2548147778081;921.1341339141206;932.2215949682018;16641.500754977355;16716.916415417905;16771.748423773653;16810.747838782427;17188.65622687547;17576.736348954742;18085.909570452128;18151;18176.636467270648;18178;867.2195024477973;870.8476016697084;894.3024440936048;897.1880448194395;899.8065415935572;892.4333048514176;897.1566727276339;898.0794685447436;898.2634239923266;898.7393655839799;946.5835032585641;946.8295706772778;948.0945696859517;948.3598570964606;948.4404201521102;933.5938866592986;936.4147407870081;936.7798567336671;936.8735220745215;937.1518775508176;688.8691148681735;689.0663151429841;689.0835189198355;689.1557841643996;689.2969171445098;17277.136143192914;17321.393751218773;17414.1292935354;17747.556311092198;17775.555611109696;16211.432599858948;16278.674426511521;16444.67110657792;16616.83383166165;16730.66538669232;13851.58445246634;14041.22773247471;14273.71452570953;14281.714365712627;14358;3976.642102210786;4074.5925407459313;4101.056756945919;4123.97938010311;4146.108586653853;53001.999999999614;55038.449615503734;62535.37464625386;69359.30640693629;91048.54475727645;12869.163504372185;12992.415341309475;12994.805077923838;13030;13119.278439685719;21052.26317078895;21196.89401553013;21260.893695531424;21380.251691190733;22000.119995200013;8596.226339629464;8751.56242187888;8938.597763100675;8994.86507702385;8999.415038022507;4531.342955271533;4675.555822196886;4700.670953033323;4797.088553174955;4797.712137271705;3987.222491614107;4085.816138273785;4085.8774236772942;4092.7339722917914;4098.549159592442;661.2593894837717;662.652107643491;665.9367360100782;674.5109795398297;685.4310921934782;772.6600295869799;773.7098588029489;796.9880451793227;798.9360851131895;814.7189219719187;11366.829497557543;11607.187496875138;11794.174407791545;12171.208871423329;12192.634220973385;792.1286584756722;797.7247502774617;801.7594721583619;821.2731732416735;825.9917400825915;5406.783728650888;5432.972835135878;5488.7530061147345;5518.668879867221;5542.861428464321;84207.5789621048;87371.56314218516;87384.56307718548;87729;89444.5527772357;71963.64018179875;72797;74874.25125748782;76640;77658;39677.60322396739;60757;63659.681701591195;63710;63845.68077159584;11520.654380368602;11923.642290731292;12015.519379224734;12208.938955305166;12238.694032649255;42788.78605606952;43024.354634679876;44211.55788442074;44233.557664422944;45096.77451612852;50604;51297.80096906448;51686.22470662868;51728.74135629298;51819.481805181465;12721.87278127244;12937.223766574036;13107.279099649611;13220.735585288432;13330.933345333211;15308.23458827032;15439.459618913284;15511.146886921328;15699.21503924822;15731.842681573038;14574.10191980084;14656.633584160481;14935.775963360775;14998.550043498712;15484.621811960711;13809.378577963815;13852.376643051288;14152.646183845487;14303.21332326732;14367.497137600134;13633.863661363259;13801.293309915152;13805.24071176095;13831.308434578432;13899.652508687364;10220.386776793417;10307.639232626821;10430.68707938763;10773.946130269298;10789.946050269698;11518.481668324777;12116.757664846476;12142.939285303517;12425.068119891224;12438.502459901865 12:38:44 INFO - PROCESS | 11332 | __end_tp_report 12:38:44 INFO - PROCESS | 11332 | __start_cc_report 12:38:44 INFO - PROCESS | 11332 | _x_x_mozilla_cycle_collect,1451 12:38:44 INFO - PROCESS | 11332 | __end_cc_report 12:38:44 INFO - PROCESS | 11332 | __startTimestamp1491853124000__endTimestamp 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | ------- Summary: start ------- 12:38:44 INFO - PROCESS | 11332 | Number of tests: 6 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#0] dojo.html Cycles:165 Average:5770.34 Median:6043.91 stddev:713.75 (11.8%) stddev-sans-first:691.24 12:38:44 INFO - PROCESS | 11332 | Values: 3397.2 3422.7 3427.5 3443.5 3463.1 5769.6 5844.8 5859.4 5861.8 5871.9 5843.9 5889.8 5899.9 5900.0 5906.7 5274.5 5323.7 5339.2 5362.8 5434.3 5173.2 5392.5 5404.3 5407.9 5409.4 5188.1 5213.8 5233.1 5319.3 5330.1 5309.5 5343.2 5346.4 5359.0 5403.0 5282.8 5322.4 5331.9 5383.5 5400.7 5558.2 5598.2 5717.8 5758.7 5774.5 6270.5 6275.7 6277.1 6280.4 6285.1 6307.7 6309.0 6312.0 6325.5 6336.8 5577.1 5614.6 5777.1 5786.7 5801.5 6262.7 6311.3 6313.1 6319.8 6320.2 6121.6 6177.6 6192.2 6197.4 6214.5 6076.5 6110.5 6136.5 6160.5 6265.6 6223.2 6230.9 6242.0 6244.6 6250.2 6038.2 6065.0 6069.5 6218.7 6230.6 4230.4 4265.8 4266.9 4278.2 4284.9 3824.8 3845.2 3846.4 3877.2 3894.4 6037.5 6046.8 6048.8 6065.0 6072.4 6268.7 6278.8 6280.3 6299.4 6309.9 5814.5 5842.6 6031.4 6038.5 6039.8 5250.5 5265.1 5307.4 5310.9 5313.1 6526.3 6553.2 6562.5 6564.7 6566.6 5952.3 6270.2 6300.2 6309.2 6310.6 6346.9 6426.7 6453.2 6526.8 6550.5 6168.6 6174.8 6174.8 6177.8 6183.4 6231.1 6271.5 6280.2 6283.5 6293.8 5921.9 5960.2 6043.9 6062.9 6102.8 6015.9 6067.8 6072.4 6077.9 6103.9 5829.7 6058.4 6060.8 6066.0 6066.9 5974.9 6048.9 6078.8 6123.2 6164.1 6028.2 6029.0 6030.0 6037.3 6057.0 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#1] ext.html Cycles:180 Average:49341.02 Median:324379.00 stddev:89990.99 (27.7%) stddev-sans-first:90169.59 12:38:44 INFO - PROCESS | 11332 | Values: 785.5 850.2 873.4 917.5 930.8 29508.0 29999.7 32474.2 32521.8 45997.0 45884.8 46129.8 46163.8 46181.0 46210.3 8938.6 9059.9 9065.6 9070.8 9072.5 7409.4 7562.5 8986.3 9089.2 10698.0 10875.2 10916.7 10931.5 10931.6 10937.5 10840.6 10865.7 10874.8 10882.6 10891.4 10588.2 10646.6 10653.6 10666.2 10666.9 39645.0 39724.0 39863.8 39917.0 39984.0 3773.7 3835.2 3842.5 3846.6 3929.3 29647.7 30061.7 30186.9 30199.5 30722.1 4080.1 4101.6 4139.5 4348.9 4526.1 250199.0 253579.0 375650.4 380598.1 381495.0 45722.8 46563.0 46573.3 46607.3 46632.8 48024.5 48272.8 48346.0 48349.0 48377.3 14779.9 14795.3 14902.3 14925.6 14932.6 12892.3 12897.4 12904.3 12911.1 12917.7 10863.4 11048.5 12641.1 13120.3 13213.5 5351.6 5416.5 5429.5 5553.3 5583.2 996.0 1014.3 1017.2 1018.8 1021.2 28607.7 28642.1 28765.4 28889.7 29176.0 1078.7 1079.7 1092.9 1094.6 1094.6 14241.3 15348.2 15358.8 15451.4 15573.1 364157.0 365449.0 367669.0 367821.0 369183.0 57787.0 57921.4 58052.7 58129.7 58157.0 1491.3 1520.9 1522.0 1534.7 1542.9 26839.1 28050.4 28457.6 28515.0 28565.9 42228.0 42245.6 42376.0 42415.2 42503.6 321930.0 323779.0 324350.0 324408.0 325714.0 32164.8 32564.2 32755.0 33083.0 33155.2 35515.3 42497.8 44070.1 45307.3 47218.0 30169.8 30299.5 30899.2 33511.7 34202.8 30996.4 31208.5 31302.2 31607.4 31746.0 36212.0 36531.8 37190.0 37353.0 37493.4 30407.7 30570.0 30625.2 30763.0 31061.4 23889.6 25027.6 25300.9 25401.4 25409.8 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#2] jquery.html Cycles:180 Average:39179.62 Median:23297.98 stddev:120041.77 (515.2%) stddev-sans-first:120343.32 12:38:44 INFO - PROCESS | 11332 | Values: 464.3 466.8 479.0 482.4 486.5 19616.2 21449.9 22318.0 22939.3 23111.3 22041.3 22763.1 22980.3 23160.4 23435.5 6554.8 6626.1 6718.8 6760.7 6791.8 6657.8 6783.1 7058.2 7368.8 7400.4 7232.9 7525.4 7530.9 7541.4 7552.6 7246.3 7527.1 7596.0 7610.1 7623.8 7175.2 7225.8 7260.7 7263.8 7269.0 24380.5 24473.8 24711.6 25061.4 25086.7 3361.3 3559.1 3597.0 3604.6 3649.5 15729.7 16053.4 16237.8 16278.0 17063.2 2210.6 2232.5 2235.8 2294.2 2306.6 76344.2 81565.0 85010.6 94594.2 118571.0 15645.8 17958.6 18191.5 18319.5 18734.5 31352.4 31649.7 31667.0 31689.2 31803.4 10325.9 10358.5 10363.3 10423.4 10498.0 8600.7 8629.5 8661.7 8812.8 8865.6 9026.5 9124.8 9187.1 9262.4 9297.3 3530.5 3552.8 3666.0 3761.2 4045.2 941.8 966.1 972.2 985.0 1001.7 19545.2 19878.5 20940.3 21125.0 21175.0 977.1 978.9 979.4 992.5 1040.7 10667.9 10859.6 11410.3 11487.5 11507.5 722080.0 728333.0 728789.0 735540.0 747651.0 85449.0 114053.4 115568.0 117610.0 119789.4 1248.8 1287.1 1300.2 1340.5 1358.1 18498.5 19353.1 19378.3 19390.9 19417.3 52593.2 52620.2 52954.7 53435.7 53528.5 70145.3 70248.6 70388.6 71014.3 71800.0 12098.2 12981.2 13112.1 13131.3 13485.1 14449.1 14508.5 14520.8 14568.1 14592.9 11746.7 11827.1 11891.6 12785.9 12927.2 10896.6 11103.6 11117.8 11206.7 11560.2 12318.2 12525.4 12676.8 12786.7 12798.7 12567.2 12580.4 12608.9 12638.3 12719.5 12611.7 12631.2 12665.6 12686.2 13096.7 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#3] mootools.html Cycles:180 Average:7071.71 Median:2329.10 stddev:4571.09 (196.3%) stddev-sans-first:4565.10 12:38:44 INFO - PROCESS | 11332 | Values: 1552.7 1574.2 1582.2 1596.6 1596.8 10937.1 11809.9 11821.9 11825.6 11826.9 11199.4 11502.5 11888.2 11911.9 11915.8 1975.5 2012.7 2016.3 2018.0 2019.0 2362.1 2384.6 2388.6 2429.3 2432.8 2326.9 2331.3 2339.3 2344.1 2431.4 2277.2 2317.1 2318.1 2320.9 2324.3 2342.8 2357.1 2357.5 2358.4 2360.5 11688.4 11747.8 11775.3 11775.7 11782.4 5607.1 5751.1 5756.1 5756.9 5761.7 3269.0 3369.7 3537.4 3538.4 3547.8 1336.2 1368.9 1400.5 1404.9 1430.8 14669.5 15017.8 16524.3 17709.7 17835.7 4761.1 4865.1 4879.0 4891.2 4907.4 12782.0 12815.9 12819.0 12832.5 12838.0 4980.5 5116.4 5707.3 5844.5 5852.3 5470.0 5473.3 5565.3 5577.7 5579.7 4085.8 4154.6 4185.0 4189.0 4209.5 1008.5 1009.9 1017.1 1017.7 1018.6 1002.4 1007.4 1023.2 1027.4 1033.0 6385.7 6416.1 6432.1 6562.6 6651.5 1026.9 1059.2 1074.5 1099.6 1116.4 4343.3 4412.2 4419.1 4474.1 4495.7 14753.2 15335.5 15346.4 15356.0 15364.3 13746.7 14217.3 14827.3 14838.0 14858.3 10592.8 10762.1 10799.7 10799.8 10810.8 6691.5 6805.1 6898.9 6932.5 6977.1 12469.5 12602.7 12624.4 12751.0 12786.0 13326.9 13427.0 13446.5 13448.5 13496.3 9562.9 9588.2 9734.3 9762.5 9852.7 10334.7 10397.9 10415.7 10469.1 10511.6 8750.7 8836.2 8843.5 9041.4 9077.7 8904.0 9015.4 9122.9 9157.4 9322.6 8400.7 8408.2 8433.2 8502.3 8575.9 6184.8 6211.8 6215.5 6246.1 6401.0 6326.0 6359.1 6386.3 6417.6 6479.7 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#4] prototype.html Cycles:180 Average:4874.77 Median:5350.18 stddev:1265.78 (23.7%) stddev-sans-first:1224.41 12:38:44 INFO - PROCESS | 11332 | Values: 421.6 422.7 437.4 439.6 441.8 5169.8 5305.3 5328.2 5352.4 5360.5 5212.3 5239.3 5263.7 5271.3 5278.4 4304.1 4368.5 4465.2 4471.4 4491.7 4441.6 4454.7 4476.5 4480.0 4496.6 4507.3 4524.8 4524.8 4527.4 4533.7 4397.6 4481.1 4489.0 4493.3 4527.8 4159.9 4185.6 4188.4 4202.6 4202.8 5062.9 5104.3 5177.6 5181.9 5207.9 4932.3 5064.2 5146.8 5157.8 5163.4 5508.4 5515.5 5529.7 5538.6 5582.7 4672.9 4674.9 4687.5 4690.2 4690.4 5445.9 5561.0 5608.7 5721.5 5820.9 4907.4 5010.9 5032.3 5039.6 5049.0 5082.8 5118.4 5121.2 5134.9 5150.6 5089.4 5279.7 5298.5 5336.4 5353.7 5522.0 5522.9 5523.6 5523.9 5533.0 1764.6 1783.8 1785.3 1787.3 1791.8 1295.2 1373.8 1376.0 1389.2 1484.8 5465.9 5477.4 5516.2 5525.6 5529.5 5614.5 5716.2 5740.3 5755.8 5762.4 5184.6 5448.9 5453.8 5492.4 5505.4 2982.5 2993.8 3005.9 3017.4 3017.5 5680.0 5843.2 5871.7 5878.5 5878.9 5764.8 5811.0 5838.9 5840.3 5853.9 5872.7 5887.0 5917.7 5919.8 5946.5 5428.2 5653.9 5679.7 5707.5 5740.7 5314.3 5595.6 5635.8 5641.5 5643.5 5776.4 5816.4 5822.9 5862.3 5916.9 4760.6 4770.2 4775.1 4789.2 4825.0 5535.9 5689.4 5711.0 5806.3 5828.0 5525.6 5529.5 5536.0 5548.6 5552.5 5449.5 5463.0 5504.2 5572.7 5585.8 5348.0 5477.0 5532.8 5538.8 5546.0 5475.0 5475.6 5513.3 5578.4 5622.7 5165.3 5398.9 5478.5 5521.2 5532.3 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - PROCESS | 11332 | [#5] yui.html Cycles:180 Average:18104.73 Median:23467.45 stddev:22290.79 (95.0%) stddev-sans-first:22315.55 12:38:44 INFO - PROCESS | 11332 | Values: 822.3 871.6 903.3 921.1 932.2 16641.5 16716.9 16771.7 16810.7 17188.7 17576.7 18085.9 18151.0 18176.6 18178.0 867.2 870.8 894.3 897.2 899.8 892.4 897.2 898.1 898.3 898.7 946.6 946.8 948.1 948.4 948.4 933.6 936.4 936.8 936.9 937.2 688.9 689.1 689.1 689.2 689.3 17277.1 17321.4 17414.1 17747.6 17775.6 16211.4 16278.7 16444.7 16616.8 16730.7 13851.6 14041.2 14273.7 14281.7 14358.0 3976.6 4074.6 4101.1 4124.0 4146.1 53002.0 55038.4 62535.4 69359.3 91048.5 12869.2 12992.4 12994.8 13030.0 13119.3 21052.3 21196.9 21260.9 21380.3 22000.1 8596.2 8751.6 8938.6 8994.9 8999.4 4531.3 4675.6 4700.7 4797.1 4797.7 3987.2 4085.8 4085.9 4092.7 4098.5 661.3 662.7 665.9 674.5 685.4 772.7 773.7 797.0 798.9 814.7 11366.8 11607.2 11794.2 12171.2 12192.6 792.1 797.7 801.8 821.3 826.0 5406.8 5433.0 5488.8 5518.7 5542.9 84207.6 87371.6 87384.6 87729.0 89444.6 71963.6 72797.0 74874.3 76640.0 77658.0 39677.6 60757.0 63659.7 63710.0 63845.7 11520.7 11923.6 12015.5 12208.9 12238.7 42788.8 43024.4 44211.6 44233.6 45096.8 50604.0 51297.8 51686.2 51728.7 51819.5 12721.9 12937.2 13107.3 13220.7 13330.9 15308.2 15439.5 15511.1 15699.2 15731.8 14574.1 14656.6 14935.8 14998.6 15484.6 13809.4 13852.4 14152.6 14303.2 14367.5 13633.9 13801.3 13805.2 13831.3 13899.7 10220.4 10307.6 10430.7 10773.9 10789.9 11518.5 12116.8 12142.9 12425.1 12438.5 12:38:44 INFO - PROCESS | 11332 | -------- Summary: end -------- 12:38:44 INFO - PROCESS | 11332 | 12:38:44 INFO - TEST-INFO | 11332: exit 0 12:38:44 INFO - TEST-OK | dromaeo_css | took 1115474ms 12:38:44 INFO - TEST-START | kraken 12:38:44 INFO - operating with platform_type : linux_ 12:38:44 INFO - Initialising browser for kraken test... 12:38:44 INFO - TEST-INFO | started process 11653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhgSD_/profile http://localhost:49259/getInfo.html) 12:38:48 INFO - PROCESS | 11653 | __metrics Screen width/height:1600/1200 12:38:48 INFO - PROCESS | 11653 | colorDepth:24 12:38:48 INFO - PROCESS | 11653 | Browser inner width/height: 1024/697 12:38:48 INFO - PROCESS | 11653 | __metrics 12:38:49 INFO - PROCESS | 11653 | 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" 12:38:49 INFO - PROCESS | 11653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:51 INFO - TEST-INFO | 11653: exit 0 12:38:51 INFO - Browser initialized. 12:38:51 INFO - Running cycle 1/1 for kraken test... 12:38:51 INFO - TEST-INFO | started process 11746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhgSD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:02 INFO - PROCESS | 11746 | RSS: Main: 139657216 12:39:02 INFO - PROCESS | 11746 | 12:39:05 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:06 INFO - PROCESS | 11746 | RSS: Main: 182845440 12:39:06 INFO - PROCESS | 11746 | 12:39:08 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-dft) 12:39:09 INFO - PROCESS | 11746 | RSS: Main: 173531136 12:39:09 INFO - PROCESS | 11746 | 12:39:12 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-fft) 12:39:12 INFO - PROCESS | 11746 | RSS: Main: 265904128 12:39:12 INFO - PROCESS | 11746 | 12:39:14 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator) 12:39:15 INFO - PROCESS | 11746 | RSS: Main: 171900928 12:39:15 INFO - PROCESS | 11746 | 12:39:17 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:18 INFO - PROCESS | 11746 | RSS: Main: 174743552 12:39:18 INFO - PROCESS | 11746 | 12:39:21 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:21 INFO - PROCESS | 11746 | RSS: Main: 212865024 12:39:21 INFO - PROCESS | 11746 | 12:39:25 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:25 INFO - PROCESS | 11746 | RSS: Main: 211496960 12:39:25 INFO - PROCESS | 11746 | 12:39:28 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial) 12:39:29 INFO - PROCESS | 11746 | RSS: Main: 210198528 12:39:29 INFO - PROCESS | 11746 | 12:39:30 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:31 INFO - PROCESS | 11746 | RSS: Main: 172756992 12:39:31 INFO - PROCESS | 11746 | 12:39:32 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:33 INFO - PROCESS | 11746 | RSS: Main: 178782208 12:39:33 INFO - PROCESS | 11746 | 12:39:35 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:35 INFO - PROCESS | 11746 | RSS: Main: 189595648 12:39:35 INFO - PROCESS | 11746 | 12:39:38 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:39 INFO - PROCESS | 11746 | RSS: Main: 198832128 12:39:39 INFO - PROCESS | 11746 | 12:39:41 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:42 INFO - PROCESS | 11746 | RSS: Main: 195194880 12:39:42 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49259/tests/kraken/driver.html?testName=ai-astar) 12:39:44 INFO - PROCESS | 11746 | RSS: Main: 247058432 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | __start_tp_report 12:39:44 INFO - PROCESS | 11746 | _x_x_mozilla_page_load 12:39:44 INFO - PROCESS | 11746 | _x_x_mozilla_page_load_details 12:39:44 INFO - PROCESS | 11746 | |i|pagename|runs| 12:39:44 INFO - PROCESS | 11746 | |0;ai-astar;104;113;114;114;112;114;112;112;112;112 12:39:44 INFO - PROCESS | 11746 | |1;audio-beat-detection;143;115;120;154;117;115;120;114;133;115 12:39:44 INFO - PROCESS | 11746 | |2;audio-dft;162;170;160;165;162;161;161;162;161;163 12:39:44 INFO - PROCESS | 11746 | |3;audio-fft;74;75;75;113;74;76;75;76;91;76 12:39:44 INFO - PROCESS | 11746 | |4;audio-oscillator;83;83;106;83;83;83;96;83;83;104 12:39:44 INFO - PROCESS | 11746 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;112;113 12:39:44 INFO - PROCESS | 11746 | |6;imaging-darkroom;147;149;146;146;146;146;146;146;145;146 12:39:44 INFO - PROCESS | 11746 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;94;94 12:39:44 INFO - PROCESS | 11746 | |8;json-parse-financial;54;54;55;54;55;57;55;55;55;53 12:39:44 INFO - PROCESS | 11746 | |9;json-stringify-tinderbox;53;53;55;52;53;53;52;52;53;53 12:39:44 INFO - PROCESS | 11746 | |10;stanford-crypto-aes;85;78;75;79;77;76;80;84;79;79 12:39:44 INFO - PROCESS | 11746 | |11;stanford-crypto-ccm;124;142;122;120;120;121;125;120;166;131 12:39:44 INFO - PROCESS | 11746 | |12;stanford-crypto-pbkdf2;158;157;161;167;161;159;160;159;175;160 12:39:44 INFO - PROCESS | 11746 | |13;stanford-crypto-sha256-iterative;60;65;60;61;60;66;60;59;58;58 12:39:44 INFO - PROCESS | 11746 | __end_tp_report 12:39:44 INFO - PROCESS | 11746 | __start_cc_report 12:39:44 INFO - PROCESS | 11746 | _x_x_mozilla_cycle_collect,1682 12:39:44 INFO - PROCESS | 11746 | __end_cc_report 12:39:44 INFO - PROCESS | 11746 | __startTimestamp1491853184410__endTimestamp 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | ------- Summary: start ------- 12:39:44 INFO - PROCESS | 11746 | Number of tests: 14 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.92 (2.6%) stddev-sans-first:0.97 12:39:44 INFO - PROCESS | 11746 | Values: 104.0 113.0 114.0 114.0 112.0 114.0 112.0 112.0 112.0 112.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:120.00 stddev:13.99 (11.7%) stddev-sans-first:13.16 12:39:44 INFO - PROCESS | 11746 | Values: 143.0 115.0 120.0 154.0 117.0 115.0 120.0 114.0 133.0 115.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.91 (1.8%) stddev-sans-first:3.07 12:39:44 INFO - PROCESS | 11746 | Values: 162.0 170.0 160.0 165.0 162.0 161.0 161.0 162.0 161.0 163.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.50 stddev:12.48 (16.5%) stddev-sans-first:13.02 12:39:44 INFO - PROCESS | 11746 | Values: 74.0 75.0 75.0 113.0 74.0 76.0 75.0 76.0 91.0 76.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:9.51 (11.5%) stddev-sans-first:9.86 12:39:44 INFO - PROCESS | 11746 | Values: 83.0 83.0 106.0 83.0 83.0 83.0 96.0 83.0 83.0 104.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:39:44 INFO - PROCESS | 11746 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 12:39:44 INFO - PROCESS | 11746 | Values: 147.0 149.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:39:44 INFO - PROCESS | 11746 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 12:39:44 INFO - PROCESS | 11746 | Values: 54.0 54.0 55.0 54.0 55.0 57.0 55.0 55.0 55.0 53.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 12:39:44 INFO - PROCESS | 11746 | Values: 53.0 53.0 55.0 52.0 53.0 53.0 52.0 52.0 53.0 53.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:3.19 (4.0%) stddev-sans-first:2.60 12:39:44 INFO - PROCESS | 11746 | Values: 85.0 78.0 75.0 79.0 77.0 76.0 80.0 84.0 79.0 79.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:124.50 stddev:14.68 (11.8%) stddev-sans-first:15.45 12:39:44 INFO - PROCESS | 11746 | Values: 124.0 142.0 122.0 120.0 120.0 121.0 125.0 120.0 166.0 131.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:160.50 stddev:5.40 (3.4%) stddev-sans-first:5.56 12:39:44 INFO - PROCESS | 11746 | Values: 158.0 157.0 161.0 167.0 161.0 159.0 160.0 159.0 175.0 160.0 12:39:44 INFO - PROCESS | 11746 | 12:39:44 INFO - PROCESS | 11746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:60.00 stddev:2.71 (4.5%) stddev-sans-first:2.86 12:39:44 INFO - PROCESS | 11746 | Values: 60.0 65.0 60.0 61.0 60.0 66.0 60.0 59.0 58.0 58.0 12:39:44 INFO - PROCESS | 11746 | -------- Summary: end -------- 12:39:44 INFO - PROCESS | 11746 | 12:39:45 INFO - TEST-INFO | 11746: exit 0 12:39:45 INFO - TEST-OK | kraken | took 60692ms 12:39:45 INFO - SUITE-END | took 1176s 12:39:45 INFO - Completed test suite (00:19:36) 12:39:45 INFO - javascript benchmark 12:39:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7844.920080282897, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.2186397128658, 3422.6748458896404, 3427.4858771184317, 3443.4834774783794, 3463.0995941055335, 5769.624974376663, 5844.795432159875, 5859.414058594139, 5861.76552937883, 5871.9412805871925, 5843.941560584393, 5889.793857214999, 5899.941000589993, 5900.026495628227, 5906.675132867691, 5274.472552744734, 5323.707196104213, 5339.172428273624, 5362.8123015694455, 5434.347878254615, 5173.224016397552, 5392.487713667196, 5404.32445944257, 5407.891842163174, 5409.43200963897, 5188.143956247215, 5213.791448342062, 5233.110371236899, 5319.281896943921, 5330.147176451768, 5309.495597918191, 5343.198520221959, 5346.4386239445075, 5359.0, 5403.027455058088, 5282.81510147143, 5322.414534401251, 5331.906959073381, 5383.488568585978, 5400.729963501848, 5558.221848941111, 5598.216249725042, 5717.799877004327, 5758.654480731169, 5774.538036957076, 6270.498360131179, 6275.6862156891975, 6277.121203031579, 6280.434760871498, 6285.120083188357, 6307.716152773136, 6309.0, 6312.021636646327, 6325.462335701471, 6336.841578960517, 5577.107662773937, 5614.578906582023, 5777.133429985536, 5786.7395967181155, 5801.50687191585, 6262.655553944485, 6311.27420346666, 6313.08460273267, 6319.778807741707, 6320.209973753189, 6121.602095863755, 6177.598456100429, 6192.225971753531, 6197.411245931629, 6214.502839772807, 6076.513878889678, 6110.511159107261, 6136.54971344134, 6160.476359509492, 6265.624062556261, 6223.159873417121, 6230.875382492415, 6242.001279795211, 6244.625322480575, 6250.15622890913, 6038.215032045894, 6065.0, 6069.514438844882, 6218.720157592919, 6230.59501132425, 4230.386593943861, 4265.829366825355, 4266.893327666833, 4278.187144442608, 4284.871453856389, 3824.8470061197795, 3845.1732877430927, 3846.4230365445405, 3877.2439374322303, 3894.3768996960916, 6037.54718396122, 6046.818595442144, 6048.788292409745, 6065.0, 6072.392760723892, 6268.686565671698, 6278.780242691484, 6280.340564240781, 6299.370062993756, 6309.905351419732, 5814.505767009851, 5842.649441033552, 6031.4270144336215, 6038.547108966845, 6039.758409663565, 5250.4749525047955, 5265.131253343156, 5307.3896501902, 5310.893782124336, 5313.07021271276, 6526.347365263436, 6553.213614366211, 6562.475001999828, 6564.671766411565, 6566.573172743756, 5952.285725712942, 6270.15352927349, 6300.21247344082, 6309.242890853127, 6310.589811662411, 6346.90479642815, 6426.742930282736, 6453.1610890583925, 6526.771562995463, 6550.475961922939, 6168.568200225941, 6174.753009879554, 6174.845628859314, 6177.752889884354, 6183.412575805291, 6231.096491008869, 6271.529635277464, 6280.214973128359, 6283.49732021428, 6293.811185664437, 5921.940780592311, 5960.195373624505, 6043.909341359971, 6062.878742425215, 6102.847428814315, 6015.879682406415, 6067.817965461043, 6072.423119803611, 6077.878442431215, 6103.938960610337, 5829.650220986754, 6058.394160583906, 6060.757569697163, 6066.0, 6066.878662426815, 5974.924513587596, 6048.879022419615, 6078.848028799315, 6123.234595675541, 6164.137020817179, 6028.246469191351, 6029.035354343284, 6029.969850150721, 6037.335893051673, 6057.030875059969], "value": 5717.626013177274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.5365334452675, 850.2347886901788, 873.4322690251336, 917.5183028909826, 930.7766136127332, 29508.0, 29999.70000299996, 32474.18814529635, 32521.83739081307, 45997.0, 45884.77057614716, 46129.7693511532, 46163.76918115413, 46181.0, 46210.30684539735, 8938.642454301837, 9059.864102038442, 9065.637374505011, 9070.818583628323, 9072.501012444312, 7409.444291678145, 7562.546247225184, 8986.281097512216, 9089.181973622373, 10698.0, 10875.184361172904, 10916.727081822939, 10931.45342732864, 10931.56273749053, 10937.507812148473, 10840.620578279762, 10865.728356791064, 10874.836877446845, 10882.61910833125, 10891.400972946485, 10588.15294776416, 10646.57413703451, 10653.573857045709, 10666.200034997328, 10666.946665266702, 39645.0, 39724.0, 39863.800680996406, 39917.0, 39984.0, 3773.716971227169, 3835.1562656215588, 3842.4812650292133, 3846.576876543578, 3929.3123703352085, 29647.70352296471, 30061.699383006107, 30186.886917915755, 30199.547006794917, 30722.078337649684, 4080.1431699343175, 4101.610347017028, 4139.461869956916, 4348.913021739548, 4526.094781043771, 250199.0, 253579.0, 375650.3652445215, 380598.097009516, 381495.0, 45722.77138614286, 46563.0, 46573.30140047902, 46607.30089048599, 46632.76683616628, 48024.519754802706, 48272.75863620659, 48346.0, 48349.0, 48377.27434088491, 14779.852201478063, 14795.334209960578, 14902.329395177243, 14925.626859328386, 14932.62668433298, 12892.290923999082, 12897.419616117297, 12904.29026403538, 12911.096223264281, 12917.677058073436, 10863.402512861869, 11048.502817373237, 12641.11512194156, 13120.343982800821, 13213.471461141638, 5351.598630102758, 5416.458354164552, 5429.457054294618, 5553.278073850373, 5583.246261754693, 996.0, 1014.3305418423805, 1017.2218253036433, 1018.8369860822232, 1021.2442792333619, 28607.713922860505, 28642.140735777542, 28765.424691506054, 28889.7111028887, 29176.0, 1078.7087486378791, 1079.7462596289865, 1092.9289596176222, 1094.5567045346488, 1094.5567045346647, 14241.287935603386, 15348.155851428055, 15358.846411535966, 15451.38194472231, 15573.14347710864, 364157.0, 365449.0, 367669.0, 367821.0, 369183.0, 57787.0, 57921.42078579245, 58052.70973645189, 58129.70935145297, 58157.0, 1491.3363553218715, 1520.8859335549878, 1521.9847801522285, 1534.7314220011453, 1542.8534289242505, 26839.060632877754, 28050.438991219653, 28457.573136402556, 28515.0, 28565.857170714015, 42228.0, 42245.577544224165, 42376.0, 42415.15169696527, 42503.574964249965, 321930.0, 323779.0, 324350.0, 324408.0, 325714.0, 32164.839175804907, 32564.185895352806, 32755.0, 33083.0, 33155.171120722174, 35515.28969420649, 42497.78751106225, 44070.118597627225, 45307.32039019484, 47218.0, 30169.849150754108, 30299.545506816976, 30899.227519312197, 33511.66488335085, 34202.82898585491, 30996.380072398875, 31208.53187202239, 31302.217444563157, 31607.367852642357, 31746.0, 36212.0, 36531.81734091419, 37190.0, 37353.0, 37493.43759843659, 30407.69592304137, 30570.0, 30625.23436914095, 30763.0, 31061.378772424876, 23889.641655374835, 25027.624585630867, 25300.873495632404, 25401.364965876, 25409.77903243445], "value": 18696.127813728443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.282683254372, 466.815607834905, 478.9976050119751, 482.36568911880875, 486.4575997762495, 19616.215351385945, 21449.892750536266, 22318.0, 22939.311820645366, 23111.306660800205, 22041.338759837232, 22763.089476420966, 22980.310590682264, 23160.42098947527, 23435.5312893742, 6554.836129096787, 6626.0723498710095, 6718.764843230488, 6760.695768690396, 6791.830204244884, 6657.766978155765, 6783.050372947791, 7058.223595404502, 7368.815779605526, 7400.370968467687, 7232.927670723304, 7525.435592330569, 7530.887036694427, 7541.358984486298, 7552.622368881534, 7246.311600397954, 7527.0967483902, 7596.0, 7610.124835643889, 7623.80940476487, 7175.174854891702, 7225.819354516127, 7260.709571617129, 7263.78208653736, 7268.963655181743, 24380.512389752104, 24473.755262447325, 24711.62932556013, 25061.373465663506, 25086.749132508623, 3361.277325375056, 3559.056849934769, 3596.964030359689, 3604.57683140156, 3649.4525821126776, 15729.685406291925, 16053.357865685359, 16237.756433653505, 16278.0, 17063.232154552952, 2210.6462965925534, 2232.48652809853, 2235.7540670526228, 2294.2199652118193, 2306.6078766609717, 76344.23655763427, 81565.0, 85010.57494712548, 94594.23259136536, 118571.0, 15645.843541564438, 17958.640827183382, 18191.545211369557, 18319.450416487525, 18734.531636708918, 31352.37295254082, 31649.683503165135, 31667.04998850038, 31689.20776980594, 31803.363932721215, 10325.896741032493, 10358.482075896174, 10363.32638378503, 10423.374597524173, 10498.0, 8600.655973761104, 8629.482231066157, 8661.696840610548, 8812.823743525094, 8865.64537418509, 9026.45841249527, 9124.771880703036, 9187.106061590577, 9262.351635385594, 9297.302702297355, 3530.534828046383, 3552.8223588820456, 3665.97152236601, 3761.2101458693433, 4045.19096180765, 941.75985123793, 966.0918736387773, 972.2076507646245, 984.9753756156153, 1001.7245257554085, 19545.218191272474, 19878.50303742418, 20940.267090652058, 21125.049372777954, 21175.0, 977.140116697316, 978.921686265097, 979.3780949097375, 992.4640694025146, 1040.661784919889, 10667.946660266649, 10859.565617375216, 11410.315381077162, 11487.540498380138, 11507.539698411969, 722080.0, 728333.0, 728789.0, 735540.0, 747651.0, 85449.0, 114053.42973285247, 115568.0, 117610.0, 119789.40105299417, 1248.806435002576, 1287.0925997171971, 1300.1938797945145, 1340.4638144741987, 1358.1240100135556, 18498.537536561154, 19353.129109190402, 19378.321758738377, 19390.903045484683, 19417.32039378615, 52593.21110183274, 52620.210696840346, 52954.73522632516, 53435.732821335645, 53528.46471535235, 70145.29854701388, 70248.6487567559, 70388.64805675938, 71014.28985710077, 71800.0, 12098.213616114925, 12981.221126732426, 13112.147710398793, 13131.277779722206, 13485.056046076681, 14449.133052016912, 14508.492202773274, 14520.782188266972, 14568.125912445286, 14592.927035364755, 11746.70633234176, 11827.112966527373, 11891.643250702493, 12785.872141278469, 12927.224366538037, 10896.564137434414, 11103.611373601885, 11117.833232501358, 11206.719832004264, 11560.248583842023, 12318.199317044364, 12525.37373131358, 12676.809847852106, 12786.68033299175, 12798.68003299925, 12567.245965242115, 12580.370981450707, 12608.873911261137, 12638.304893230961, 12719.537253215998, 12611.68470788201, 12631.178973366701, 12665.620031399072, 12686.175398599062, 13096.672583185496], "value": 11597.82309989867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1552.6661767719938, 1574.244362705901, 1582.1614544291529, 1596.5848879291384, 1596.76048592711, 10937.070349020332, 11809.940950295259, 11821.940890295547, 11825.586104486356, 11826.881731182686, 11199.384033878134, 11502.482388292527, 11888.227265227753, 11911.940440297787, 11915.761684766321, 1975.4666240115196, 2012.6980952857043, 2016.3144530859504, 2018.021259689057, 2019.0106847644622, 2362.055177928825, 2384.558856611524, 2388.5581167483983, 2429.3197904586655, 2432.84186527876, 2326.8603883766946, 2331.335569362732, 2339.333290012347, 2344.074090734159, 2431.416460049593, 2277.1574517428658, 2317.073170731704, 2318.084356679111, 2320.8607483550954, 2324.31432727345, 2342.8008619267384, 2357.139644029934, 2357.481354102095, 2358.363241924688, 2360.480694247263, 11688.357140357277, 11747.765044699143, 11775.293482390998, 11775.7056073598, 11782.351970641612, 5607.130894711286, 5751.137329400582, 5756.079027355603, 5756.913646295267, 5761.740721667535, 3269.0, 3369.696727294531, 3537.3809583322814, 3538.3630946429635, 3547.7693949893433, 1336.2116351352652, 1368.9247091409968, 1400.516821696513, 1404.8805851502532, 1430.8433999232143, 14669.486567970176, 15017.774733379008, 16524.25640846153, 17709.73435398457, 17835.73246401305, 4761.095391875532, 4865.0999565079865, 4879.048585525859, 4891.2174052152195, 4907.386576677915, 12782.0, 12815.871841281654, 12819.038572107129, 12832.486700531874, 12838.03714721381, 4980.477049909779, 5116.386033675983, 5707.258056452634, 5844.503217226498, 5852.297724273115, 5470.0, 5473.28847249855, 5565.30433695788, 5577.6932268724795, 5579.69311687861, 4085.836566537365, 4154.629657205775, 4185.037441388497, 4189.031155356977, 4209.452771139732, 1008.4604736465956, 1009.9495025248708, 1017.1201910347496, 1017.7099526635021, 1018.5874720738113, 1002.3584905660383, 1007.4056306778889, 1023.1763430438568, 1027.4143738069229, 1032.9535170917327, 6385.7126429309865, 6416.133821934072, 6432.13166222554, 6562.639054852029, 6651.534392592569, 1026.9229807764448, 1059.2426415113232, 1074.5486895503907, 1099.6096385783092, 1116.391566596207, 4343.283358245854, 4412.161689279091, 4419.116176764595, 4474.127545128734, 4495.707778994421, 14753.188574628284, 15335.539933802003, 15346.386144554315, 15356.0, 15364.308606112529, 13746.65633359174, 14217.289135543182, 14827.332770025374, 14838.0, 14858.331375088146, 10592.841107383396, 10762.139028877671, 10799.67600971972, 10799.784004320027, 10810.837837432446, 6691.46468282546, 6805.115335006418, 6898.896516552356, 6932.549384290005, 6977.092977912839, 12469.5012199511, 12602.747945041232, 12624.368781561068, 12751.0, 12786.041046921704, 13326.86673133295, 13426.99297552707, 13446.529371471952, 13448.529301474402, 13496.32518374097, 9562.90437095648, 9588.232941364813, 9734.318597698093, 9762.51187440611, 9852.704418867446, 10334.741631459274, 10397.948010260203, 10415.68752937413, 10469.110125639407, 10511.579536818748, 8750.737477875675, 8836.160564746338, 8843.46939183651, 9041.412308199946, 9077.727668169966, 8903.955480222558, 9015.368924175245, 9122.90877091247, 9157.358984871262, 9322.627094916128, 8400.663973440995, 8408.159184081544, 8433.156684331518, 8502.277306429023, 8575.914240857512, 6184.81445556634, 6211.782587609412, 6215.502759779117, 6246.094316324198, 6401.0398440232475, 6326.0, 6359.07793369968, 6386.265579458422, 6417.582857114273, 6479.676016199265], "value": 5320.374548423101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.58052737526157, 422.68087593866625, 437.44007670182157, 439.63290652305324, 441.8144379360666, 5169.844904652867, 5305.336832895888, 5328.227407025979, 5352.384475785276, 5360.490753378428, 5212.348456442945, 5239.292695486109, 5263.736813159346, 5271.341082364705, 5278.419373868871, 4304.117655880545, 4368.453943257093, 4465.240909045454, 4471.4187155669715, 4491.6855820092605, 4441.622462090726, 4454.710443821141, 4476.507584165739, 4479.955200448003, 4496.595306422421, 4507.301368287905, 4524.796384162704, 4524.841630542932, 4527.4340707411575, 4533.687819212192, 4397.6042156206095, 4481.095534397868, 4489.034857505636, 4493.258612328962, 4527.796249168795, 4159.9376009359885, 4185.6232939035635, 4188.350805625133, 4202.571125817206, 4202.760185745213, 5062.924056139161, 5104.259882317043, 5177.559907407875, 5181.870453238662, 5207.947920520822, 4932.309476673268, 5064.2403639454005, 5146.845594632167, 5157.7936882524655, 5163.397713480877, 5508.366537848158, 5515.4760297771645, 5529.695866727328, 5538.584606154514, 5582.665040097607, 4672.883177920545, 4674.929876051862, 4687.531246875319, 4690.202665546865, 4690.390249267573, 5445.918311225335, 5561.0, 5608.663480191201, 5721.511142652917, 5820.912686309709, 4907.380564413735, 5010.949890501121, 5032.345795046621, 5039.596832253411, 5048.964962182744, 5082.796688132507, 5118.411382690963, 5121.180611102281, 5134.8973020540125, 5150.639455238173, 5089.3638295213095, 5279.709615971082, 5298.470152984671, 5336.359636843526, 5353.7055461949185, 5522.0, 5522.889542209134, 5523.613347065747, 5523.861903452365, 5533.0, 1764.5588602849289, 1783.7502749615064, 1785.3215778004276, 1787.2672204396135, 1791.758112654801, 1295.1905059337914, 1373.7595920713836, 1375.9862401376058, 1389.2359202438618, 1484.7995520604795, 5465.890682186334, 5477.4248703886315, 5516.200150978086, 5525.585581081435, 5529.474699903502, 5614.466625670555, 5716.1997320375185, 5740.339860916049, 5755.798547050833, 5762.394948530427, 5184.637075404686, 5448.891022179534, 5453.781848726086, 5492.423295553989, 5505.449455054462, 2982.463156631827, 2993.8473687629985, 3005.894793682254, 3017.400777587838, 3017.532282496217, 5679.971600142056, 5843.211166492469, 5871.6770577618645, 5878.500327472213, 5878.853028674317, 5764.751746818744, 5810.970945145247, 5838.883222335615, 5840.29916410025, 5853.853653658607, 5872.677002764889, 5886.970565147147, 5917.733701983507, 5919.822405327847, 5946.464818166386, 5428.173137937823, 5653.886922261614, 5679.716014199356, 5707.5433965281845, 5740.684262365443, 5314.28257185275, 5595.5803314752375, 5635.774569017193, 5641.5204707600315, 5643.492085712305, 5776.364599893925, 5816.36020037804, 5822.922759289376, 5862.296524417097, 5916.852078698067, 4760.619150468024, 4770.165221086366, 4775.116603428377, 4789.161896668139, 4824.975875120602, 5535.916961245504, 5689.374168841341, 5710.971445142748, 5806.274215723035, 5827.970860145672, 5525.613207075467, 5529.502344788988, 5536.0, 5548.639338443149, 5552.472515111058, 5449.482299181572, 5463.012001239038, 5504.201890725903, 5572.665640061609, 5585.832425027255, 5347.973260133675, 5477.0, 5532.75102620375, 5538.806141785019, 5545.972270138624, 5475.0, 5475.6440831345835, 5513.338399392099, 5578.414266501959, 5622.746976385991, 5165.251038599457, 5398.946010540001, 5478.506934375925, 5521.2270282159725, 5532.253145825262], "value": 4514.886192084944, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.3010441125048, 871.6252011634995, 903.2548147778081, 921.1341339141206, 932.2215949682018, 16641.500754977355, 16716.916415417905, 16771.748423773653, 16810.747838782427, 17188.65622687547, 17576.736348954742, 18085.909570452128, 18151.0, 18176.636467270648, 18178.0, 867.2195024477973, 870.8476016697084, 894.3024440936048, 897.1880448194395, 899.8065415935572, 892.4333048514176, 897.1566727276339, 898.0794685447436, 898.2634239923266, 898.7393655839799, 946.5835032585641, 946.8295706772778, 948.0945696859517, 948.3598570964606, 948.4404201521102, 933.5938866592986, 936.4147407870081, 936.7798567336671, 936.8735220745215, 937.1518775508176, 688.8691148681735, 689.0663151429841, 689.0835189198355, 689.1557841643996, 689.2969171445098, 17277.136143192914, 17321.393751218773, 17414.1292935354, 17747.556311092198, 17775.555611109696, 16211.432599858948, 16278.674426511521, 16444.67110657792, 16616.83383166165, 16730.66538669232, 13851.58445246634, 14041.22773247471, 14273.71452570953, 14281.714365712627, 14358.0, 3976.642102210786, 4074.5925407459313, 4101.056756945919, 4123.97938010311, 4146.108586653853, 53001.999999999614, 55038.449615503734, 62535.37464625386, 69359.30640693629, 91048.54475727645, 12869.163504372185, 12992.415341309475, 12994.805077923838, 13030.0, 13119.278439685719, 21052.26317078895, 21196.89401553013, 21260.893695531424, 21380.251691190733, 22000.119995200013, 8596.226339629464, 8751.56242187888, 8938.597763100675, 8994.86507702385, 8999.415038022507, 4531.342955271533, 4675.555822196886, 4700.670953033323, 4797.088553174955, 4797.712137271705, 3987.222491614107, 4085.816138273785, 4085.8774236772942, 4092.7339722917914, 4098.549159592442, 661.2593894837717, 662.652107643491, 665.9367360100782, 674.5109795398297, 685.4310921934782, 772.6600295869799, 773.7098588029489, 796.9880451793227, 798.9360851131895, 814.7189219719187, 11366.829497557543, 11607.187496875138, 11794.174407791545, 12171.208871423329, 12192.634220973385, 792.1286584756722, 797.7247502774617, 801.7594721583619, 821.2731732416735, 825.9917400825915, 5406.783728650888, 5432.972835135878, 5488.7530061147345, 5518.668879867221, 5542.861428464321, 84207.5789621048, 87371.56314218516, 87384.56307718548, 87729.0, 89444.5527772357, 71963.64018179875, 72797.0, 74874.25125748782, 76640.0, 77658.0, 39677.60322396739, 60757.0, 63659.681701591195, 63710.0, 63845.68077159584, 11520.654380368602, 11923.642290731292, 12015.519379224734, 12208.938955305166, 12238.694032649255, 42788.78605606952, 43024.354634679876, 44211.55788442074, 44233.557664422944, 45096.77451612852, 50604.0, 51297.80096906448, 51686.22470662868, 51728.74135629298, 51819.481805181465, 12721.87278127244, 12937.223766574036, 13107.279099649611, 13220.735585288432, 13330.933345333211, 15308.23458827032, 15439.459618913284, 15511.146886921328, 15699.21503924822, 15731.842681573038, 14574.10191980084, 14656.633584160481, 14935.775963360775, 14998.550043498712, 15484.621811960711, 13809.378577963815, 13852.376643051288, 14152.646183845487, 14303.21332326732, 14367.497137600134, 13633.863661363259, 13801.293309915152, 13805.24071176095, 13831.308434578432, 13899.652508687364, 10220.386776793417, 10307.639232626821, 10430.68707938763, 10773.946130269298, 10789.946050269698, 11518.481668324777, 12116.757664846476, 12142.939285303517, 12425.068119891224, 12438.502459901865], "value": 7826.371496377467, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 114.0, 114.0, 112.0, 114.0, 112.0, 112.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 120.0, 154.0, 117.0, 115.0, 120.0, 114.0, 133.0, 115.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 160.0, 165.0, 162.0, 161.0, 161.0, 162.0, 161.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 113.0, 74.0, 76.0, 75.0, 76.0, 91.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 83.0, 83.0, 83.0, 96.0, 83.0, 83.0, 104.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.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": [147.0, 149.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 55.0, 57.0, 55.0, 55.0, 55.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 75.0, 79.0, 77.0, 76.0, 80.0, 84.0, 79.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 142.0, 122.0, 120.0, 120.0, 121.0, 125.0, 120.0, 166.0, 131.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 161.0, 167.0, 161.0, 159.0, 160.0, 159.0, 175.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 60.0, 61.0, 60.0, 66.0, 60.0, 59.0, 58.0, 58.0], "value": 60.7, "unit": "score"}]}]} 12:39:45 INFO - Return code: 0 12:39:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:45 ERROR - # TBPL SUCCESS # 12:39:45 INFO - Running post-action listener: _resource_record_post_action 12:39:45 INFO - [mozharness: 2017-04-10 19:39:45.735914Z] Finished run-tests step (success) 12:39:45 INFO - Running post-run listener: _resource_record_post_run 12:39:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 364945408; Read time: 156; Write time: 213556 12:39:45 INFO - TinderboxPrint: CPU usage
13.2% 12:39:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 156 12:39:45 INFO - TinderboxPrint: I/O write bytes / time
364,945,408 / 213,556 12:39:45 INFO - TinderboxPrint: CPU idle
8,267.1 (86.8%) 12:39:45 INFO - TinderboxPrint: CPU user
1,206.1 (12.7%) 12:39:45 INFO - TinderboxPrint: Swap in / out
0 / 0 12:39:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112881664; Read time: 20; Write time: 92100 12:39:45 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 252063744; Read time: 136; Write time: 121456 12:39:46 INFO - Running post-run listener: _upload_blobber_files 12:39:46 INFO - Blob upload gear active. 12:39:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:46 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 12:39:46 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'] 12:39:46 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 12:39:46 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:39:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:39:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:47 INFO - (blobuploader) - INFO - Done attempting. 12:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:51 INFO - (blobuploader) - INFO - Done attempting. 12:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:52 INFO - (blobuploader) - INFO - Done attempting. 12:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:53 INFO - (blobuploader) - INFO - Done attempting. 12:39:53 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:53 INFO - Return code: 0 12:39:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/48158a43011b5ac4d4b0a18303cb5f59032c8fe98366c29e43346b17a589339d9269162d6f5c88712206fa15342f881f2543ece3d479d139eb8e4226d06f71d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8d75d0e00a7e18a54a3794e28c69ccd2d846f338b353ca8267939262d76910eac1c8d86f5e9e896f2ec96585ecd7c12df29a2d302f763a7bc692189a2c596990", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a270ae30e14ac711b6b4bac042bb7e8187b226a6e05678b3d2e3c921122e74d3e9f1541c45fb6abc90809ff2a25277a9acf873edfac06fc214a5479388c01aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8f292c6eb9378ddcc9469e35ec2b54bd3496e13a081e14773fa4ea2a1f3f0b66592844a1f3d5be639117c26ed5d8bba6498ab5298ec565739fff47ad029b76f8"} 12:39:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:53 INFO - Contents: 12:39:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/48158a43011b5ac4d4b0a18303cb5f59032c8fe98366c29e43346b17a589339d9269162d6f5c88712206fa15342f881f2543ece3d479d139eb8e4226d06f71d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8d75d0e00a7e18a54a3794e28c69ccd2d846f338b353ca8267939262d76910eac1c8d86f5e9e896f2ec96585ecd7c12df29a2d302f763a7bc692189a2c596990", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a270ae30e14ac711b6b4bac042bb7e8187b226a6e05678b3d2e3c921122e74d3e9f1541c45fb6abc90809ff2a25277a9acf873edfac06fc214a5479388c01aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8f292c6eb9378ddcc9469e35ec2b54bd3496e13a081e14773fa4ea2a1f3f0b66592844a1f3d5be639117c26ed5d8bba6498ab5298ec565739fff47ad029b76f8"} 12:39:53 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:53 INFO - Copying logs to upload dir... 12:39:53 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.159693 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-04-10 12:39:53.773291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 12:39:53.776431) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/48158a43011b5ac4d4b0a18303cb5f59032c8fe98366c29e43346b17a589339d9269162d6f5c88712206fa15342f881f2543ece3d479d139eb8e4226d06f71d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8d75d0e00a7e18a54a3794e28c69ccd2d846f338b353ca8267939262d76910eac1c8d86f5e9e896f2ec96585ecd7c12df29a2d302f763a7bc692189a2c596990", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a270ae30e14ac711b6b4bac042bb7e8187b226a6e05678b3d2e3c921122e74d3e9f1541c45fb6abc90809ff2a25277a9acf873edfac06fc214a5479388c01aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8f292c6eb9378ddcc9469e35ec2b54bd3496e13a081e14773fa4ea2a1f3f0b66592844a1f3d5be639117c26ed5d8bba6498ab5298ec565739fff47ad029b76f8"} build_url:https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/G6559U_nRp2hiSkWBMgYpQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/48158a43011b5ac4d4b0a18303cb5f59032c8fe98366c29e43346b17a589339d9269162d6f5c88712206fa15342f881f2543ece3d479d139eb8e4226d06f71d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8d75d0e00a7e18a54a3794e28c69ccd2d846f338b353ca8267939262d76910eac1c8d86f5e9e896f2ec96585ecd7c12df29a2d302f763a7bc692189a2c596990", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a270ae30e14ac711b6b4bac042bb7e8187b226a6e05678b3d2e3c921122e74d3e9f1541c45fb6abc90809ff2a25277a9acf873edfac06fc214a5479388c01aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8f292c6eb9378ddcc9469e35ec2b54bd3496e13a081e14773fa4ea2a1f3f0b66592844a1f3d5be639117c26ed5d8bba6498ab5298ec565739fff47ad029b76f8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 12:39:53.804234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:39:53.804883) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1491851937.569917-1484143391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 12:39:53.885921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 12:39:53.886264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 12:39:53.886592) ========= ========= Total master_lag: 0.20 =========