builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1492509400.47 results: success (0) revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.465471) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.465932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.466220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.481049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.481335) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-18 02:56:40-- 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% 46.5M=0s 2017-04-18 02:56:40 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.599254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.599577) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:40.648876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 02:56:40.649217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --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 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-18 02:56:41,081 truncating revision to first 12 chars 2017-04-18 02:56:41,081 Setting DEBUG logging. 2017-04-18 02:56:41,081 attempt 1/10 2017-04-18 02:56:41,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b43e1c02d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 02:56:42,182 unpacking tar archive at: mozilla-aurora-4b43e1c02d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 02:56:42.061700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:42.062055) ========= script_repo_revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:42.062739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:42.063015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:56:42.071886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-18 02:56:42.072246) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:42 INFO - MultiFileLogger online at 20170418 02:56:42 in /builds/slave/test 02:56:42 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 02:56:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:42 INFO - {'append_to_log': False, 02:56:42 INFO - 'base_work_dir': '/builds/slave/test', 02:56:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 02:56:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:42 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 02:56:42 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:42 INFO - 'config_files': ('talos/linux_config.py',), 02:56:42 INFO - 'default_actions': ('clobber', 02:56:42 INFO - 'read-buildbot-config', 02:56:42 INFO - 'download-and-extract', 02:56:42 INFO - 'populate-webroot', 02:56:42 INFO - 'create-virtualenv', 02:56:42 INFO - 'install', 02:56:42 INFO - 'run-tests'), 02:56:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:42 INFO - 'download_minidump_stackwalk': True, 02:56:42 INFO - 'download_symbols': 'ondemand', 02:56:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:42 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:42 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:42 INFO - 'gecko_profile': False, 02:56:42 INFO - 'gecko_profile_interval': 0, 02:56:42 INFO - 'installer_path': 'installer.exe', 02:56:42 INFO - 'log_level': 'info', 02:56:42 INFO - 'log_name': 'talos', 02:56:42 INFO - 'log_to_console': True, 02:56:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:42 INFO - 'opt_config_files': (), 02:56:42 INFO - 'pip_index': False, 02:56:42 INFO - 'suite': 'dromaeojs', 02:56:42 INFO - 'system_bits': '32', 02:56:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:42 INFO - 'title': 'talos-linux64-ix-063', 02:56:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:42 INFO - 'use_talos_json': True, 02:56:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:42 INFO - 'work_dir': 'build'} 02:56:42 INFO - [mozharness: 2017-04-18 09:56:42.606118Z] Running clobber step. 02:56:42 INFO - Running pre-action listener: _resource_record_pre_action 02:56:42 INFO - Running main action method: clobber 02:56:42 INFO - rmtree: /builds/slave/test/build 02:56:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:44 INFO - Running post-action listener: _resource_record_post_action 02:56:44 INFO - [mozharness: 2017-04-18 09:56:44.125174Z] Finished clobber step (success) 02:56:44 INFO - [mozharness: 2017-04-18 09:56:44.125272Z] Running read-buildbot-config step. 02:56:44 INFO - Running pre-action listener: _resource_record_pre_action 02:56:44 INFO - Running main action method: read_buildbot_config 02:56:44 INFO - Using buildbot properties: 02:56:44 INFO - { 02:56:44 INFO - "project": "", 02:56:44 INFO - "product": "firefox", 02:56:44 INFO - "who": "cbook@mozilla.com", 02:56:44 INFO - "installer_path": "public/build/target.tar.bz2", 02:56:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:56:44 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 02:56:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 02:56:44 INFO - "stage_platform": "linux64", 02:56:44 INFO - "basedir": "/builds/slave/test", 02:56:44 INFO - "buildnumber": 137, 02:56:44 INFO - "platform": "ubuntu64_hw", 02:56:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:56:44 INFO - "slavebuilddir": "test", 02:56:44 INFO - "taskId": "LG1vOSYKRiSjLkRFv8IevQ", 02:56:44 INFO - "branch": "mozilla-aurora", 02:56:44 INFO - "script_repo_revision": "production", 02:56:44 INFO - "revision": "4b43e1c02d4ff32f7d45a6c614720660f52927d9", 02:56:44 INFO - "slavename": "talos-linux64-ix-063", 02:56:44 INFO - "repo_path": "releases/mozilla-aurora" 02:56:44 INFO - } 02:56:44 INFO - Finding installer, test and symbols from parent task. 02:56:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LG1vOSYKRiSjLkRFv8IevQ'}, attempt #1 02:56:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LG1vOSYKRiSjLkRFv8IevQ'}, attempt #1 02:56:45 INFO - Task dependencies: FAYYQg_aQ7KuuP2lhlxo1g 02:56:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g'}, attempt #1 02:56:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 02:56:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/test_packages.json 02:56:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.crashreporter-symbols.zip 02:56:45 INFO - Running post-action listener: _resource_record_post_action 02:56:45 INFO - [mozharness: 2017-04-18 09:56:45.556461Z] Finished read-buildbot-config step (success) 02:56:45 INFO - [mozharness: 2017-04-18 09:56:45.556678Z] Running download-and-extract step. 02:56:45 INFO - Running pre-action listener: _resource_record_pre_action 02:56:45 INFO - Running main action method: download_and_extract 02:56:45 INFO - mkdir: /builds/slave/test/build/tests 02:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:45 INFO - trying https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.test_packages.json 02:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:56:46 INFO - Downloaded 896 bytes. 02:56:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:56:46 INFO - Using the following test package requirements: 02:56:46 INFO - {u'common': [u'target.common.tests.zip'], 02:56:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:56:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:56:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:56:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:56:46 INFO - u'mozbase': [u'target.common.tests.zip'], 02:56:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:56:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:56:46 INFO - u'web-platform': [u'target.common.tests.zip', 02:56:46 INFO - u'target.web-platform.tests.zip'], 02:56:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:56:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:56:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip 02:56:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:56:46 INFO - Fetch https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip into memory 02:56:47 INFO - Expected file size: 59543023 02:56:47 INFO - Obtained file size: 59543023 02:56:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:56:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip 02:56:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:56:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.common.tests.zip into memory 02:56:58 INFO - Expected file size: 59543023 02:56:58 INFO - Obtained file size: 59543023 02:57:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.talos.tests.zip 02:57:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:09 INFO - Fetch https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.talos.tests.zip into memory 02:57:09 INFO - Expected file size: 14404424 02:57:09 INFO - Obtained file size: 14404424 02:57:10 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')]} 02:57:10 INFO - trying https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 02:57:10 INFO - Downloading https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:11 INFO - Downloaded 66800122 bytes. 02:57:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 02:57:11 INFO - mkdir: /builds/slave/test/properties 02:57:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:11 INFO - Contents: 02:57:11 INFO - build_url:https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - Running post-action listener: set_extra_try_arguments 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.306546Z] Finished download-and-extract step (success) 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.306644Z] Running populate-webroot step. 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: populate_webroot 02:57:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:11 INFO - '--tppagecycles', 02:57:11 INFO - '7'], 02:57:11 INFO - 'tests': ['tsvgm']}}, 02:57:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['damp', 'tps']}, 02:57:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'tests': ['damp', 'tps']}, 02:57:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['dromaeo_dom']}, 02:57:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['basic_compositor_video']}, 02:57:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['a11yr', 02:57:11 INFO - 'ts_paint', 02:57:11 INFO - 'tpaint', 02:57:11 INFO - 'sessionrestore', 02:57:11 INFO - 'sessionrestore_no_auto_restore', 02:57:11 INFO - 'tabpaint']}, 02:57:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['tsvgx', 02:57:11 INFO - 'tsvgr_opacity', 02:57:11 INFO - 'tart', 02:57:11 INFO - 'tscrollx', 02:57:11 INFO - 'cart', 02:57:11 INFO - 'tsvg_static']}, 02:57:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:11 INFO - 'tsvgr_opacity', 02:57:11 INFO - 'tart', 02:57:11 INFO - 'tscrollx', 02:57:11 INFO - 'cart', 02:57:11 INFO - 'tsvg_static']}, 02:57:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-e10s'], 02:57:11 INFO - 'tests': ['tp5o']}, 02:57:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--disable-e10s', 02:57:11 INFO - '--xperf_path', 02:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:11 INFO - 'tests': ['tp5n']}, 02:57:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:11 INFO - 'talos_options': ['--xperf_path', 02:57:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:11 INFO - 'tests': ['tp5n']}}, 02:57:11 INFO - 'talos.zip': {'path': '', 02:57:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.319868Z] Finished populate-webroot step (success) 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.319959Z] Running create-virtualenv step. 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: create_virtualenv 02:57:11 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:11 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 02:57:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:11 INFO - Using real prefix '/usr' 02:57:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:13 INFO - Installing pip.................done. 02:57:13 INFO - Return code: 0 02:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:14 INFO - Reading from file tmpfile_stdout 02:57:14 INFO - Output received: 02:57:14 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) 02:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:57:14 INFO - Using env: {'DISPLAY': ':0', 02:57:14 INFO - 'HOME': '/home/cltbld', 02:57:14 INFO - 'LANG': 'en_US.UTF-8', 02:57:14 INFO - 'LANGUAGE': 'en_US:en', 02:57:14 INFO - 'LOGNAME': 'cltbld', 02:57:14 INFO - 'MAIL': '/var/mail/cltbld', 02:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:14 INFO - 'MOZ_NO_REMOTE': '1', 02:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:14 INFO - 'NO_EM_RESTART': '1', 02:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:14 INFO - 'PWD': '/builds/slave/test', 02:57:14 INFO - 'SHELL': '/bin/bash', 02:57:14 INFO - 'SHLVL': '1', 02:57:14 INFO - 'TERM': 'linux', 02:57:14 INFO - 'TMOUT': '86400', 02:57:14 INFO - 'USER': 'cltbld', 02:57:14 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:14 INFO - '_': '/tools/buildbot/bin/python'} 02:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:14 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 02:57:14 INFO - Cleaning up... 02:57:14 INFO - Return code: 0 02:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:57:14 INFO - Using env: {'DISPLAY': ':0', 02:57:14 INFO - 'HOME': '/home/cltbld', 02:57:14 INFO - 'LANG': 'en_US.UTF-8', 02:57:14 INFO - 'LANGUAGE': 'en_US:en', 02:57:14 INFO - 'LOGNAME': 'cltbld', 02:57:14 INFO - 'MAIL': '/var/mail/cltbld', 02:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:14 INFO - 'MOZ_NO_REMOTE': '1', 02:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:14 INFO - 'NO_EM_RESTART': '1', 02:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:14 INFO - 'PWD': '/builds/slave/test', 02:57:14 INFO - 'SHELL': '/bin/bash', 02:57:14 INFO - 'SHLVL': '1', 02:57:14 INFO - 'TERM': 'linux', 02:57:14 INFO - 'TMOUT': '86400', 02:57:14 INFO - 'USER': 'cltbld', 02:57:14 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:14 INFO - '_': '/tools/buildbot/bin/python'} 02:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:14 INFO - Downloading/unpacking psutil>=3.1.1 02:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:16 INFO - Installing collected packages: psutil 02:57:16 INFO - Running setup.py install for psutil 02:57:16 INFO - building 'psutil._psutil_linux' extension 02:57:16 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 02:57:16 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 02:57:16 INFO - building 'psutil._psutil_posix' extension 02:57:16 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 02:57:17 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 02:57:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:17 INFO - Successfully installed psutil 02:57:17 INFO - Cleaning up... 02:57:17 INFO - Return code: 0 02:57:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:17 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')]} 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:17 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')]} 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:17 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:17 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 02:57:17 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 02:57:17 INFO - Using env: {'DISPLAY': ':0', 02:57:17 INFO - 'HOME': '/home/cltbld', 02:57:17 INFO - 'LANG': 'en_US.UTF-8', 02:57:17 INFO - 'LANGUAGE': 'en_US:en', 02:57:17 INFO - 'LOGNAME': 'cltbld', 02:57:17 INFO - 'MAIL': '/var/mail/cltbld', 02:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:17 INFO - 'MOZ_NO_REMOTE': '1', 02:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:17 INFO - 'NO_EM_RESTART': '1', 02:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:17 INFO - 'PWD': '/builds/slave/test', 02:57:17 INFO - 'SHELL': '/bin/bash', 02:57:17 INFO - 'SHLVL': '1', 02:57:17 INFO - 'TERM': 'linux', 02:57:17 INFO - 'TMOUT': '86400', 02:57:17 INFO - 'USER': 'cltbld', 02:57:17 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:17 INFO - '_': '/tools/buildbot/bin/python'} 02:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:19 INFO - Installing collected packages: mozsystemmonitor 02:57:19 INFO - Running setup.py install for mozsystemmonitor 02:57:19 INFO - Successfully installed mozsystemmonitor 02:57:19 INFO - Cleaning up... 02:57:19 INFO - Return code: 0 02:57:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:19 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')]} 02:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:19 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')]} 02:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:19 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:19 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 02:57:19 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 02:57:19 INFO - Using env: {'DISPLAY': ':0', 02:57:19 INFO - 'HOME': '/home/cltbld', 02:57:19 INFO - 'LANG': 'en_US.UTF-8', 02:57:19 INFO - 'LANGUAGE': 'en_US:en', 02:57:19 INFO - 'LOGNAME': 'cltbld', 02:57:19 INFO - 'MAIL': '/var/mail/cltbld', 02:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:19 INFO - 'MOZ_NO_REMOTE': '1', 02:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:19 INFO - 'NO_EM_RESTART': '1', 02:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:19 INFO - 'PWD': '/builds/slave/test', 02:57:19 INFO - 'SHELL': '/bin/bash', 02:57:19 INFO - 'SHLVL': '1', 02:57:19 INFO - 'TERM': 'linux', 02:57:19 INFO - 'TMOUT': '86400', 02:57:19 INFO - 'USER': 'cltbld', 02:57:19 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:19 INFO - '_': '/tools/buildbot/bin/python'} 02:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:19 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:19 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 02:57:19 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 02:57:19 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 02:57:19 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 02:57:19 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 02:57:19 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 02:57:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:21 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 02:57:21 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 02:57:21 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 02:57:21 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 02:57:21 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 02:57:21 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 02:57:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:22 INFO - warning: no files found matching '*.txt' 02:57:22 INFO - no previously-included directories found matching 'build' 02:57:22 INFO - no previously-included directories found matching 'dist' 02:57:22 INFO - no previously-included directories found matching '.git*' 02:57:22 INFO - Installing collected packages: jsonschema, functools32 02:57:22 INFO - Running setup.py install for functools32 02:57:22 INFO - warning: no files found matching '*.txt' 02:57:22 INFO - no previously-included directories found matching 'build' 02:57:22 INFO - no previously-included directories found matching 'dist' 02:57:22 INFO - no previously-included directories found matching '.git*' 02:57:22 INFO - Successfully installed jsonschema functools32 02:57:22 INFO - Cleaning up... 02:57:22 INFO - Return code: 0 02:57:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:22 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')]} 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:22 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')]} 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:22 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:22 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 02:57:22 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 02:57:22 INFO - Using env: {'DISPLAY': ':0', 02:57:22 INFO - 'HOME': '/home/cltbld', 02:57:22 INFO - 'LANG': 'en_US.UTF-8', 02:57:22 INFO - 'LANGUAGE': 'en_US:en', 02:57:22 INFO - 'LOGNAME': 'cltbld', 02:57:22 INFO - 'MAIL': '/var/mail/cltbld', 02:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:22 INFO - 'MOZ_NO_REMOTE': '1', 02:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:22 INFO - 'NO_EM_RESTART': '1', 02:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:22 INFO - 'PWD': '/builds/slave/test', 02:57:22 INFO - 'SHELL': '/bin/bash', 02:57:22 INFO - 'SHLVL': '1', 02:57:22 INFO - 'TERM': 'linux', 02:57:22 INFO - 'TMOUT': '86400', 02:57:22 INFO - 'USER': 'cltbld', 02:57:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:22 INFO - '_': '/tools/buildbot/bin/python'} 02:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:22 INFO - Cleaning up... 02:57:22 INFO - Return code: 0 02:57:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:22 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')]} 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:22 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')]} 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:22 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:22 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 02:57:22 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 02:57:22 INFO - Using env: {'DISPLAY': ':0', 02:57:22 INFO - 'HOME': '/home/cltbld', 02:57:22 INFO - 'LANG': 'en_US.UTF-8', 02:57:22 INFO - 'LANGUAGE': 'en_US:en', 02:57:22 INFO - 'LOGNAME': 'cltbld', 02:57:22 INFO - 'MAIL': '/var/mail/cltbld', 02:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:22 INFO - 'MOZ_NO_REMOTE': '1', 02:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:22 INFO - 'NO_EM_RESTART': '1', 02:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:22 INFO - 'PWD': '/builds/slave/test', 02:57:22 INFO - 'SHELL': '/bin/bash', 02:57:22 INFO - 'SHLVL': '1', 02:57:22 INFO - 'TERM': 'linux', 02:57:22 INFO - 'TMOUT': '86400', 02:57:22 INFO - 'USER': 'cltbld', 02:57:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:22 INFO - '_': '/tools/buildbot/bin/python'} 02:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:22 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:24 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:24 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 02:57:24 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 02:57:24 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 02:57:24 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 02:57:24 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 02:57:24 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 02:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:25 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 02:57:25 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 02:57:25 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 02:57:25 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 02:57:25 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 02:57:25 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 02:57:25 INFO - Downloading docopt-0.6.1.tar.gz 02:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:25 INFO - Running setup.py install for blobuploader 02:57:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:25 INFO - Running setup.py install for requests 02:57:26 INFO - Running setup.py install for docopt 02:57:26 INFO - Successfully installed blobuploader requests docopt 02:57:26 INFO - Cleaning up... 02:57:26 INFO - Return code: 0 02:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:26 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:26 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 02:57:26 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 02:57:26 INFO - Using env: {'DISPLAY': ':0', 02:57:26 INFO - 'HOME': '/home/cltbld', 02:57:26 INFO - 'LANG': 'en_US.UTF-8', 02:57:26 INFO - 'LANGUAGE': 'en_US:en', 02:57:26 INFO - 'LOGNAME': 'cltbld', 02:57:26 INFO - 'MAIL': '/var/mail/cltbld', 02:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:26 INFO - 'MOZ_NO_REMOTE': '1', 02:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:26 INFO - 'NO_EM_RESTART': '1', 02:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:26 INFO - 'PWD': '/builds/slave/test', 02:57:26 INFO - 'SHELL': '/bin/bash', 02:57:26 INFO - 'SHLVL': '1', 02:57:26 INFO - 'TERM': 'linux', 02:57:26 INFO - 'TMOUT': '86400', 02:57:26 INFO - 'USER': 'cltbld', 02:57:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:26 INFO - '_': '/tools/buildbot/bin/python'} 02:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:26 INFO - Running setup.py (path:/tmp/pip-YXzC5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:26 INFO - Running setup.py (path:/tmp/pip-6rkkgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:26 INFO - Running setup.py (path:/tmp/pip-rgxKJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:26 INFO - Running setup.py (path:/tmp/pip-UJYX4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:26 INFO - Running setup.py (path:/tmp/pip-SJPHTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:26 INFO - Running setup.py (path:/tmp/pip-QPKlvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:26 INFO - Running setup.py (path:/tmp/pip-jWBT8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:26 INFO - Running setup.py (path:/tmp/pip-KGfIax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:27 INFO - Running setup.py (path:/tmp/pip-DFiDn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:27 INFO - Running setup.py (path:/tmp/pip-jrPAff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:27 INFO - Running setup.py (path:/tmp/pip-LYuAK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:27 INFO - Running setup.py (path:/tmp/pip-KFh7cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:27 INFO - Running setup.py (path:/tmp/pip-k2Yg97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:27 INFO - Running setup.py (path:/tmp/pip-OGDmJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:27 INFO - Running setup.py (path:/tmp/pip-SRK8Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:27 INFO - Running setup.py (path:/tmp/pip-Xx70Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:27 INFO - Running setup.py (path:/tmp/pip-C_W578-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:27 INFO - Running setup.py install for manifestparser 02:57:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:27 INFO - Running setup.py install for mozcrash 02:57:27 INFO - Running setup.py install for mozdebug 02:57:27 INFO - Running setup.py install for mozdevice 02:57:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for mozfile 02:57:28 INFO - Running setup.py install for mozhttpd 02:57:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for mozinfo 02:57:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for mozInstall 02:57:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for mozleak 02:57:28 INFO - Running setup.py install for mozlog 02:57:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for moznetwork 02:57:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:28 INFO - Running setup.py install for mozprocess 02:57:28 INFO - Running setup.py install for mozprofile 02:57:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozrunner 02:57:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Running setup.py install for mozscreenshot 02:57:29 INFO - Running setup.py install for moztest 02:57:29 INFO - Running setup.py install for mozversion 02:57:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:29 INFO - Cleaning up... 02:57:29 INFO - Return code: 0 02:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:29 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')]} 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:29 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')]} 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:29 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:29 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 02:57:29 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 02:57:29 INFO - Using env: {'DISPLAY': ':0', 02:57:29 INFO - 'HOME': '/home/cltbld', 02:57:29 INFO - 'LANG': 'en_US.UTF-8', 02:57:29 INFO - 'LANGUAGE': 'en_US:en', 02:57:29 INFO - 'LOGNAME': 'cltbld', 02:57:29 INFO - 'MAIL': '/var/mail/cltbld', 02:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:29 INFO - 'MOZ_NO_REMOTE': '1', 02:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:29 INFO - 'NO_EM_RESTART': '1', 02:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:29 INFO - 'PWD': '/builds/slave/test', 02:57:29 INFO - 'SHELL': '/bin/bash', 02:57:29 INFO - 'SHLVL': '1', 02:57:29 INFO - 'TERM': 'linux', 02:57:29 INFO - 'TMOUT': '86400', 02:57:29 INFO - 'USER': 'cltbld', 02:57:29 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:29 INFO - '_': '/tools/buildbot/bin/python'} 02:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:29 INFO - Running setup.py (path:/tmp/pip-eY3lK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:29 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)) 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:29 INFO - Running setup.py (path:/tmp/pip-H0ru8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:29 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)) 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:29 INFO - Running setup.py (path:/tmp/pip-G4Wp8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:29 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)) 02:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:29 INFO - Running setup.py (path:/tmp/pip-AN7rT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:30 INFO - Running setup.py (path:/tmp/pip-SX08CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:30 INFO - Running setup.py (path:/tmp/pip-hBLw7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:30 INFO - Running setup.py (path:/tmp/pip-rOXcY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:30 INFO - Running setup.py (path:/tmp/pip-u1zZs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:30 INFO - Running setup.py (path:/tmp/pip-E60mWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:30 INFO - Running setup.py (path:/tmp/pip-8dmL4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:30 INFO - Running setup.py (path:/tmp/pip-m5wAjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:30 INFO - Running setup.py (path:/tmp/pip-iycsoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:30 INFO - Running setup.py (path:/tmp/pip-elCJSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:30 INFO - Running setup.py (path:/tmp/pip-014nKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:30 INFO - Running setup.py (path:/tmp/pip-skHNMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:30 INFO - Running setup.py (path:/tmp/pip-fIimLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:30 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)) 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:30 INFO - Running setup.py (path:/tmp/pip-rMNNIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:30 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)) 02:57:30 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)) 02:57:30 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)) 02:57:30 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)) 02:57:31 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)) 02:57:31 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)) 02:57:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:31 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 02:57:31 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 02:57:31 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 02:57:31 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 02:57:31 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 02:57:31 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 02:57:32 INFO - Downloading blessings-1.6.tar.gz 02:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:33 INFO - Installing collected packages: blessings 02:57:33 INFO - Running setup.py install for blessings 02:57:33 INFO - Successfully installed blessings 02:57:33 INFO - Cleaning up... 02:57:33 INFO - Return code: 0 02:57:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:33 INFO - Reading from file tmpfile_stdout 02:57:33 INFO - Current package versions: 02:57:33 INFO - argparse == 1.2.1 02:57:33 INFO - blessings == 1.6 02:57:33 INFO - blobuploader == 1.2.4 02:57:33 INFO - docopt == 0.6.1 02:57:33 INFO - functools32 == 3.2.3-2 02:57:33 INFO - jsonschema == 2.5.1 02:57:33 INFO - manifestparser == 1.1 02:57:33 INFO - mozInstall == 1.12 02:57:33 INFO - mozcrash == 1.0 02:57:33 INFO - mozdebug == 0.1 02:57:33 INFO - mozdevice == 0.49 02:57:33 INFO - mozfile == 1.2 02:57:33 INFO - mozhttpd == 0.7 02:57:33 INFO - mozinfo == 0.9 02:57:33 INFO - mozleak == 0.1 02:57:33 INFO - mozlog == 3.4 02:57:33 INFO - moznetwork == 0.27 02:57:33 INFO - mozprocess == 0.25 02:57:33 INFO - mozprofile == 0.28 02:57:33 INFO - mozrunner == 6.13 02:57:33 INFO - mozscreenshot == 0.1 02:57:33 INFO - mozsystemmonitor == 0.3 02:57:33 INFO - moztest == 0.8 02:57:33 INFO - mozversion == 1.4 02:57:33 INFO - psutil == 3.1.1 02:57:33 INFO - requests == 1.2.3 02:57:33 INFO - wsgiref == 0.1.2 02:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:33 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')]} 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 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')]} 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:33 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 02:57:33 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 02:57:33 INFO - Using env: {'DISPLAY': ':0', 02:57:33 INFO - 'HOME': '/home/cltbld', 02:57:33 INFO - 'LANG': 'en_US.UTF-8', 02:57:33 INFO - 'LANGUAGE': 'en_US:en', 02:57:33 INFO - 'LOGNAME': 'cltbld', 02:57:33 INFO - 'MAIL': '/var/mail/cltbld', 02:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:33 INFO - 'MOZ_NO_REMOTE': '1', 02:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:33 INFO - 'NO_EM_RESTART': '1', 02:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:33 INFO - 'PWD': '/builds/slave/test', 02:57:33 INFO - 'SHELL': '/bin/bash', 02:57:33 INFO - 'SHLVL': '1', 02:57:33 INFO - 'TERM': 'linux', 02:57:33 INFO - 'TMOUT': '86400', 02:57:33 INFO - 'USER': 'cltbld', 02:57:33 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:33 INFO - '_': '/tools/buildbot/bin/python'} 02:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 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)) 02:57:33 INFO - Cleaning up... 02:57:33 INFO - Return code: 0 02:57:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57:33 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')]} 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 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')]} 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 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 0x18a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', '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 02:57:33 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 02:57:33 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 02:57:33 INFO - Using env: {'DISPLAY': ':0', 02:57:33 INFO - 'HOME': '/home/cltbld', 02:57:33 INFO - 'LANG': 'en_US.UTF-8', 02:57:33 INFO - 'LANGUAGE': 'en_US:en', 02:57:33 INFO - 'LOGNAME': 'cltbld', 02:57:33 INFO - 'MAIL': '/var/mail/cltbld', 02:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:33 INFO - 'MOZ_NO_REMOTE': '1', 02:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:33 INFO - 'NO_EM_RESTART': '1', 02:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:33 INFO - 'PWD': '/builds/slave/test', 02:57:33 INFO - 'SHELL': '/bin/bash', 02:57:33 INFO - 'SHLVL': '1', 02:57:33 INFO - 'TERM': 'linux', 02:57:33 INFO - 'TMOUT': '86400', 02:57:33 INFO - 'USER': 'cltbld', 02:57:33 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:33 INFO - '_': '/tools/buildbot/bin/python'} 02:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:33 INFO - Cleaning up... 02:57:33 INFO - Return code: 0 02:57:33 INFO - Running post-action listener: _resource_record_post_action 02:57:33 INFO - Running post-action listener: _start_resource_monitoring 02:57:33 INFO - Starting resource monitoring. 02:57:33 INFO - [mozharness: 2017-04-18 09:57:33.985975Z] Finished create-virtualenv step (success) 02:57:33 INFO - [mozharness: 2017-04-18 09:57:33.986575Z] Running install step. 02:57:33 INFO - Running pre-action listener: _resource_record_pre_action 02:57:33 INFO - Running main action method: install 02:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:34 INFO - Reading from file tmpfile_stdout 02:57:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:34 INFO - Reading from file tmpfile_stdout 02:57:34 INFO - Output received: 02:57:34 INFO - Usage: mozinstall [options] installer 02:57:34 INFO - Options: 02:57:34 INFO - -h, --help show this help message and exit 02:57:34 INFO - -d DEST, --destination=DEST 02:57:34 INFO - Directory to install application into. [default: 02:57:34 INFO - "/builds/slave/test"] 02:57:34 INFO - --app=APP Application being installed. [default: firefox] 02:57:34 INFO - mkdir: /builds/slave/test/build/application 02:57:34 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'] 02:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:57:50 INFO - Reading from file tmpfile_stdout 02:57:50 INFO - Output received: 02:57:50 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:50 INFO - Running post-action listener: _resource_record_post_action 02:57:50 INFO - [mozharness: 2017-04-18 09:57:50.849012Z] Finished install step (success) 02:57:50 INFO - [mozharness: 2017-04-18 09:57:50.849285Z] Running run-tests step. 02:57:50 INFO - Running pre-action listener: _resource_record_pre_action 02:57:50 INFO - Running main action method: run_tests 02:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:50 INFO - Python 2.7.3 02:57:50 INFO - Return code: 0 02:57:50 INFO - grabbing minidump binary from tooltool 02:57:50 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')]} 02:57:50 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 0x1b3b400>, '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 0x1b3c3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3c840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:50 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 02:57:50 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 02:57:50 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 02:57:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:50 INFO - Return code: 0 02:57:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:50 INFO - ENV: RUST_BACKTRACE is now 1 02:57:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:50 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/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:57:50 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/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 02:57:50 INFO - Using env: {'DISPLAY': ':0', 02:57:50 INFO - 'HOME': '/home/cltbld', 02:57:50 INFO - 'LANG': 'en_US.UTF-8', 02:57:50 INFO - 'LANGUAGE': 'en_US:en', 02:57:50 INFO - 'LOGNAME': 'cltbld', 02:57:50 INFO - 'MAIL': '/var/mail/cltbld', 02:57:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:50 INFO - 'MOZ_NO_REMOTE': '1', 02:57:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:50 INFO - 'NO_EM_RESTART': '1', 02:57:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:50 INFO - 'PWD': '/builds/slave/test', 02:57:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:50 INFO - 'RUST_BACKTRACE': '1', 02:57:50 INFO - 'SHELL': '/bin/bash', 02:57:50 INFO - 'SHLVL': '1', 02:57:50 INFO - 'TERM': 'linux', 02:57:50 INFO - 'TMOUT': '86400', 02:57:50 INFO - 'USER': 'cltbld', 02:57:50 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230', 02:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:50 INFO - '_': '/tools/buildbot/bin/python'} 02:57:50 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/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 02:57:51 INFO - mozversion application_buildid: 20170418084933 02:57:51 INFO - mozversion application_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 02:57:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:57:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:51 INFO - mozversion application_name: Firefox 02:57:51 INFO - mozversion application_remotingname: firefox-dev 02:57:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:57:51 INFO - mozversion application_vendor: Mozilla 02:57:51 INFO - mozversion application_version: 54.0a2 02:57:51 INFO - mozversion platform_buildid: 20170418084933 02:57:51 INFO - mozversion platform_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 02:57:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:57:51 INFO - mozversion platform_version: 54.0a2 02:57:51 INFO - using testdate: 1492509471 02:57:51 INFO - actual date: 1492509471 02:57:51 INFO - starting webserver on 'localhost:41793' 02:57:51 INFO - SUITE-START | Running 2 tests 02:57:51 INFO - TEST-START | dromaeo_css 02:57:51 INFO - operating with platform_type : linux_ 02:57:51 INFO - Initialising browser for dromaeo_css test... 02:57:51 INFO - TEST-INFO | started process 25905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9lEsj/profile http://localhost:41793/getInfo.html) 02:57:55 INFO - PROCESS | 25905 | __metrics Screen width/height:1600/1200 02:57:55 INFO - PROCESS | 25905 | colorDepth:24 02:57:55 INFO - PROCESS | 25905 | Browser inner width/height: 1024/697 02:57:55 INFO - PROCESS | 25905 | __metrics 02:57:55 INFO - PROCESS | 25905 | 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" 02:57:55 INFO - PROCESS | 25905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:57:56 INFO - PROCESS | 25905 | console.error: PushService: 02:57:56 INFO - PROCESS | 25905 | stateChangeProcessEnqueue: Error transitioning state 02:57:56 INFO - PROCESS | 25905 | UnknownError 02:57:57 INFO - TEST-INFO | 25905: exit 0 02:57:57 INFO - Browser initialized. 02:57:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:57 INFO - TEST-INFO | started process 25995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9lEsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:08 INFO - PROCESS | 25995 | RSS: Main: 140017664 02:58:08 INFO - PROCESS | 25995 | 03:01:09 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41793/tests/dromaeo/cssquery-ext.html) 03:01:11 INFO - PROCESS | 25995 | RSS: Main: 272031744 03:01:11 INFO - PROCESS | 25995 | 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | A coding exception was thrown and uncaught in a Task. 03:02:58 INFO - PROCESS | 25995 | 03:02:58 ERROR - PROCESS | 25995 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:02:58 INFO - PROCESS | 25995 | Full stack: 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | A coding exception was thrown and uncaught in a Task. 03:02:58 INFO - PROCESS | 25995 | 03:02:58 ERROR - PROCESS | 25995 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:02:58 INFO - PROCESS | 25995 | Full stack: 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | A coding exception was thrown and uncaught in a Task. 03:02:58 INFO - PROCESS | 25995 | 03:02:58 ERROR - PROCESS | 25995 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:02:58 INFO - PROCESS | 25995 | Full stack: 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | ************************* 03:02:58 INFO - PROCESS | 25995 | A coding exception was thrown and uncaught in a Task. 03:02:58 INFO - PROCESS | 25995 | 03:02:58 ERROR - PROCESS | 25995 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:02:58 INFO - PROCESS | 25995 | Full stack: 03:02:58 INFO - PROCESS | 25995 | ************************* 03:04:13 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-ext.html (next: http://localhost:41793/tests/dromaeo/cssquery-jquery.html) 03:04:14 INFO - PROCESS | 25995 | RSS: Main: 218443776 03:04:14 INFO - PROCESS | 25995 | 03:07:16 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41793/tests/dromaeo/cssquery-mootools.html) 03:07:16 INFO - PROCESS | 25995 | RSS: Main: 169697280 03:07:16 INFO - PROCESS | 25995 | 03:10:18 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41793/tests/dromaeo/cssquery-prototype.html) 03:10:19 INFO - PROCESS | 25995 | RSS: Main: 201596928 03:10:19 INFO - PROCESS | 25995 | 03:13:22 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41793/tests/dromaeo/cssquery-yui.html) 03:13:22 INFO - PROCESS | 25995 | RSS: Main: 175751168 03:13:22 INFO - PROCESS | 25995 | 03:16:24 INFO - PROCESS | 25995 | Cycle 1(1): loaded http://localhost:41793/tests/dromaeo/cssquery-yui.html (next: http://localhost:41793/tests/dromaeo/cssquery-dojo.html) 03:16:25 INFO - PROCESS | 25995 | RSS: Main: 267501568 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | __start_tp_report 03:16:25 INFO - PROCESS | 25995 | _x_x_mozilla_page_load 03:16:25 INFO - PROCESS | 25995 | _x_x_mozilla_page_load_details 03:16:25 INFO - PROCESS | 25995 | |i|pagename|runs| 03:16:25 INFO - PROCESS | 25995 | |0;dojo.html;3361.7310615150786;3387.8814241501555;3394.881179158728;3405.795652260863;3429.4684323929782;5564.304461942257;5632.690202038886;5650.039493286141;5658.349289831665;5658.547316214693;5672.17753425753;5682.090865461527;5716.57125715572;5739.225204597378;5743.942560574393;5168.043911876296;5174.042802081608;5179.456157103516;5198;5235.450277720842;5019.598432125421;5275.129603615399;5282.23407605897;5288.0745869472885;5319.867003324909;5067.898642027176;5119.129747942859;5140.177571588547;5212.635115541913;5215.478452154792;5217.50433708797;5249.763760630762;5254.789808407659;5257.631965762398;5260.526552610245;5092.6180536459915;5149.30484384607;5199.714015729133;5200.531952124289;5234.581233501349;5479.561635069185;5481.862953426156;5531.861703457445;5539.723013849331;5542.612017158801;5929.851753706192;5936.050231962909;5973.701314934236;5989.041753319448;6012.789552365646;5918.496927761103;5921.052631578927;5931;5942.524598032147;6007.549433792483;5450;5490.3411590608985;5608.9439105609235;5659.915101273484;5677.37548869624;6167.506599472121;6167.938320616826;6182.412670796267;6186.041163619646;6203.875922481616;5846.795362162304;5950.31571369298;5951.842106572091;5965.015772397506;5991.310999235144;5797.652140871562;5832.300123985149;6004.819855404257;6081.331053584102;6099.054646529795;6073.5748497604745;6076.058210977306;6078.057901025348;6095.4818840398175;6095.725692343855;5722.599418040697;5779.682117483495;5779.768809247667;6002.339742628307;6025.517958563304;4573.108243892409;4610.815567377334;4615.838445654453;4633.4208223972;4640.883977900579;4158.459400277945;4188.036751547162;4193.412922190896;4193.748375097504;4202.096549241927;5611.0741727615305;5669.092945128842;5769.769209231667;5795.536357091422;5878.706064696748;5997.790077347272;6014.338422773491;6016.939830601638;6020.849478763066;6053.031514957585;5833.212516310328;5858.179854820329;5865.20819689345;5867.237259156368;5871.060630299132;4974.651774375831;5007.7245751484015;5115.053715062725;5147.897042059138;5173.818916337986;6427.614343139333;6441.259255185713;6445.709943052668;6451.838704032437;6455.4835613150835;6113.755449781959;6174.783882564088;6176.042713379434;6179.412955769195;6181.258249010148;6066.029435290508;6113;6298.559100862895;6365.077063825626;6417.550771445954;5979.551533635082;6017.428344307284;6044.788432404845;6047.5464340173785;6053.485453736482;6152.200213972155;6152.600080994721;6159.106929495288;6161.075838624242;6174.536909731878;5646.520045796154;5722.513586345207;5980.760769569169;5992.280926288873;5992.520598352208;5853.882922341444;5872.970635146797;5935.465808077293;5945.881082378241;5992.730327135377;5883.970580147072;5926.229590153425;5931.881362372815;5944.346121926498;5944.791932282349;5697;5728.083506639085;5756.712164391847;5901.616394934315;5927.673977931255;5743.0811070228565;5750.194972703908;5780.075187969905;5783.3638299787835;5795.565332599987 03:16:25 INFO - PROCESS | 25995 | |1;ext.html;757.6742000939594;821.6590115102233;838.6351936907446;882.5631312500313;896.8475359188946;31319.21701957452;42471.36292955608;43104.568954310445;43136.352954705704;43148.99999999996;45698.54301456984;46149;46169.538304616945;46191;46211.306830397574;7750.4187185961;7874.9212507875045;9239.49182794946;9370.531473426301;9370.67202647904;10676.733081672981;10730.678079657584;11244.49399777008;11254.49354779037;11277.097832173447;10973.83539246908;11012.119030477543;11031.779364412707;11031.83452248217;11033.393163376011;10897.291676041032;10919.508622111984;10920.890791092066;10956.616518421817;10964.56141754329;10712.892871071346;10732.195085368628;10776.40729759863;10776.515056822462;10778.514966826511;41934;42299.78850105761;42311.788441057906;42332.36501452481;42481.78759106216;4255.87232383029;4293.24868148076;4333.783310834478;4423.402840616508;4439.911201775979;28854.855725721238;29064.854675726485;29183.708162918312;29805.701942980508;30445.391092178255;4200.558941311149;4294.742315461082;4345.760983145926;4364.388985542027;4409.559044095597;229794;230549;231078;231712;232641.5311310978;51324.74337628363;51331.23003154956;51413.22880156801;51477;51568.74215628973;54247.72876135594;54354.7282263594;54445.1833222494;54464;54543.45456545384;16476.752848707278;16825.326986920387;16829.915850420915;16839.57901052459;16871.409500667418;11805.350705711096;11977.341246231366;14992.100473971597;14997.475088372074;15061.623459413384;12885.420156092998;12916.289604071866;13059.542915997894;13182.340882955814;13444.32778361078;5580.553555715533;5594.888102237933;5612.130119831432;5649.378568357477;5695.886082278331;1020.8060468511108;1022.6625213679467;1026.0662796854826;1033.405791669793;1034.1674951663983;28245.858770706014;28484.715152848206;28596.571051434246;28669.713302867123;28995.275118121794;1073.6242315189777;1083.9403832789114;1099.70308016835;1104.2792063926777;1105.6461932181624;14061.507847225503;14901.403943842124;15125.697486050218;15131;15195.772063419057;291908;292018;292040;292391;293448;54803.17795233075;54850;54891;54898.45101549013;55122.17316740252;1493.8132733408324;1500.407339101049;1521.33821787525;1536.3393740691386;1539.638185026518;25712;27353.45293094167;27366.179014629593;27424;28271.434571308047;45941.54058459373;46050.76974615239;46052;46132.30801537912;46355;338427;339409;340880;342124;344061;28005.439891201655;28343.43313133767;28381.290467737646;28436.715632844236;28573;37102.44346334753;37289.81355093207;37540.87377378683;37768.97848172195;38149.61850381461;29641;29707.257318567208;29736.405271894007;29938.401231975673;29990.55014174833;28900.213710340093;28993.710062899943;28997.565036524047;29546.81812727467;29638.703612963593;33209.83395083009;33269.00192994117;33521;33702;34356.14109647279;27788.722112779422;28067.859660701564;28198.295042624097;28611.570826438037;29022.709772902846;23437.882810585837;23534.29397118089;23939.76060239445;23981.76018239865;24916.875415622806 03:16:25 INFO - PROCESS | 25995 | |2;jquery.html;405.7707395321645;458.5829785961379;467.2687244462416;470.38849495655637;482.6452557370333;19411.611767764654;19885.502862428428;20278.89860550697;21106.89446552765;21319.786802131974;19044.428667139975;19434.805651943476;19486.707699384486;19616.117274722637;20292.797072029276;6100.664463454508;6669.266380698132;6745.3254674532645;6771.796846094625;6780.627065511395;7760.844783104335;7898.447108702364;7899;7911.643976021064;7913.604319784016;7472.962635186844;7570.507916985406;7595.696172153107;7599.088109426876;7783.4162437817395;7689.423293252972;7729.072511298652;7731.342835858931;7769.417293702995;7798.64906079225;7472.775816725507;7653.349465295457;7684.001079859582;7685.923140768577;7696.499727517749;20807.8959605201;21122.366329010154;21161;24225.757742422702;24845.254642360756;3040.3463255399975;3075.3234288456506;3138.3095718941795;3357.8824741134185;3429.7599168058246;15765;15910.920445397698;16053.839461605352;16835.83164168367;16894.577635559086;2316.490372118148;2359.445530300378;2360.2211270280936;2390.3307074019303;2402.8558286502866;106510;115197;115576.42211788887;127612.36193819065;131632.34183829115;14683.574661989893;17430.564235894206;17439.389621363192;18199.818001820076;18206.180721867284;32647.183820404203;32657.51013734796;32663.346733065206;32795.83602081974;33212.169695757315;10612.893871061191;10795.136389088853;10839.078678312431;11031.117510599133;11056.723581910517;9020.81958360829;9046.592903319366;9066.320025998077;9237.12247336502;9288.907110928803;9158.771030724285;9471;9625.085616866527;9636.036396360309;9757.170640495495;3438.2951494943477;3509.8420571073852;3566.4293713006314;3804.2962052020466;3852.1332700142243;958.5734348214977;969.2633598465217;975.6195083917278;982.0376031489038;987.9061489158519;20876.164953401996;22650.66024009641;23298.883505582704;23709.17017904365;23783;1111.2665640677114;1120.5349779841274;1131.3890499130378;1133.3653154233655;1134.7957367673732;11882.524699011943;11924.761504769856;12083.879161208451;12129.21160124589;12193.146479746332;337350;339007;339625;401829;784332;119905;120526;122649.38675306566;122786;123501.38249308875;1288.3944546063335;1315.368623060917;1331.900107491942;1344.9125806822526;1355.525566051874;14963.326650300545;19957.60084798325;20085.598288033867;20239;20318.898405507876;38101.66644167441;39745.80127099462;48256;53461.73269133629;54107;63988.36011639824;64212;64599;64837.67581162064;64929.35070649422;12117;13124.606261812161;13246.271455070064;13454.125481843648;13552.661183470493;14234;14413.7837932429;14534.345954431865;14547;14742.26288685583;12185.451654675384;12279.69300767488;12368.505259789868;12432.191907525981;12890.871091289342;11101.945315195044;11246.381449020382;11867.109966752356;11872.228305160137;11905.404729763304;12814.423350949417;12855.16441431304;13101.082924195596;13164.670883227613;13350;13006.609801705965;13045.673858153623;13147.211167329991;13246.891528139473;13521.459141634225;12447.439865206268;12530.185537940004;12608.243505389706;12652.87347126517;13077.738445231233 03:16:25 INFO - PROCESS | 25995 | |3;mootools.html;1538.9461368852092;1558.6648870492843;1559.688062387522;1566.8824838137139;1582.794236749223;10884.455777211137;11721.70695732607;11725;11729.589464368748;11733.47199376028;10799.83800242997;10935.83596246057;10942.726431839208;10957.232993690444;11405.14461415393;2468.3582268610157;2518.672572565573;2540.123657338225;2543.4277287610325;2550.1966880432697;2386.2721869829693;2426.708794944609;2480.2435257246534;2481;2481.751824817513;2400.1119585753295;2413.6862207913036;2446.7920226780657;2451.3258853815164;2457.8402403843784;2369.3958040699686;2394.988025059872;2411.577973854577;2411.819113566472;2421.7336093029753;2325.2210509479346;2418.6855708757926;2420.5521978434044;2425.6967879015124;2426.8543887366814;11520.654380368602;11584.536618535249;11608.129390295762;11610.477528511237;11647.301161930227;5940.851478713023;6023.247094113236;6040.456358927674;6044.153818465418;6116;3583.964160358389;3595.4247320428867;3653.5798383186007;3681.3925702259094;3739.4016957286703;1382.2950295349344;2271.965920511194;2322;2338.438774694061;2375.10933399975;15310.234488275542;15708.842911570966;16997.235124419432;17535.386261480915;17561.29754809806;4873.366462359942;4940.135476291634;4976.154053810861;4977.601791856643;5023.397192336943;13128.934355328352;13149.737005260033;13158.078934474686;13165.67085822843;13168.73662526744;5803.7968671096305;5852.648841069549;5865.501432378211;5872.324682661463;5872.970635146797;5273.973630131824;5423.18652202165;5484.643498172606;5531.446855314517;5533.584981126432;4095.7130804215385;4100.446439730657;4176.707630465899;4214.452121224222;4217.894552636148;1034.1623285139062;1044.253358848427;1052.910502607287;1064.084886997182;1064.8775390829999;1002.0931057393071;1012.7215015870695;1014.2697257974247;1014.9949250253701;1022.3048327137618;6853.623050732258;6907.896381554281;6910.550814197061;6961.060256865258;7016.438684905195;1042.4735508568124;1055.3404122423485;1060.7666313411037;1079.0989523747758;1091.8089334366455;4625.907481850411;4645.465771436328;4665.183592871302;4726.456457507362;4741;14513.492027778977;15105.244737763069;15114.773278400833;15117.622059448382;15129.39482420691;13972;14841.925790370979;14861.331240094221;14872.92563537197;14984.250787460584;9126.498042607587;9385.202257808027;10653.573857045787;10829.783404331869;10907.29102608328;7177.246389129066;7411.444141689287;7456.142543607554;7502.962485187539;7606.543607383574;12548;12561.87438125607;12665.81001285;12853.678658033625;12937.223766574036;12782.68043298925;13560.93219533896;13737.931310343385;13776.380062897395;13779.035467517178;9946.4529450878;10094.041066098709;10156.593736250763;10195.082442579907;10208.336458130198;10947.397893115955;10949.945250273699;11019.44902754843;11099.112071034137;11131.554737810397;9327.160555550034;9360.765980850534;9389.38968967015;9430.339876208875;9515.619375224913;9118;9159.22146617545;9203.539823008688;9216.032316606928;9347.579358928728;8688.435251708872;8822.161894620001;8890.911090889267;8925.776855578662;8935.419197752126;6266.185395898504;6318.526110541636;6509.609423434609;6514.088027676224;6576.802695918938;6415.0377443382;6422;6464.612123272431;6497.415232628897;6576.572522786004 03:16:25 INFO - PROCESS | 25995 | |4;prototype.html;404.6418919256457;409.6681687832856;424.13264873334026;431.84021911892603;435.18620180262906;5147.356580427447;5237.45006774288;5369.9731501342485;5377.247185394048;5388.434214407484;5130.589552835773;5261.552768014713;5266.394364648067;5267.710275934822;5271.209318602211;4588.632909367259;4611.33135695324;4615.907681846361;4619.399478067847;4619.937414394692;4269.594388533084;4402.336586365251;4461.06317673289;4635.427337827505;4678.602318802906;4430.474629461209;4443.134178454895;4458.821647134111;4460.50934397216;4471.754053527055;4456.55434456555;4469.463664360265;4489.955100448987;4491.371208030879;4523.11799199153;3957.3866050762176;4138.875833724963;4241.681873859442;4242.2576049191575;4246.44796176495;5069.352460450332;5103.923441148386;5106.183010718267;5108.770105345268;5126.897462050775;5139.640225184238;5151.407588127376;5177.834987127903;5185.325907632021;5199.454057324002;5309.309789727311;5480.287562616874;5520.834374968757;5601.915971260434;5609.382967873531;4603.907921841578;4635.327877457784;4641.535846415365;4641.907161856778;4665.640738668153;5756.712164391805;5821.563382746311;5835.387284335126;5851.3270973838125;5853.239078919756;4640.280756482751;4710.81156753726;4739.976300118477;4765.642576806753;4789.161896668069;4820.927686084711;4834.081524510332;4850.223964165716;4850.296706977469;4889.9486610378935;5159.174532074925;5190.2993095932325;5198.7140707260705;5231.921521177185;5234.293370395024;5364.517193452608;5392.272043274108;5477;5616.438356164433;5652.858678532987;1605.5103193525854;1626.406361677979;1667.9416220432227;1678.446112782803;1681.5370627554107;1246.7194881151668;1282.4870051979096;1282.660095074806;1299.1036185032485;1300.2458574027041;5464.207689884945;5501.532369748536;5520.420355862577;5556.444355564411;5565.7217139143695;5615.775368985276;5699.886002279931;5706.80026199081;5711.571632127607;5767.68277744728;5231.895362092737;5462.562994960394;5503.229547863302;5509.00837849191;5569.248151499496;3003.903575195082;3004.369082492701;3008.6389633244153;3009.2627306310096;3032.3935212957495;5663.886722265532;5918.260217472816;5934.139549765347;5947.702614869239;5955.27795128045;5787.218725472091;5795.88408231833;5823.94176058234;5843.678597677083;5845.853853653608;5968.850778730566;5992.610480318765;5998.520118390518;6019.374768812396;6036.788712395045;5460.754266058117;5660.264165658438;5734.3978882218435;5747.655140691572;5762.625429347079;5637.408072152365;5663.895540369588;5665.886682266414;5679.409765265732;5729.197912292199;5833.591648584558;5900.6515936567275;6036.849078773066;6057.969710151421;6067.635941843327;4784.545468180518;4810.230363141881;4828.830990915301;4831.806727730851;4833.41998960113;5536.695481748542;5649.604527683023;5661.773529058792;5776.180503141497;5797.333306669787;5528.917066243929;5589.748461319332;5607.579431542569;5635.887282254414;5665.971670141623;5581.358143813513;5584.916226256691;5593.272874526286;5593.580481463988;5608.943910560843;5329.840104796862;5618.52242559387;5619.49424551776;5623.465770751772;5625.578081643975;5587.77648894056;5642.996736158605;5645.71771411436;5660.801871934463;5671.780567178076;5363.946360536344;5474.23598061514;5479.945200548103;5485.753141108739;5560.694161821139 03:16:25 INFO - PROCESS | 25995 | |5;yui.html;841.4404421059987;868.1882439918677;925.6158694141927;938.5635679409073;939.4691999020553;17311.22099505522;17875.821241787577;17881.731774023367;17907.37324193652;17972.28110875565;13380.330983450836;16810.747838782427;16945.745813812802;16989;17019.82980170198;895.0333639669158;924.5284904698585;927.4528028463205;928.1275600935134;928.3965422475411;907.1790030022839;907.6369452219133;908.0284096017264;908.7864351877304;911.43946472919;961.4663861556833;961.8653388525612;963.2631037256505;963.3593660215948;963.7927845513213;959.94720290384;960.3085778239727;960.6205548808216;960.7934294126761;961.653804630336;697.9685914133826;700.7442283566462;700.8528209076101;701.3162166887245;701.424831638057;16572.337106515726;16590.50228493135;16607.50177494677;16655.25051372691;16665.083420411873;16826.24281907317;16932.746008809878;17091.390360812737;17513;17638.206280717397;14033.298335083206;14111.929440352835;14179.574612761531;14198.432062717478;14238;4091.8158682859344;4107.67138628909;4127.8968025799295;4169.624733773975;4228.556001619816;85354.57322713471;86594.56702716509;86737;87729;88755.11244887533;13332.133411328232;13486.730265394637;13540.119892207173;13546.864531354757;13741.587752367444;25533;25907.870460647577;26099.869500652756;26196.345091372867;26241.34396640061;9019.368644194843;9028.909710902939;9305.162535371848;9345.672901448417;9367.437953722661;4852.369192005087;4936.037472692862;5006.6495345325475;5010.498950105033;5128.282040514331;3782.867599634055;3881.2043531076624;3881.4760007399204;3882.80585970706;3886.902827429337;650.0606623429194;659.5976454362835;680.0920770770978;680.4692339974828;684.6953105867841;724.1310427487036;744.8770952792728;754.792432081182;761.6115780951644;764.399946042354;10531.578736850593;10653.73365665849;10671.25301228922;10741.946290268656;10900.618478353219;652.9151210342625;661.2197606823897;673.2594146438878;678.2335960364757;683.4668958212602;5209.192575150858;5304.761285742151;5342.145256758978;5378.704171270618;5400.324959380077;75425.62287188639;77146.6142669283;78052.60973695095;78743.21256787474;79567;73220;73295;74659;75143.62428187823;77416;59254.40745592575;62709.68645156745;63152.138247840136;63251.683741581;63541;10073.949630251802;10261.74345641365;10321.225908056776;10339.483025848827;10384.584616615553;42518.5748142527;42895;43572.56427435685;44108;45094.32358514559;50651;50751;51158.74420627873;51410;52646.21030684466;12336.50653973831;12337.753244935231;12477.93761031189;12630.810537842124;12719.173253738478;13705.862941370458;13878.097923634932;13988.37052332668;14085.859141408455;14126.50557230492;11136.10911127124;11282.323060616389;11289.548418063185;11305.208635395444;11489.465339251405;12304.600602882352;12482.75034499323;12486.625401237978;12491.125621206791;12619.053570982396;12564.811527826907;12682.746345072863;12692.936535317263;12694.492220311084;12700.301483418501;9735.561899714672;9803.460809655537;9831.705048848546;9861.408315501092;10044.748881278027;10474.319169253975;10553.472326383497;10586.8941310589;10624.309419887682;10632.681019569425 03:16:25 INFO - PROCESS | 25995 | __end_tp_report 03:16:25 INFO - PROCESS | 25995 | __start_cc_report 03:16:25 INFO - PROCESS | 25995 | _x_x_mozilla_cycle_collect,1282 03:16:25 INFO - PROCESS | 25995 | __end_cc_report 03:16:25 INFO - PROCESS | 25995 | __startTimestamp1492510585243__endTimestamp 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | ------- Summary: start ------- 03:16:25 INFO - PROCESS | 25995 | Number of tests: 6 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#0] dojo.html Cycles:165 Average:5624.98 Median:5797.65 stddev:623.43 (10.8%) stddev-sans-first:599.52 03:16:25 INFO - PROCESS | 25995 | Values: 3361.7 3387.9 3394.9 3405.8 3429.5 5564.3 5632.7 5650.0 5658.3 5658.5 5672.2 5682.1 5716.6 5739.2 5743.9 5168.0 5174.0 5179.5 5198.0 5235.5 5019.6 5275.1 5282.2 5288.1 5319.9 5067.9 5119.1 5140.2 5212.6 5215.5 5217.5 5249.8 5254.8 5257.6 5260.5 5092.6 5149.3 5199.7 5200.5 5234.6 5479.6 5481.9 5531.9 5539.7 5542.6 5929.9 5936.1 5973.7 5989.0 6012.8 5918.5 5921.1 5931.0 5942.5 6007.5 5450.0 5490.3 5608.9 5659.9 5677.4 6167.5 6167.9 6182.4 6186.0 6203.9 5846.8 5950.3 5951.8 5965.0 5991.3 5797.7 5832.3 6004.8 6081.3 6099.1 6073.6 6076.1 6078.1 6095.5 6095.7 5722.6 5779.7 5779.8 6002.3 6025.5 4573.1 4610.8 4615.8 4633.4 4640.9 4158.5 4188.0 4193.4 4193.7 4202.1 5611.1 5669.1 5769.8 5795.5 5878.7 5997.8 6014.3 6016.9 6020.8 6053.0 5833.2 5858.2 5865.2 5867.2 5871.1 4974.7 5007.7 5115.1 5147.9 5173.8 6427.6 6441.3 6445.7 6451.8 6455.5 6113.8 6174.8 6176.0 6179.4 6181.3 6066.0 6113.0 6298.6 6365.1 6417.6 5979.6 6017.4 6044.8 6047.5 6053.5 6152.2 6152.6 6159.1 6161.1 6174.5 5646.5 5722.5 5980.8 5992.3 5992.5 5853.9 5873.0 5935.5 5945.9 5992.7 5884.0 5926.2 5931.9 5944.3 5944.8 5697.0 5728.1 5756.7 5901.6 5927.7 5743.1 5750.2 5780.1 5783.4 5795.6 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#1] ext.html Cycles:180 Average:45173.31 Median:160545.85 stddev:76303.75 (47.5%) stddev-sans-first:76444.93 03:16:25 INFO - PROCESS | 25995 | Values: 757.7 821.7 838.6 882.6 896.8 31319.2 42471.4 43104.6 43136.4 43149.0 45698.5 46149.0 46169.5 46191.0 46211.3 7750.4 7874.9 9239.5 9370.5 9370.7 10676.7 10730.7 11244.5 11254.5 11277.1 10973.8 11012.1 11031.8 11031.8 11033.4 10897.3 10919.5 10920.9 10956.6 10964.6 10712.9 10732.2 10776.4 10776.5 10778.5 41934.0 42299.8 42311.8 42332.4 42481.8 4255.9 4293.2 4333.8 4423.4 4439.9 28854.9 29064.9 29183.7 29805.7 30445.4 4200.6 4294.7 4345.8 4364.4 4409.6 229794.0 230549.0 231078.0 231712.0 232641.5 51324.7 51331.2 51413.2 51477.0 51568.7 54247.7 54354.7 54445.2 54464.0 54543.5 16476.8 16825.3 16829.9 16839.6 16871.4 11805.4 11977.3 14992.1 14997.5 15061.6 12885.4 12916.3 13059.5 13182.3 13444.3 5580.6 5594.9 5612.1 5649.4 5695.9 1020.8 1022.7 1026.1 1033.4 1034.2 28245.9 28484.7 28596.6 28669.7 28995.3 1073.6 1083.9 1099.7 1104.3 1105.6 14061.5 14901.4 15125.7 15131.0 15195.8 291908.0 292018.0 292040.0 292391.0 293448.0 54803.2 54850.0 54891.0 54898.5 55122.2 1493.8 1500.4 1521.3 1536.3 1539.6 25712.0 27353.5 27366.2 27424.0 28271.4 45941.5 46050.8 46052.0 46132.3 46355.0 338427.0 339409.0 340880.0 342124.0 344061.0 28005.4 28343.4 28381.3 28436.7 28573.0 37102.4 37289.8 37540.9 37769.0 38149.6 29641.0 29707.3 29736.4 29938.4 29990.6 28900.2 28993.7 28997.6 29546.8 29638.7 33209.8 33269.0 33521.0 33702.0 34356.1 27788.7 28067.9 28198.3 28611.6 29022.7 23437.9 23534.3 23939.8 23981.8 24916.9 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#2] jquery.html Cycles:180 Average:31838.82 Median:21114.63 stddev:79975.70 (378.8%) stddev-sans-first:80165.23 03:16:25 INFO - PROCESS | 25995 | Values: 405.8 458.6 467.3 470.4 482.6 19411.6 19885.5 20278.9 21106.9 21319.8 19044.4 19434.8 19486.7 19616.1 20292.8 6100.7 6669.3 6745.3 6771.8 6780.6 7760.8 7898.4 7899.0 7911.6 7913.6 7473.0 7570.5 7595.7 7599.1 7783.4 7689.4 7729.1 7731.3 7769.4 7798.6 7472.8 7653.3 7684.0 7685.9 7696.5 20807.9 21122.4 21161.0 24225.8 24845.3 3040.3 3075.3 3138.3 3357.9 3429.8 15765.0 15910.9 16053.8 16835.8 16894.6 2316.5 2359.4 2360.2 2390.3 2402.9 106510.0 115197.0 115576.4 127612.4 131632.3 14683.6 17430.6 17439.4 18199.8 18206.2 32647.2 32657.5 32663.3 32795.8 33212.2 10612.9 10795.1 10839.1 11031.1 11056.7 9020.8 9046.6 9066.3 9237.1 9288.9 9158.8 9471.0 9625.1 9636.0 9757.2 3438.3 3509.8 3566.4 3804.3 3852.1 958.6 969.3 975.6 982.0 987.9 20876.2 22650.7 23298.9 23709.2 23783.0 1111.3 1120.5 1131.4 1133.4 1134.8 11882.5 11924.8 12083.9 12129.2 12193.1 337350.0 339007.0 339625.0 401829.0 784332.0 119905.0 120526.0 122649.4 122786.0 123501.4 1288.4 1315.4 1331.9 1344.9 1355.5 14963.3 19957.6 20085.6 20239.0 20318.9 38101.7 39745.8 48256.0 53461.7 54107.0 63988.4 64212.0 64599.0 64837.7 64929.4 12117.0 13124.6 13246.3 13454.1 13552.7 14234.0 14413.8 14534.3 14547.0 14742.3 12185.5 12279.7 12368.5 12432.2 12890.9 11101.9 11246.4 11867.1 11872.2 11905.4 12814.4 12855.2 13101.1 13164.7 13350.0 13006.6 13045.7 13147.2 13246.9 13521.5 12447.4 12530.2 12608.2 12652.9 13077.7 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#3] mootools.html Cycles:180 Average:7216.17 Median:2419.62 stddev:4532.61 (187.3%) stddev-sans-first:4525.25 03:16:25 INFO - PROCESS | 25995 | Values: 1538.9 1558.7 1559.7 1566.9 1582.8 10884.5 11721.7 11725.0 11729.6 11733.5 10799.8 10935.8 10942.7 10957.2 11405.1 2468.4 2518.7 2540.1 2543.4 2550.2 2386.3 2426.7 2480.2 2481.0 2481.8 2400.1 2413.7 2446.8 2451.3 2457.8 2369.4 2395.0 2411.6 2411.8 2421.7 2325.2 2418.7 2420.6 2425.7 2426.9 11520.7 11584.5 11608.1 11610.5 11647.3 5940.9 6023.2 6040.5 6044.2 6116.0 3584.0 3595.4 3653.6 3681.4 3739.4 1382.3 2272.0 2322.0 2338.4 2375.1 15310.2 15708.8 16997.2 17535.4 17561.3 4873.4 4940.1 4976.2 4977.6 5023.4 13128.9 13149.7 13158.1 13165.7 13168.7 5803.8 5852.6 5865.5 5872.3 5873.0 5274.0 5423.2 5484.6 5531.4 5533.6 4095.7 4100.4 4176.7 4214.5 4217.9 1034.2 1044.3 1052.9 1064.1 1064.9 1002.1 1012.7 1014.3 1015.0 1022.3 6853.6 6907.9 6910.6 6961.1 7016.4 1042.5 1055.3 1060.8 1079.1 1091.8 4625.9 4645.5 4665.2 4726.5 4741.0 14513.5 15105.2 15114.8 15117.6 15129.4 13972.0 14841.9 14861.3 14872.9 14984.3 9126.5 9385.2 10653.6 10829.8 10907.3 7177.2 7411.4 7456.1 7503.0 7606.5 12548.0 12561.9 12665.8 12853.7 12937.2 12782.7 13560.9 13737.9 13776.4 13779.0 9946.5 10094.0 10156.6 10195.1 10208.3 10947.4 10949.9 11019.4 11099.1 11131.6 9327.2 9360.8 9389.4 9430.3 9515.6 9118.0 9159.2 9203.5 9216.0 9347.6 8688.4 8822.2 8890.9 8925.8 8935.4 6266.2 6318.5 6509.6 6514.1 6576.8 6415.0 6422.0 6464.6 6497.4 6576.6 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#4] prototype.html Cycles:180 Average:4881.28 Median:5364.23 stddev:1298.80 (24.2%) stddev-sans-first:1258.23 03:16:25 INFO - PROCESS | 25995 | Values: 404.6 409.7 424.1 431.8 435.2 5147.4 5237.5 5370.0 5377.2 5388.4 5130.6 5261.6 5266.4 5267.7 5271.2 4588.6 4611.3 4615.9 4619.4 4619.9 4269.6 4402.3 4461.1 4635.4 4678.6 4430.5 4443.1 4458.8 4460.5 4471.8 4456.6 4469.5 4490.0 4491.4 4523.1 3957.4 4138.9 4241.7 4242.3 4246.4 5069.4 5103.9 5106.2 5108.8 5126.9 5139.6 5151.4 5177.8 5185.3 5199.5 5309.3 5480.3 5520.8 5601.9 5609.4 4603.9 4635.3 4641.5 4641.9 4665.6 5756.7 5821.6 5835.4 5851.3 5853.2 4640.3 4710.8 4740.0 4765.6 4789.2 4820.9 4834.1 4850.2 4850.3 4889.9 5159.2 5190.3 5198.7 5231.9 5234.3 5364.5 5392.3 5477.0 5616.4 5652.9 1605.5 1626.4 1667.9 1678.4 1681.5 1246.7 1282.5 1282.7 1299.1 1300.2 5464.2 5501.5 5520.4 5556.4 5565.7 5615.8 5699.9 5706.8 5711.6 5767.7 5231.9 5462.6 5503.2 5509.0 5569.2 3003.9 3004.4 3008.6 3009.3 3032.4 5663.9 5918.3 5934.1 5947.7 5955.3 5787.2 5795.9 5823.9 5843.7 5845.9 5968.9 5992.6 5998.5 6019.4 6036.8 5460.8 5660.3 5734.4 5747.7 5762.6 5637.4 5663.9 5665.9 5679.4 5729.2 5833.6 5900.7 6036.8 6058.0 6067.6 4784.5 4810.2 4828.8 4831.8 4833.4 5536.7 5649.6 5661.8 5776.2 5797.3 5528.9 5589.7 5607.6 5635.9 5666.0 5581.4 5584.9 5593.3 5593.6 5608.9 5329.8 5618.5 5619.5 5623.5 5625.6 5587.8 5643.0 5645.7 5660.8 5671.8 5363.9 5474.2 5479.9 5485.8 5560.7 03:16:25 INFO - PROCESS | 25995 | 03:16:25 INFO - PROCESS | 25995 | [#5] yui.html Cycles:180 Average:18269.85 Median:24973.35 stddev:23188.38 (92.9%) stddev-sans-first:23216.50 03:16:25 INFO - PROCESS | 25995 | Values: 841.4 868.2 925.6 938.6 939.5 17311.2 17875.8 17881.7 17907.4 17972.3 13380.3 16810.7 16945.7 16989.0 17019.8 895.0 924.5 927.5 928.1 928.4 907.2 907.6 908.0 908.8 911.4 961.5 961.9 963.3 963.4 963.8 959.9 960.3 960.6 960.8 961.7 698.0 700.7 700.9 701.3 701.4 16572.3 16590.5 16607.5 16655.3 16665.1 16826.2 16932.7 17091.4 17513.0 17638.2 14033.3 14111.9 14179.6 14198.4 14238.0 4091.8 4107.7 4127.9 4169.6 4228.6 85354.6 86594.6 86737.0 87729.0 88755.1 13332.1 13486.7 13540.1 13546.9 13741.6 25533.0 25907.9 26099.9 26196.3 26241.3 9019.4 9028.9 9305.2 9345.7 9367.4 4852.4 4936.0 5006.6 5010.5 5128.3 3782.9 3881.2 3881.5 3882.8 3886.9 650.1 659.6 680.1 680.5 684.7 724.1 744.9 754.8 761.6 764.4 10531.6 10653.7 10671.3 10741.9 10900.6 652.9 661.2 673.3 678.2 683.5 5209.2 5304.8 5342.1 5378.7 5400.3 75425.6 77146.6 78052.6 78743.2 79567.0 73220.0 73295.0 74659.0 75143.6 77416.0 59254.4 62709.7 63152.1 63251.7 63541.0 10073.9 10261.7 10321.2 10339.5 10384.6 42518.6 42895.0 43572.6 44108.0 45094.3 50651.0 50751.0 51158.7 51410.0 52646.2 12336.5 12337.8 12477.9 12630.8 12719.2 13705.9 13878.1 13988.4 14085.9 14126.5 11136.1 11282.3 11289.5 11305.2 11489.5 12304.6 12482.8 12486.6 12491.1 12619.1 12564.8 12682.7 12692.9 12694.5 12700.3 9735.6 9803.5 9831.7 9861.4 10044.7 10474.3 10553.5 10586.9 10624.3 10632.7 03:16:25 INFO - PROCESS | 25995 | -------- Summary: end -------- 03:16:25 INFO - PROCESS | 25995 | 03:16:26 INFO - TEST-INFO | 25995: exit 0 03:16:26 INFO - TEST-OK | dromaeo_css | took 1114898ms 03:16:26 INFO - TEST-START | kraken 03:16:26 INFO - operating with platform_type : linux_ 03:16:26 INFO - Initialising browser for kraken test... 03:16:26 INFO - TEST-INFO | started process 26317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3HQs6/profile http://localhost:41793/getInfo.html) 03:16:30 INFO - PROCESS | 26317 | __metrics Screen width/height:1600/1200 03:16:30 INFO - PROCESS | 26317 | colorDepth:24 03:16:30 INFO - PROCESS | 26317 | Browser inner width/height: 1024/697 03:16:30 INFO - PROCESS | 26317 | __metrics 03:16:30 INFO - PROCESS | 26317 | 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" 03:16:30 INFO - PROCESS | 26317 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:31 INFO - TEST-INFO | 26317: exit 0 03:16:31 INFO - Browser initialized. 03:16:31 INFO - Running cycle 1/1 for kraken test... 03:16:31 INFO - TEST-INFO | started process 26409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv3HQs6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:43 INFO - PROCESS | 26409 | RSS: Main: 139370496 03:16:43 INFO - PROCESS | 26409 | 03:16:46 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41793/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:46 INFO - PROCESS | 26409 | RSS: Main: 183545856 03:16:46 INFO - PROCESS | 26409 | 03:16:49 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41793/tests/kraken/driver.html?testName=audio-dft) 03:16:50 INFO - PROCESS | 26409 | RSS: Main: 173961216 03:16:50 INFO - PROCESS | 26409 | 03:16:52 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41793/tests/kraken/driver.html?testName=audio-fft) 03:16:53 INFO - PROCESS | 26409 | RSS: Main: 265474048 03:16:53 INFO - PROCESS | 26409 | 03:16:55 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41793/tests/kraken/driver.html?testName=audio-oscillator) 03:16:56 INFO - PROCESS | 26409 | RSS: Main: 171823104 03:16:56 INFO - PROCESS | 26409 | 03:16:58 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:58 INFO - PROCESS | 26409 | RSS: Main: 174612480 03:16:58 INFO - PROCESS | 26409 | 03:17:01 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41793/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:02 INFO - PROCESS | 26409 | RSS: Main: 213159936 03:17:02 INFO - PROCESS | 26409 | 03:17:05 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41793/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:06 INFO - PROCESS | 26409 | RSS: Main: 212119552 03:17:06 INFO - PROCESS | 26409 | 03:17:09 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41793/tests/kraken/driver.html?testName=json-parse-financial) 03:17:09 INFO - PROCESS | 26409 | RSS: Main: 210055168 03:17:09 INFO - PROCESS | 26409 | 03:17:11 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:11 INFO - PROCESS | 26409 | RSS: Main: 172687360 03:17:11 INFO - PROCESS | 26409 | 03:17:13 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:14 INFO - PROCESS | 26409 | RSS: Main: 179130368 03:17:14 INFO - PROCESS | 26409 | 03:17:16 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:16 INFO - PROCESS | 26409 | RSS: Main: 189173760 03:17:16 INFO - PROCESS | 26409 | 03:17:19 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:20 INFO - PROCESS | 26409 | RSS: Main: 198610944 03:17:20 INFO - PROCESS | 26409 | 03:17:22 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:23 INFO - PROCESS | 26409 | RSS: Main: 194211840 03:17:23 INFO - PROCESS | 26409 | 03:17:24 INFO - PROCESS | 26409 | Cycle 1(1): loaded http://localhost:41793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41793/tests/kraken/driver.html?testName=ai-astar) 03:17:25 INFO - PROCESS | 26409 | RSS: Main: 246616064 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | __start_tp_report 03:17:25 INFO - PROCESS | 26409 | _x_x_mozilla_page_load 03:17:25 INFO - PROCESS | 26409 | _x_x_mozilla_page_load_details 03:17:25 INFO - PROCESS | 26409 | |i|pagename|runs| 03:17:25 INFO - PROCESS | 26409 | |0;ai-astar;102;112;113;113;112;112;111;112;112;113 03:17:25 INFO - PROCESS | 26409 | |1;audio-beat-detection;140;119;116;154;115;117;118;122;138;118 03:17:25 INFO - PROCESS | 26409 | |2;audio-dft;161;161;161;160;161;162;162;160;160;160 03:17:25 INFO - PROCESS | 26409 | |3;audio-fft;73;74;76;108;76;76;75;76;96;76 03:17:25 INFO - PROCESS | 26409 | |4;audio-oscillator;83;83;101;81;82;82;104;83;83;100 03:17:25 INFO - PROCESS | 26409 | |5;imaging-gaussian-blur;113;113;113;113;114;113;113;113;115;113 03:17:25 INFO - PROCESS | 26409 | |6;imaging-darkroom;147;147;146;147;147;147;147;147;148;148 03:17:25 INFO - PROCESS | 26409 | |7;imaging-desaturate;94;94;94;95;93;94;94;94;94;94 03:17:25 INFO - PROCESS | 26409 | |8;json-parse-financial;54;55;55;55;54;56;55;56;56;57 03:17:25 INFO - PROCESS | 26409 | |9;json-stringify-tinderbox;55;55;53;56;54;53;54;54;54;54 03:17:25 INFO - PROCESS | 26409 | |10;stanford-crypto-aes;75;79;76;79;84;81;76;76;75;76 03:17:25 INFO - PROCESS | 26409 | |11;stanford-crypto-ccm;130;124;122;135;120;119;118;128;158;140 03:17:25 INFO - PROCESS | 26409 | |12;stanford-crypto-pbkdf2;159;158;160;161;157;163;157;158;157;158 03:17:25 INFO - PROCESS | 26409 | |13;stanford-crypto-sha256-iterative;60;60;61;60;59;59;60;59;59;58 03:17:25 INFO - PROCESS | 26409 | __end_tp_report 03:17:25 INFO - PROCESS | 26409 | __start_cc_report 03:17:25 INFO - PROCESS | 26409 | _x_x_mozilla_cycle_collect,1681 03:17:25 INFO - PROCESS | 26409 | __end_cc_report 03:17:25 INFO - PROCESS | 26409 | __startTimestamp1492510645233__endTimestamp 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | ------- Summary: start ------- 03:17:25 INFO - PROCESS | 26409 | Number of tests: 14 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.29 (2.9%) stddev-sans-first:0.67 03:17:25 INFO - PROCESS | 26409 | Values: 102.0 112.0 113.0 113.0 112.0 112.0 111.0 112.0 112.0 113.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:120.50 stddev:13.41 (11.1%) stddev-sans-first:13.19 03:17:25 INFO - PROCESS | 26409 | Values: 140.0 119.0 116.0 154.0 115.0 117.0 118.0 122.0 138.0 118.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:17:25 INFO - PROCESS | 26409 | Values: 161.0 161.0 161.0 160.0 161.0 162.0 162.0 160.0 160.0 160.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:11.67 (15.4%) stddev-sans-first:12.05 03:17:25 INFO - PROCESS | 26409 | Values: 73.0 74.0 76.0 108.0 76.0 76.0 75.0 76.0 96.0 76.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:82.50 stddev:9.37 (11.4%) stddev-sans-first:9.74 03:17:25 INFO - PROCESS | 26409 | Values: 83.0 83.0 101.0 81.0 82.0 82.0 104.0 83.0 83.0 100.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:17:25 INFO - PROCESS | 26409 | Values: 113.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 115.0 113.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:17:25 INFO - PROCESS | 26409 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:17:25 INFO - PROCESS | 26409 | Values: 94.0 94.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:0.95 (1.7%) stddev-sans-first:0.88 03:17:25 INFO - PROCESS | 26409 | Values: 54.0 55.0 55.0 55.0 54.0 56.0 55.0 56.0 56.0 57.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 03:17:25 INFO - PROCESS | 26409 | Values: 55.0 55.0 53.0 56.0 54.0 53.0 54.0 54.0 54.0 54.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.98 (3.8%) stddev-sans-first:3.00 03:17:25 INFO - PROCESS | 26409 | Values: 75.0 79.0 76.0 79.0 84.0 81.0 76.0 76.0 75.0 76.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:129.00 stddev:12.36 (9.6%) stddev-sans-first:13.11 03:17:25 INFO - PROCESS | 26409 | Values: 130.0 124.0 122.0 135.0 120.0 119.0 118.0 128.0 158.0 140.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:158.50 stddev:1.99 (1.3%) stddev-sans-first:2.11 03:17:25 INFO - PROCESS | 26409 | Values: 159.0 158.0 160.0 161.0 157.0 163.0 157.0 158.0 157.0 158.0 03:17:25 INFO - PROCESS | 26409 | 03:17:25 INFO - PROCESS | 26409 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 03:17:25 INFO - PROCESS | 26409 | Values: 60.0 60.0 61.0 60.0 59.0 59.0 60.0 59.0 59.0 58.0 03:17:25 INFO - PROCESS | 26409 | -------- Summary: end -------- 03:17:25 INFO - PROCESS | 26409 | 03:17:26 INFO - TEST-INFO | 26409: exit 0 03:17:26 INFO - TEST-OK | kraken | took 60312ms 03:17:26 INFO - SUITE-END | took 1175s 03:17:26 INFO - Completed test suite (00:19:35) 03:17:26 INFO - javascript benchmark 03:17:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7825.145303721498, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.7310615150786, 3387.8814241501555, 3394.881179158728, 3405.795652260863, 3429.4684323929782, 5564.304461942257, 5632.690202038886, 5650.039493286141, 5658.349289831665, 5658.547316214693, 5672.17753425753, 5682.090865461527, 5716.57125715572, 5739.225204597378, 5743.942560574393, 5168.043911876296, 5174.042802081608, 5179.456157103516, 5198.0, 5235.450277720842, 5019.598432125421, 5275.129603615399, 5282.23407605897, 5288.0745869472885, 5319.867003324909, 5067.898642027176, 5119.129747942859, 5140.177571588547, 5212.635115541913, 5215.478452154792, 5217.50433708797, 5249.763760630762, 5254.789808407659, 5257.631965762398, 5260.526552610245, 5092.6180536459915, 5149.30484384607, 5199.714015729133, 5200.531952124289, 5234.581233501349, 5479.561635069185, 5481.862953426156, 5531.861703457445, 5539.723013849331, 5542.612017158801, 5929.851753706192, 5936.050231962909, 5973.701314934236, 5989.041753319448, 6012.789552365646, 5918.496927761103, 5921.052631578927, 5931.0, 5942.524598032147, 6007.549433792483, 5450.0, 5490.3411590608985, 5608.9439105609235, 5659.915101273484, 5677.37548869624, 6167.506599472121, 6167.938320616826, 6182.412670796267, 6186.041163619646, 6203.875922481616, 5846.795362162304, 5950.31571369298, 5951.842106572091, 5965.015772397506, 5991.310999235144, 5797.652140871562, 5832.300123985149, 6004.819855404257, 6081.331053584102, 6099.054646529795, 6073.5748497604745, 6076.058210977306, 6078.057901025348, 6095.4818840398175, 6095.725692343855, 5722.599418040697, 5779.682117483495, 5779.768809247667, 6002.339742628307, 6025.517958563304, 4573.108243892409, 4610.815567377334, 4615.838445654453, 4633.4208223972, 4640.883977900579, 4158.459400277945, 4188.036751547162, 4193.412922190896, 4193.748375097504, 4202.096549241927, 5611.0741727615305, 5669.092945128842, 5769.769209231667, 5795.536357091422, 5878.706064696748, 5997.790077347272, 6014.338422773491, 6016.939830601638, 6020.849478763066, 6053.031514957585, 5833.212516310328, 5858.179854820329, 5865.20819689345, 5867.237259156368, 5871.060630299132, 4974.651774375831, 5007.7245751484015, 5115.053715062725, 5147.897042059138, 5173.818916337986, 6427.614343139333, 6441.259255185713, 6445.709943052668, 6451.838704032437, 6455.4835613150835, 6113.755449781959, 6174.783882564088, 6176.042713379434, 6179.412955769195, 6181.258249010148, 6066.029435290508, 6113.0, 6298.559100862895, 6365.077063825626, 6417.550771445954, 5979.551533635082, 6017.428344307284, 6044.788432404845, 6047.5464340173785, 6053.485453736482, 6152.200213972155, 6152.600080994721, 6159.106929495288, 6161.075838624242, 6174.536909731878, 5646.520045796154, 5722.513586345207, 5980.760769569169, 5992.280926288873, 5992.520598352208, 5853.882922341444, 5872.970635146797, 5935.465808077293, 5945.881082378241, 5992.730327135377, 5883.970580147072, 5926.229590153425, 5931.881362372815, 5944.346121926498, 5944.791932282349, 5697.0, 5728.083506639085, 5756.712164391847, 5901.616394934315, 5927.673977931255, 5743.0811070228565, 5750.194972703908, 5780.075187969905, 5783.3638299787835, 5795.565332599987], "value": 5584.855245049567, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.6742000939594, 821.6590115102233, 838.6351936907446, 882.5631312500313, 896.8475359188946, 31319.21701957452, 42471.36292955608, 43104.568954310445, 43136.352954705704, 43148.99999999996, 45698.54301456984, 46149.0, 46169.538304616945, 46191.0, 46211.306830397574, 7750.4187185961, 7874.9212507875045, 9239.49182794946, 9370.531473426301, 9370.67202647904, 10676.733081672981, 10730.678079657584, 11244.49399777008, 11254.49354779037, 11277.097832173447, 10973.83539246908, 11012.119030477543, 11031.779364412707, 11031.83452248217, 11033.393163376011, 10897.291676041032, 10919.508622111984, 10920.890791092066, 10956.616518421817, 10964.56141754329, 10712.892871071346, 10732.195085368628, 10776.40729759863, 10776.515056822462, 10778.514966826511, 41934.0, 42299.78850105761, 42311.788441057906, 42332.36501452481, 42481.78759106216, 4255.87232383029, 4293.24868148076, 4333.783310834478, 4423.402840616508, 4439.911201775979, 28854.855725721238, 29064.854675726485, 29183.708162918312, 29805.701942980508, 30445.391092178255, 4200.558941311149, 4294.742315461082, 4345.760983145926, 4364.388985542027, 4409.559044095597, 229794.0, 230549.0, 231078.0, 231712.0, 232641.5311310978, 51324.74337628363, 51331.23003154956, 51413.22880156801, 51477.0, 51568.74215628973, 54247.72876135594, 54354.7282263594, 54445.1833222494, 54464.0, 54543.45456545384, 16476.752848707278, 16825.326986920387, 16829.915850420915, 16839.57901052459, 16871.409500667418, 11805.350705711096, 11977.341246231366, 14992.100473971597, 14997.475088372074, 15061.623459413384, 12885.420156092998, 12916.289604071866, 13059.542915997894, 13182.340882955814, 13444.32778361078, 5580.553555715533, 5594.888102237933, 5612.130119831432, 5649.378568357477, 5695.886082278331, 1020.8060468511108, 1022.6625213679467, 1026.0662796854826, 1033.405791669793, 1034.1674951663983, 28245.858770706014, 28484.715152848206, 28596.571051434246, 28669.713302867123, 28995.275118121794, 1073.6242315189777, 1083.9403832789114, 1099.70308016835, 1104.2792063926777, 1105.6461932181624, 14061.507847225503, 14901.403943842124, 15125.697486050218, 15131.0, 15195.772063419057, 291908.0, 292018.0, 292040.0, 292391.0, 293448.0, 54803.17795233075, 54850.0, 54891.0, 54898.45101549013, 55122.17316740252, 1493.8132733408324, 1500.407339101049, 1521.33821787525, 1536.3393740691386, 1539.638185026518, 25712.0, 27353.45293094167, 27366.179014629593, 27424.0, 28271.434571308047, 45941.54058459373, 46050.76974615239, 46052.0, 46132.30801537912, 46355.0, 338427.0, 339409.0, 340880.0, 342124.0, 344061.0, 28005.439891201655, 28343.43313133767, 28381.290467737646, 28436.715632844236, 28573.0, 37102.44346334753, 37289.81355093207, 37540.87377378683, 37768.97848172195, 38149.61850381461, 29641.0, 29707.257318567208, 29736.405271894007, 29938.401231975673, 29990.55014174833, 28900.213710340093, 28993.710062899943, 28997.565036524047, 29546.81812727467, 29638.703612963593, 33209.83395083009, 33269.00192994117, 33521.0, 33702.0, 34356.14109647279, 27788.722112779422, 28067.859660701564, 28198.295042624097, 28611.570826438037, 29022.709772902846, 23437.882810585837, 23534.29397118089, 23939.76060239445, 23981.76018239865, 24916.875415622806], "value": 18631.140864661582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.7707395321645, 458.5829785961379, 467.2687244462416, 470.38849495655637, 482.6452557370333, 19411.611767764654, 19885.502862428428, 20278.89860550697, 21106.89446552765, 21319.786802131974, 19044.428667139975, 19434.805651943476, 19486.707699384486, 19616.117274722637, 20292.797072029276, 6100.664463454508, 6669.266380698132, 6745.3254674532645, 6771.796846094625, 6780.627065511395, 7760.844783104335, 7898.447108702364, 7899.0, 7911.643976021064, 7913.604319784016, 7472.962635186844, 7570.507916985406, 7595.696172153107, 7599.088109426876, 7783.4162437817395, 7689.423293252972, 7729.072511298652, 7731.342835858931, 7769.417293702995, 7798.64906079225, 7472.775816725507, 7653.349465295457, 7684.001079859582, 7685.923140768577, 7696.499727517749, 20807.8959605201, 21122.366329010154, 21161.0, 24225.757742422702, 24845.254642360756, 3040.3463255399975, 3075.3234288456506, 3138.3095718941795, 3357.8824741134185, 3429.7599168058246, 15765.0, 15910.920445397698, 16053.839461605352, 16835.83164168367, 16894.577635559086, 2316.490372118148, 2359.445530300378, 2360.2211270280936, 2390.3307074019303, 2402.8558286502866, 106510.0, 115197.0, 115576.42211788887, 127612.36193819065, 131632.34183829115, 14683.574661989893, 17430.564235894206, 17439.389621363192, 18199.818001820076, 18206.180721867284, 32647.183820404203, 32657.51013734796, 32663.346733065206, 32795.83602081974, 33212.169695757315, 10612.893871061191, 10795.136389088853, 10839.078678312431, 11031.117510599133, 11056.723581910517, 9020.81958360829, 9046.592903319366, 9066.320025998077, 9237.12247336502, 9288.907110928803, 9158.771030724285, 9471.0, 9625.085616866527, 9636.036396360309, 9757.170640495495, 3438.2951494943477, 3509.8420571073852, 3566.4293713006314, 3804.2962052020466, 3852.1332700142243, 958.5734348214977, 969.2633598465217, 975.6195083917278, 982.0376031489038, 987.9061489158519, 20876.164953401996, 22650.66024009641, 23298.883505582704, 23709.17017904365, 23783.0, 1111.2665640677114, 1120.5349779841274, 1131.3890499130378, 1133.3653154233655, 1134.7957367673732, 11882.524699011943, 11924.761504769856, 12083.879161208451, 12129.21160124589, 12193.146479746332, 337350.0, 339007.0, 339625.0, 401829.0, 784332.0, 119905.0, 120526.0, 122649.38675306566, 122786.0, 123501.38249308875, 1288.3944546063335, 1315.368623060917, 1331.900107491942, 1344.9125806822526, 1355.525566051874, 14963.326650300545, 19957.60084798325, 20085.598288033867, 20239.0, 20318.898405507876, 38101.66644167441, 39745.80127099462, 48256.0, 53461.73269133629, 54107.0, 63988.36011639824, 64212.0, 64599.0, 64837.67581162064, 64929.35070649422, 12117.0, 13124.606261812161, 13246.271455070064, 13454.125481843648, 13552.661183470493, 14234.0, 14413.7837932429, 14534.345954431865, 14547.0, 14742.26288685583, 12185.451654675384, 12279.69300767488, 12368.505259789868, 12432.191907525981, 12890.871091289342, 11101.945315195044, 11246.381449020382, 11867.109966752356, 11872.228305160137, 11905.404729763304, 12814.423350949417, 12855.16441431304, 13101.082924195596, 13164.670883227613, 13350.0, 13006.609801705965, 13045.673858153623, 13147.211167329991, 13246.891528139473, 13521.459141634225, 12447.439865206268, 12530.185537940004, 12608.243505389706, 12652.87347126517, 13077.738445231233], "value": 11592.198074409065, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.9461368852092, 1558.6648870492843, 1559.688062387522, 1566.8824838137139, 1582.794236749223, 10884.455777211137, 11721.70695732607, 11725.0, 11729.589464368748, 11733.47199376028, 10799.83800242997, 10935.83596246057, 10942.726431839208, 10957.232993690444, 11405.14461415393, 2468.3582268610157, 2518.672572565573, 2540.123657338225, 2543.4277287610325, 2550.1966880432697, 2386.2721869829693, 2426.708794944609, 2480.2435257246534, 2481.0, 2481.751824817513, 2400.1119585753295, 2413.6862207913036, 2446.7920226780657, 2451.3258853815164, 2457.8402403843784, 2369.3958040699686, 2394.988025059872, 2411.577973854577, 2411.819113566472, 2421.7336093029753, 2325.2210509479346, 2418.6855708757926, 2420.5521978434044, 2425.6967879015124, 2426.8543887366814, 11520.654380368602, 11584.536618535249, 11608.129390295762, 11610.477528511237, 11647.301161930227, 5940.851478713023, 6023.247094113236, 6040.456358927674, 6044.153818465418, 6116.0, 3583.964160358389, 3595.4247320428867, 3653.5798383186007, 3681.3925702259094, 3739.4016957286703, 1382.2950295349344, 2271.965920511194, 2322.0, 2338.438774694061, 2375.10933399975, 15310.234488275542, 15708.842911570966, 16997.235124419432, 17535.386261480915, 17561.29754809806, 4873.366462359942, 4940.135476291634, 4976.154053810861, 4977.601791856643, 5023.397192336943, 13128.934355328352, 13149.737005260033, 13158.078934474686, 13165.67085822843, 13168.73662526744, 5803.7968671096305, 5852.648841069549, 5865.501432378211, 5872.324682661463, 5872.970635146797, 5273.973630131824, 5423.18652202165, 5484.643498172606, 5531.446855314517, 5533.584981126432, 4095.7130804215385, 4100.446439730657, 4176.707630465899, 4214.452121224222, 4217.894552636148, 1034.1623285139062, 1044.253358848427, 1052.910502607287, 1064.084886997182, 1064.8775390829999, 1002.0931057393071, 1012.7215015870695, 1014.2697257974247, 1014.9949250253701, 1022.3048327137618, 6853.623050732258, 6907.896381554281, 6910.550814197061, 6961.060256865258, 7016.438684905195, 1042.4735508568124, 1055.3404122423485, 1060.7666313411037, 1079.0989523747758, 1091.8089334366455, 4625.907481850411, 4645.465771436328, 4665.183592871302, 4726.456457507362, 4741.0, 14513.492027778977, 15105.244737763069, 15114.773278400833, 15117.622059448382, 15129.39482420691, 13972.0, 14841.925790370979, 14861.331240094221, 14872.92563537197, 14984.250787460584, 9126.498042607587, 9385.202257808027, 10653.573857045787, 10829.783404331869, 10907.29102608328, 7177.246389129066, 7411.444141689287, 7456.142543607554, 7502.962485187539, 7606.543607383574, 12548.0, 12561.87438125607, 12665.81001285, 12853.678658033625, 12937.223766574036, 12782.68043298925, 13560.93219533896, 13737.931310343385, 13776.380062897395, 13779.035467517178, 9946.4529450878, 10094.041066098709, 10156.593736250763, 10195.082442579907, 10208.336458130198, 10947.397893115955, 10949.945250273699, 11019.44902754843, 11099.112071034137, 11131.554737810397, 9327.160555550034, 9360.765980850534, 9389.38968967015, 9430.339876208875, 9515.619375224913, 9118.0, 9159.22146617545, 9203.539823008688, 9216.032316606928, 9347.579358928728, 8688.435251708872, 8822.161894620001, 8890.911090889267, 8925.776855578662, 8935.419197752126, 6266.185395898504, 6318.526110541636, 6509.609423434609, 6514.088027676224, 6576.802695918938, 6415.0377443382, 6422.0, 6464.612123272431, 6497.415232628897, 6576.572522786004], "value": 5520.193154096715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6418919256457, 409.6681687832856, 424.13264873334026, 431.84021911892603, 435.18620180262906, 5147.356580427447, 5237.45006774288, 5369.9731501342485, 5377.247185394048, 5388.434214407484, 5130.589552835773, 5261.552768014713, 5266.394364648067, 5267.710275934822, 5271.209318602211, 4588.632909367259, 4611.33135695324, 4615.907681846361, 4619.399478067847, 4619.937414394692, 4269.594388533084, 4402.336586365251, 4461.06317673289, 4635.427337827505, 4678.602318802906, 4430.474629461209, 4443.134178454895, 4458.821647134111, 4460.50934397216, 4471.754053527055, 4456.55434456555, 4469.463664360265, 4489.955100448987, 4491.371208030879, 4523.11799199153, 3957.3866050762176, 4138.875833724963, 4241.681873859442, 4242.2576049191575, 4246.44796176495, 5069.352460450332, 5103.923441148386, 5106.183010718267, 5108.770105345268, 5126.897462050775, 5139.640225184238, 5151.407588127376, 5177.834987127903, 5185.325907632021, 5199.454057324002, 5309.309789727311, 5480.287562616874, 5520.834374968757, 5601.915971260434, 5609.382967873531, 4603.907921841578, 4635.327877457784, 4641.535846415365, 4641.907161856778, 4665.640738668153, 5756.712164391805, 5821.563382746311, 5835.387284335126, 5851.3270973838125, 5853.239078919756, 4640.280756482751, 4710.81156753726, 4739.976300118477, 4765.642576806753, 4789.161896668069, 4820.927686084711, 4834.081524510332, 4850.223964165716, 4850.296706977469, 4889.9486610378935, 5159.174532074925, 5190.2993095932325, 5198.7140707260705, 5231.921521177185, 5234.293370395024, 5364.517193452608, 5392.272043274108, 5477.0, 5616.438356164433, 5652.858678532987, 1605.5103193525854, 1626.406361677979, 1667.9416220432227, 1678.446112782803, 1681.5370627554107, 1246.7194881151668, 1282.4870051979096, 1282.660095074806, 1299.1036185032485, 1300.2458574027041, 5464.207689884945, 5501.532369748536, 5520.420355862577, 5556.444355564411, 5565.7217139143695, 5615.775368985276, 5699.886002279931, 5706.80026199081, 5711.571632127607, 5767.68277744728, 5231.895362092737, 5462.562994960394, 5503.229547863302, 5509.00837849191, 5569.248151499496, 3003.903575195082, 3004.369082492701, 3008.6389633244153, 3009.2627306310096, 3032.3935212957495, 5663.886722265532, 5918.260217472816, 5934.139549765347, 5947.702614869239, 5955.27795128045, 5787.218725472091, 5795.88408231833, 5823.94176058234, 5843.678597677083, 5845.853853653608, 5968.850778730566, 5992.610480318765, 5998.520118390518, 6019.374768812396, 6036.788712395045, 5460.754266058117, 5660.264165658438, 5734.3978882218435, 5747.655140691572, 5762.625429347079, 5637.408072152365, 5663.895540369588, 5665.886682266414, 5679.409765265732, 5729.197912292199, 5833.591648584558, 5900.6515936567275, 6036.849078773066, 6057.969710151421, 6067.635941843327, 4784.545468180518, 4810.230363141881, 4828.830990915301, 4831.806727730851, 4833.41998960113, 5536.695481748542, 5649.604527683023, 5661.773529058792, 5776.180503141497, 5797.333306669787, 5528.917066243929, 5589.748461319332, 5607.579431542569, 5635.887282254414, 5665.971670141623, 5581.358143813513, 5584.916226256691, 5593.272874526286, 5593.580481463988, 5608.943910560843, 5329.840104796862, 5618.52242559387, 5619.49424551776, 5623.465770751772, 5625.578081643975, 5587.77648894056, 5642.996736158605, 5645.71771411436, 5660.801871934463, 5671.780567178076, 5363.946360536344, 5474.23598061514, 5479.945200548103, 5485.753141108739, 5560.694161821139], "value": 4501.750163144049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.4404421059987, 868.1882439918677, 925.6158694141927, 938.5635679409073, 939.4691999020553, 17311.22099505522, 17875.821241787577, 17881.731774023367, 17907.37324193652, 17972.28110875565, 13380.330983450836, 16810.747838782427, 16945.745813812802, 16989.0, 17019.82980170198, 895.0333639669158, 924.5284904698585, 927.4528028463205, 928.1275600935134, 928.3965422475411, 907.1790030022839, 907.6369452219133, 908.0284096017264, 908.7864351877304, 911.43946472919, 961.4663861556833, 961.8653388525612, 963.2631037256505, 963.3593660215948, 963.7927845513213, 959.94720290384, 960.3085778239727, 960.6205548808216, 960.7934294126761, 961.653804630336, 697.9685914133826, 700.7442283566462, 700.8528209076101, 701.3162166887245, 701.424831638057, 16572.337106515726, 16590.50228493135, 16607.50177494677, 16655.25051372691, 16665.083420411873, 16826.24281907317, 16932.746008809878, 17091.390360812737, 17513.0, 17638.206280717397, 14033.298335083206, 14111.929440352835, 14179.574612761531, 14198.432062717478, 14238.0, 4091.8158682859344, 4107.67138628909, 4127.8968025799295, 4169.624733773975, 4228.556001619816, 85354.57322713471, 86594.56702716509, 86737.0, 87729.0, 88755.11244887533, 13332.133411328232, 13486.730265394637, 13540.119892207173, 13546.864531354757, 13741.587752367444, 25533.0, 25907.870460647577, 26099.869500652756, 26196.345091372867, 26241.34396640061, 9019.368644194843, 9028.909710902939, 9305.162535371848, 9345.672901448417, 9367.437953722661, 4852.369192005087, 4936.037472692862, 5006.6495345325475, 5010.498950105033, 5128.282040514331, 3782.867599634055, 3881.2043531076624, 3881.4760007399204, 3882.80585970706, 3886.902827429337, 650.0606623429194, 659.5976454362835, 680.0920770770978, 680.4692339974828, 684.6953105867841, 724.1310427487036, 744.8770952792728, 754.792432081182, 761.6115780951644, 764.399946042354, 10531.578736850593, 10653.73365665849, 10671.25301228922, 10741.946290268656, 10900.618478353219, 652.9151210342625, 661.2197606823897, 673.2594146438878, 678.2335960364757, 683.4668958212602, 5209.192575150858, 5304.761285742151, 5342.145256758978, 5378.704171270618, 5400.324959380077, 75425.62287188639, 77146.6142669283, 78052.60973695095, 78743.21256787474, 79567.0, 73220.0, 73295.0, 74659.0, 75143.62428187823, 77416.0, 59254.40745592575, 62709.68645156745, 63152.138247840136, 63251.683741581, 63541.0, 10073.949630251802, 10261.74345641365, 10321.225908056776, 10339.483025848827, 10384.584616615553, 42518.5748142527, 42895.0, 43572.56427435685, 44108.0, 45094.32358514559, 50651.0, 50751.0, 51158.74420627873, 51410.0, 52646.21030684466, 12336.50653973831, 12337.753244935231, 12477.93761031189, 12630.810537842124, 12719.173253738478, 13705.862941370458, 13878.097923634932, 13988.37052332668, 14085.859141408455, 14126.50557230492, 11136.10911127124, 11282.323060616389, 11289.548418063185, 11305.208635395444, 11489.465339251405, 12304.600602882352, 12482.75034499323, 12486.625401237978, 12491.125621206791, 12619.053570982396, 12564.811527826907, 12682.746345072863, 12692.936535317263, 12694.492220311084, 12700.301483418501, 9735.561899714672, 9803.460809655537, 9831.705048848546, 9861.408315501092, 10044.748881278027, 10474.319169253975, 10553.472326383497, 10586.8941310589, 10624.309419887682, 10632.681019569425], "value": 7658.862226523479, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 113.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 116.0, 154.0, 115.0, 117.0, 118.0, 122.0, 138.0, 118.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 160.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 108.0, 76.0, 76.0, 75.0, 76.0, 96.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 101.0, 81.0, 82.0, 82.0, 104.0, 83.0, 83.0, 100.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 115.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 56.0, 55.0, 56.0, 56.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 56.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 76.0, 79.0, 84.0, 81.0, 76.0, 76.0, 75.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 122.0, 135.0, 120.0, 119.0, 118.0, 128.0, 158.0, 140.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 160.0, 161.0, 157.0, 163.0, 157.0, 158.0, 157.0, 158.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0], "value": 59.5, "unit": "score"}]}]} 03:17:26 INFO - Return code: 0 03:17:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:26 ERROR - # TBPL SUCCESS # 03:17:26 INFO - Running post-action listener: _resource_record_post_action 03:17:26 INFO - [mozharness: 2017-04-18 10:17:26.562303Z] Finished run-tests step (success) 03:17:26 INFO - Running post-run listener: _resource_record_post_run 03:17:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 262144; Write bytes: 366542848; Read time: 24; Write time: 243128 03:17:26 INFO - TinderboxPrint: CPU usage
13.1% 03:17:26 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 24 03:17:26 INFO - TinderboxPrint: I/O write bytes / time
366,542,848 / 243,128 03:17:26 INFO - TinderboxPrint: CPU idle
8,263.9 (86.9%) 03:17:26 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 03:17:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112304128; Read time: 0; Write time: 102304 03:17:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 253624320; Read time: 24; Write time: 140756 03:17:27 INFO - Running post-run listener: _upload_blobber_files 03:17:27 INFO - Blob upload gear active. 03:17:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:27 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 03:17:27 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'] 03:17:27 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 03:17:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:17:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:17:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:28 INFO - (blobuploader) - INFO - Done attempting. 03:17:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:17:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:17:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:29 INFO - (blobuploader) - INFO - Done attempting. 03:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:17:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:29 INFO - (blobuploader) - INFO - Done attempting. 03:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:33 INFO - (blobuploader) - INFO - Done attempting. 03:17:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:33 INFO - Return code: 0 03:17:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/db61d28670d024e081558dfd4baeef349a790fd1ccec74b8dc8f1b7a3ec854a0c873d00681183a2e60ea1ac49789c257c3b421470b37c8ba2169a96b715dd3c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a06027e5a75850dc883d0330295fbc2eee273fcbfbc874699fd05916afaac6101449170be988e9b339a7f50142d46aee0405fff4c16f7fabd130cd662b20135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/61ac7495a6819b148808d59b347c2371e47930df9dab6bc31299589a2ebbb2b8bc37a19cd3c5c0d52ec9ac77740add1bfa658c6f86d8442c844efba7c847b602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b959b87ee3f0a72dde2447e98a902ff960ee6de6050fa91d502d253de1ca500d7150a9ad94ab9a5900ea49d4e1d36c7c7f5f72d79aa70fa47a8b66560f277f3f"} 03:17:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:33 INFO - Contents: 03:17:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/db61d28670d024e081558dfd4baeef349a790fd1ccec74b8dc8f1b7a3ec854a0c873d00681183a2e60ea1ac49789c257c3b421470b37c8ba2169a96b715dd3c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a06027e5a75850dc883d0330295fbc2eee273fcbfbc874699fd05916afaac6101449170be988e9b339a7f50142d46aee0405fff4c16f7fabd130cd662b20135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/61ac7495a6819b148808d59b347c2371e47930df9dab6bc31299589a2ebbb2b8bc37a19cd3c5c0d52ec9ac77740add1bfa658c6f86d8442c844efba7c847b602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b959b87ee3f0a72dde2447e98a902ff960ee6de6050fa91d502d253de1ca500d7150a9ad94ab9a5900ea49d4e1d36c7c7f5f72d79aa70fa47a8b66560f277f3f"} 03:17:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:33 INFO - Copying logs to upload dir... 03:17:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.265940 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-18 03:17:33.337850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:33.341461) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 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/db61d28670d024e081558dfd4baeef349a790fd1ccec74b8dc8f1b7a3ec854a0c873d00681183a2e60ea1ac49789c257c3b421470b37c8ba2169a96b715dd3c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a06027e5a75850dc883d0330295fbc2eee273fcbfbc874699fd05916afaac6101449170be988e9b339a7f50142d46aee0405fff4c16f7fabd130cd662b20135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/61ac7495a6819b148808d59b347c2371e47930df9dab6bc31299589a2ebbb2b8bc37a19cd3c5c0d52ec9ac77740add1bfa658c6f86d8442c844efba7c847b602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b959b87ee3f0a72dde2447e98a902ff960ee6de6050fa91d502d253de1ca500d7150a9ad94ab9a5900ea49d4e1d36c7c7f5f72d79aa70fa47a8b66560f277f3f"} build_url:https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/FAYYQg_aQ7KuuP2lhlxo1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/db61d28670d024e081558dfd4baeef349a790fd1ccec74b8dc8f1b7a3ec854a0c873d00681183a2e60ea1ac49789c257c3b421470b37c8ba2169a96b715dd3c4", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4a06027e5a75850dc883d0330295fbc2eee273fcbfbc874699fd05916afaac6101449170be988e9b339a7f50142d46aee0405fff4c16f7fabd130cd662b20135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/61ac7495a6819b148808d59b347c2371e47930df9dab6bc31299589a2ebbb2b8bc37a19cd3c5c0d52ec9ac77740add1bfa658c6f86d8442c844efba7c847b602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b959b87ee3f0a72dde2447e98a902ff960ee6de6050fa91d502d253de1ca500d7150a9ad94ab9a5900ea49d4e1d36c7c7f5f72d79aa70fa47a8b66560f277f3f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:33.366695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:33.367065) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1492509400.222481-1703232230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004353 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:33.451894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:17:33.452208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:17:33.452500) ========= ========= Total master_lag: 0.15 =========