builder: pine_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1491626442.13 results: success (0) revision: e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.131554) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.131985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.132254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.147211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.147524) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-07 21:40:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2017-04-07 21:40:42 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.340386 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.501749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.502057) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:42.551592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 21:40:42.551950) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/pine --rev e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 --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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-07 21:40:42,738 truncating revision to first 12 chars 2017-04-07 21:40:42,738 Setting DEBUG logging. 2017-04-07 21:40:42,738 attempt 1/10 2017-04-07 21:40:42,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/e22c7a25dfff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 21:40:43,481 unpacking tar archive at: pine-e22c7a25dfff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.065883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-07 21:40:43.633069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:43.633412) ========= script_repo_revision: e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:43.633787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:43.634049) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 21:40:43.645597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-07 21:40:43.645984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] 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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:40:43 INFO - MultiFileLogger online at 20170407 21:40:43 in /builds/slave/test 21:40:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 21:40:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:43 INFO - {'append_to_log': False, 21:40:43 INFO - 'base_work_dir': '/builds/slave/test', 21:40:43 INFO - 'blob_upload_branch': 'Pine', 21:40:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:43 INFO - 'branch': 'Pine', 21:40:43 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:43 INFO - 'config_files': ('talos/linux_config.py',), 21:40:43 INFO - 'default_actions': ('clobber', 21:40:43 INFO - 'read-buildbot-config', 21:40:43 INFO - 'download-and-extract', 21:40:43 INFO - 'populate-webroot', 21:40:43 INFO - 'create-virtualenv', 21:40:43 INFO - 'install', 21:40:43 INFO - 'run-tests'), 21:40:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:43 INFO - 'download_minidump_stackwalk': True, 21:40:43 INFO - 'download_symbols': 'ondemand', 21:40:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:40:43 INFO - 'tooltool.py': '/tools/tooltool.py', 21:40:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:40:43 INFO - '/tools/misc-python/virtualenv.py')}, 21:40:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:43 INFO - 'gecko_profile': False, 21:40:43 INFO - 'gecko_profile_interval': 0, 21:40:43 INFO - 'installer_path': 'installer.exe', 21:40:43 INFO - 'log_level': 'info', 21:40:43 INFO - 'log_name': 'talos', 21:40:43 INFO - 'log_to_console': True, 21:40:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:40:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:40:43 INFO - 'opt_config_files': (), 21:40:43 INFO - 'pip_index': False, 21:40:43 INFO - 'suite': 'dromaeojs', 21:40:43 INFO - 'system_bits': '32', 21:40:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:43 INFO - 'title': 'talos-linux64-ix-013', 21:40:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:43 INFO - 'use_talos_json': True, 21:40:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:43 INFO - 'work_dir': 'build'} 21:40:43 INFO - [mozharness: 2017-04-08 04:40:43.929883Z] Running clobber step. 21:40:43 INFO - Running pre-action listener: _resource_record_pre_action 21:40:43 INFO - Running main action method: clobber 21:40:43 INFO - rmtree: /builds/slave/test/build 21:40:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:45 INFO - Running post-action listener: _resource_record_post_action 21:40:45 INFO - [mozharness: 2017-04-08 04:40:45.357691Z] Finished clobber step (success) 21:40:45 INFO - [mozharness: 2017-04-08 04:40:45.357792Z] Running read-buildbot-config step. 21:40:45 INFO - Running pre-action listener: _resource_record_pre_action 21:40:45 INFO - Running main action method: read_buildbot_config 21:40:45 INFO - Using buildbot properties: 21:40:45 INFO - { 21:40:45 INFO - "project": "", 21:40:45 INFO - "product": "firefox", 21:40:45 INFO - "who": "dmosedale@mozilla.com", 21:40:45 INFO - "installer_path": "public/build/target.tar.bz2", 21:40:45 INFO - "builddir": "pine_ubuntu64_hw_test-dromaeojs", 21:40:45 INFO - "repository": "https://hg.mozilla.org/projects/pine/", 21:40:45 INFO - "buildername": "Ubuntu HW 12.04 x64 pine talos dromaeojs", 21:40:45 INFO - "stage_platform": "linux64", 21:40:45 INFO - "basedir": "/builds/slave/test", 21:40:45 INFO - "buildnumber": 3, 21:40:45 INFO - "platform": "ubuntu64_hw", 21:40:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:40:45 INFO - "slavebuilddir": "test", 21:40:45 INFO - "taskId": "QOFBsv6cQ3WJX3AfnaqCjQ", 21:40:45 INFO - "branch": "pine", 21:40:45 INFO - "script_repo_revision": "default", 21:40:45 INFO - "revision": "e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6", 21:40:45 INFO - "slavename": "talos-linux64-ix-013", 21:40:45 INFO - "repo_path": "projects/pine" 21:40:45 INFO - } 21:40:45 INFO - Finding installer, test and symbols from parent task. 21:40:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOFBsv6cQ3WJX3AfnaqCjQ'}, attempt #1 21:40:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOFBsv6cQ3WJX3AfnaqCjQ'}, attempt #1 21:40:46 INFO - Task dependencies: LsBSD0zvTeahS9JDb0v94g 21:40:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g'}, attempt #1 21:40:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 21:40:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/test_packages.json 21:40:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.crashreporter-symbols.zip 21:40:46 INFO - Running post-action listener: _resource_record_post_action 21:40:46 INFO - [mozharness: 2017-04-08 04:40:46.789518Z] Finished read-buildbot-config step (success) 21:40:46 INFO - [mozharness: 2017-04-08 04:40:46.789645Z] Running download-and-extract step. 21:40:46 INFO - Running pre-action listener: _resource_record_pre_action 21:40:46 INFO - Running main action method: download_and_extract 21:40:46 INFO - mkdir: /builds/slave/test/build/tests 21:40:46 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')]} 21:40:46 INFO - trying https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.test_packages.json 21:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:40:47 INFO - Downloaded 986 bytes. 21:40:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:40:47 INFO - Using the following test package requirements: 21:40:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:40:47 INFO - u'common': [u'target.common.tests.zip'], 21:40:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:40:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:40:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:40:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:40:47 INFO - u'mozbase': [u'target.common.tests.zip'], 21:40:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:40:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:40:47 INFO - u'web-platform': [u'target.common.tests.zip', 21:40:47 INFO - u'target.web-platform.tests.zip'], 21:40:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:40:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:40:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip 21:40:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:40:47 INFO - Fetch https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip into memory 21:40:48 INFO - Expected file size: 58238880 21:40:48 INFO - Obtained file size: 58238880 21:40:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:40:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip 21:40:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:40:58 INFO - Fetch https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.common.tests.zip into memory 21:40:59 INFO - Expected file size: 58238880 21:40:59 INFO - Obtained file size: 58238880 21:41:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.talos.tests.zip 21:41:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:41:10 INFO - Fetch https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.talos.tests.zip into memory 21:41:11 INFO - Expected file size: 14404138 21:41:11 INFO - Obtained file size: 14404138 21:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:11 INFO - trying https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 21:41:11 INFO - Downloading https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:41:12 INFO - Downloaded 57958875 bytes. 21:41:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 21:41:12 INFO - mkdir: /builds/slave/test/properties 21:41:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:41:12 INFO - Writing to file /builds/slave/test/properties/build_url 21:41:12 INFO - Contents: 21:41:12 INFO - build_url:https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 21:41:12 INFO - Running post-action listener: _resource_record_post_action 21:41:12 INFO - Running post-action listener: set_extra_try_arguments 21:41:12 INFO - [mozharness: 2017-04-08 04:41:12.464602Z] Finished download-and-extract step (success) 21:41:12 INFO - [mozharness: 2017-04-08 04:41:12.464700Z] Running populate-webroot step. 21:41:12 INFO - Running pre-action listener: _resource_record_pre_action 21:41:12 INFO - Running main action method: populate_webroot 21:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:41:12 INFO - '--tppagecycles', 21:41:12 INFO - '7'], 21:41:12 INFO - 'tests': ['tsvgm']}}, 21:41:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:41:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:41:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:41:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:41:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['damp', 'tps']}, 21:41:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'tests': ['damp', 'tps']}, 21:41:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['dromaeo_dom']}, 21:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:41:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['basic_compositor_video']}, 21:41:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:41:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['a11yr', 21:41:12 INFO - 'ts_paint', 21:41:12 INFO - 'tpaint', 21:41:12 INFO - 'sessionrestore', 21:41:12 INFO - 'sessionrestore_no_auto_restore', 21:41:12 INFO - 'tabpaint']}, 21:41:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['tsvgx', 21:41:12 INFO - 'tsvgr_opacity', 21:41:12 INFO - 'tart', 21:41:12 INFO - 'tscrollx', 21:41:12 INFO - 'cart', 21:41:12 INFO - 'tsvg_static']}, 21:41:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:41:12 INFO - 'tsvgr_opacity', 21:41:12 INFO - 'tart', 21:41:12 INFO - 'tscrollx', 21:41:12 INFO - 'cart', 21:41:12 INFO - 'tsvg_static']}, 21:41:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'talos_options': ['--disable-e10s'], 21:41:12 INFO - 'tests': ['tp5o']}, 21:41:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:41:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'talos_options': ['--disable-e10s', 21:41:12 INFO - '--xperf_path', 21:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:12 INFO - 'tests': ['tp5n']}, 21:41:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:41:12 INFO - 'talos_options': ['--xperf_path', 21:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:12 INFO - 'tests': ['tp5n']}}, 21:41:12 INFO - 'talos.zip': {'path': '', 21:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:41:12 INFO - Running post-action listener: _resource_record_post_action 21:41:12 INFO - [mozharness: 2017-04-08 04:41:12.477966Z] Finished populate-webroot step (success) 21:41:12 INFO - [mozharness: 2017-04-08 04:41:12.478056Z] Running create-virtualenv step. 21:41:12 INFO - Running pre-action listener: _resource_record_pre_action 21:41:12 INFO - Running main action method: create_virtualenv 21:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:41:12 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 21:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:41:12 INFO - Using real prefix '/usr' 21:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 21:41:15 INFO - Installing pip.................done. 21:41:15 INFO - Return code: 0 21:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:41:15 INFO - Reading from file tmpfile_stdout 21:41:15 INFO - Output received: 21:41:15 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) 21:41:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:41:15 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')]} 21:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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')]} 21:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:15 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 21:41:15 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 21:41:15 INFO - Using env: {'DISPLAY': ':0', 21:41:15 INFO - 'HOME': '/home/cltbld', 21:41:15 INFO - 'LANG': 'en_US.UTF-8', 21:41:15 INFO - 'LANGUAGE': 'en_US:en', 21:41:15 INFO - 'LOGNAME': 'cltbld', 21:41:15 INFO - 'MAIL': '/var/mail/cltbld', 21:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:15 INFO - 'MOZ_NO_REMOTE': '1', 21:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:15 INFO - 'NO_EM_RESTART': '1', 21:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:15 INFO - 'PWD': '/builds/slave/test', 21:41:15 INFO - 'SHELL': '/bin/bash', 21:41:15 INFO - 'SHLVL': '1', 21:41:15 INFO - 'TERM': 'linux', 21:41:15 INFO - 'TMOUT': '86400', 21:41:15 INFO - 'USER': 'cltbld', 21:41:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:15 INFO - '_': '/tools/buildbot/bin/python'} 21:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:15 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 21:41:15 INFO - Cleaning up... 21:41:15 INFO - Return code: 0 21:41:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:41:15 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')]} 21:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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')]} 21:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:15 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:15 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 21:41:15 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 21:41:15 INFO - Using env: {'DISPLAY': ':0', 21:41:15 INFO - 'HOME': '/home/cltbld', 21:41:15 INFO - 'LANG': 'en_US.UTF-8', 21:41:15 INFO - 'LANGUAGE': 'en_US:en', 21:41:15 INFO - 'LOGNAME': 'cltbld', 21:41:15 INFO - 'MAIL': '/var/mail/cltbld', 21:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:15 INFO - 'MOZ_NO_REMOTE': '1', 21:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:15 INFO - 'NO_EM_RESTART': '1', 21:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:15 INFO - 'PWD': '/builds/slave/test', 21:41:15 INFO - 'SHELL': '/bin/bash', 21:41:15 INFO - 'SHLVL': '1', 21:41:15 INFO - 'TERM': 'linux', 21:41:15 INFO - 'TMOUT': '86400', 21:41:15 INFO - 'USER': 'cltbld', 21:41:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:15 INFO - '_': '/tools/buildbot/bin/python'} 21:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:15 INFO - Downloading/unpacking psutil>=3.1.1 21:41:15 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 21:41:15 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 21:41:15 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 21:41:15 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 21:41:15 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 21:41:15 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 21:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:17 INFO - Installing collected packages: psutil 21:41:17 INFO - Running setup.py install for psutil 21:41:17 INFO - building 'psutil._psutil_linux' extension 21:41:17 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 21:41:18 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 21:41:18 INFO - building 'psutil._psutil_posix' extension 21:41:18 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 21:41:18 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 21:41:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:18 INFO - Successfully installed psutil 21:41:18 INFO - Cleaning up... 21:41:18 INFO - Return code: 0 21:41:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:18 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:18 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 21:41:18 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 21:41:18 INFO - Using env: {'DISPLAY': ':0', 21:41:18 INFO - 'HOME': '/home/cltbld', 21:41:18 INFO - 'LANG': 'en_US.UTF-8', 21:41:18 INFO - 'LANGUAGE': 'en_US:en', 21:41:18 INFO - 'LOGNAME': 'cltbld', 21:41:18 INFO - 'MAIL': '/var/mail/cltbld', 21:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:18 INFO - 'MOZ_NO_REMOTE': '1', 21:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:18 INFO - 'NO_EM_RESTART': '1', 21:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:18 INFO - 'PWD': '/builds/slave/test', 21:41:18 INFO - 'SHELL': '/bin/bash', 21:41:18 INFO - 'SHLVL': '1', 21:41:18 INFO - 'TERM': 'linux', 21:41:18 INFO - 'TMOUT': '86400', 21:41:18 INFO - 'USER': 'cltbld', 21:41:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:18 INFO - '_': '/tools/buildbot/bin/python'} 21:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:41:18 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 21:41:18 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 21:41:18 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 21:41:18 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 21:41:18 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 21:41:18 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 21:41:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:41:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:41:20 INFO - Installing collected packages: mozsystemmonitor 21:41:20 INFO - Running setup.py install for mozsystemmonitor 21:41:20 INFO - Successfully installed mozsystemmonitor 21:41:20 INFO - Cleaning up... 21:41:20 INFO - Return code: 0 21:41:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:20 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:20 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 21:41:20 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 21:41:20 INFO - Using env: {'DISPLAY': ':0', 21:41:20 INFO - 'HOME': '/home/cltbld', 21:41:20 INFO - 'LANG': 'en_US.UTF-8', 21:41:20 INFO - 'LANGUAGE': 'en_US:en', 21:41:20 INFO - 'LOGNAME': 'cltbld', 21:41:20 INFO - 'MAIL': '/var/mail/cltbld', 21:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:20 INFO - 'MOZ_NO_REMOTE': '1', 21:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:20 INFO - 'NO_EM_RESTART': '1', 21:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:20 INFO - 'PWD': '/builds/slave/test', 21:41:20 INFO - 'SHELL': '/bin/bash', 21:41:20 INFO - 'SHLVL': '1', 21:41:20 INFO - 'TERM': 'linux', 21:41:20 INFO - 'TMOUT': '86400', 21:41:20 INFO - 'USER': 'cltbld', 21:41:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:20 INFO - '_': '/tools/buildbot/bin/python'} 21:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:41:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 INFO - Downloading functools32-3.2.3-2.tar.gz 21:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:41:23 INFO - warning: no files found matching '*.txt' 21:41:23 INFO - no previously-included directories found matching 'build' 21:41:23 INFO - no previously-included directories found matching 'dist' 21:41:23 INFO - no previously-included directories found matching '.git*' 21:41:23 INFO - Installing collected packages: jsonschema, functools32 21:41:23 INFO - Running setup.py install for functools32 21:41:23 INFO - warning: no files found matching '*.txt' 21:41:23 INFO - no previously-included directories found matching 'build' 21:41:23 INFO - no previously-included directories found matching 'dist' 21:41:23 INFO - no previously-included directories found matching '.git*' 21:41:23 INFO - Successfully installed jsonschema functools32 21:41:23 INFO - Cleaning up... 21:41:23 INFO - Return code: 0 21:41:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:41:23 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')]} 21:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:23 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')]} 21:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:23 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:23 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 21:41:23 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 21:41:23 INFO - Using env: {'DISPLAY': ':0', 21:41:23 INFO - 'HOME': '/home/cltbld', 21:41:23 INFO - 'LANG': 'en_US.UTF-8', 21:41:23 INFO - 'LANGUAGE': 'en_US:en', 21:41:23 INFO - 'LOGNAME': 'cltbld', 21:41:23 INFO - 'MAIL': '/var/mail/cltbld', 21:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:23 INFO - 'MOZ_NO_REMOTE': '1', 21:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:23 INFO - 'NO_EM_RESTART': '1', 21:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:23 INFO - 'PWD': '/builds/slave/test', 21:41:23 INFO - 'SHELL': '/bin/bash', 21:41:23 INFO - 'SHLVL': '1', 21:41:23 INFO - 'TERM': 'linux', 21:41:23 INFO - 'TMOUT': '86400', 21:41:23 INFO - 'USER': 'cltbld', 21:41:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:23 INFO - '_': '/tools/buildbot/bin/python'} 21:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:41:23 INFO - Cleaning up... 21:41:23 INFO - Return code: 0 21:41:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41:23 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')]} 21:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:23 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')]} 21:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:23 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:23 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 21:41:23 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 21:41:23 INFO - Using env: {'DISPLAY': ':0', 21:41:23 INFO - 'HOME': '/home/cltbld', 21:41:23 INFO - 'LANG': 'en_US.UTF-8', 21:41:23 INFO - 'LANGUAGE': 'en_US:en', 21:41:23 INFO - 'LOGNAME': 'cltbld', 21:41:23 INFO - 'MAIL': '/var/mail/cltbld', 21:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:23 INFO - 'MOZ_NO_REMOTE': '1', 21:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:23 INFO - 'NO_EM_RESTART': '1', 21:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:23 INFO - 'PWD': '/builds/slave/test', 21:41:23 INFO - 'SHELL': '/bin/bash', 21:41:23 INFO - 'SHLVL': '1', 21:41:23 INFO - 'TERM': 'linux', 21:41:23 INFO - 'TMOUT': '86400', 21:41:23 INFO - 'USER': 'cltbld', 21:41:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:23 INFO - '_': '/tools/buildbot/bin/python'} 21:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:23 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 21:41:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 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 21:41:26 INFO - Downloading docopt-0.6.1.tar.gz 21:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:26 INFO - Running setup.py install for blobuploader 21:41:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:26 INFO - Running setup.py install for requests 21:41:27 INFO - Running setup.py install for docopt 21:41:27 INFO - Successfully installed blobuploader requests docopt 21:41:27 INFO - Cleaning up... 21:41:27 INFO - Return code: 0 21:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:27 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')]} 21:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:27 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')]} 21:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:27 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:27 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 21:41:27 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 21:41:27 INFO - Using env: {'DISPLAY': ':0', 21:41:27 INFO - 'HOME': '/home/cltbld', 21:41:27 INFO - 'LANG': 'en_US.UTF-8', 21:41:27 INFO - 'LANGUAGE': 'en_US:en', 21:41:27 INFO - 'LOGNAME': 'cltbld', 21:41:27 INFO - 'MAIL': '/var/mail/cltbld', 21:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:27 INFO - 'MOZ_NO_REMOTE': '1', 21:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:27 INFO - 'NO_EM_RESTART': '1', 21:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:27 INFO - 'PWD': '/builds/slave/test', 21:41:27 INFO - 'SHELL': '/bin/bash', 21:41:27 INFO - 'SHLVL': '1', 21:41:27 INFO - 'TERM': 'linux', 21:41:27 INFO - 'TMOUT': '86400', 21:41:27 INFO - 'USER': 'cltbld', 21:41:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:27 INFO - '_': '/tools/buildbot/bin/python'} 21:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:27 INFO - Running setup.py (path:/tmp/pip-iHyG5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:27 INFO - Running setup.py (path:/tmp/pip-E5y87W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:27 INFO - Running setup.py (path:/tmp/pip-5pCspl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:27 INFO - Running setup.py (path:/tmp/pip-k0dC2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:27 INFO - Running setup.py (path:/tmp/pip-PKvqMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:27 INFO - Running setup.py (path:/tmp/pip-RTpiSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:28 INFO - Running setup.py (path:/tmp/pip-4dJLna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:28 INFO - Running setup.py (path:/tmp/pip-lN9nyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:28 INFO - Running setup.py (path:/tmp/pip-HKWFr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:28 INFO - Running setup.py (path:/tmp/pip-t5wZ0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:28 INFO - Running setup.py (path:/tmp/pip-P_FG6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:28 INFO - Running setup.py (path:/tmp/pip-1CA3Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:28 INFO - Running setup.py (path:/tmp/pip-JU_h1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:28 INFO - Running setup.py (path:/tmp/pip-BfnIYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:28 INFO - Running setup.py (path:/tmp/pip-2YsNIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:28 INFO - Running setup.py (path:/tmp/pip-76i8Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:28 INFO - Running setup.py (path:/tmp/pip-1U10sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:28 INFO - Running setup.py install for manifestparser 21:41:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:28 INFO - Running setup.py install for mozcrash 21:41:29 INFO - Running setup.py install for mozdebug 21:41:29 INFO - Running setup.py install for mozdevice 21:41:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozfile 21:41:29 INFO - Running setup.py install for mozhttpd 21:41:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozinfo 21:41:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozInstall 21:41:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozleak 21:41:29 INFO - Running setup.py install for mozlog 21:41:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for moznetwork 21:41:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:29 INFO - Running setup.py install for mozprocess 21:41:30 INFO - Running setup.py install for mozprofile 21:41:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:30 INFO - Running setup.py install for mozrunner 21:41:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:30 INFO - Running setup.py install for mozscreenshot 21:41:30 INFO - Running setup.py install for moztest 21:41:30 INFO - Running setup.py install for mozversion 21:41:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:30 INFO - Cleaning up... 21:41:30 INFO - Return code: 0 21:41:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:30 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')]} 21:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:30 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')]} 21:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:30 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:30 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 21:41:30 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 21:41:30 INFO - Using env: {'DISPLAY': ':0', 21:41:30 INFO - 'HOME': '/home/cltbld', 21:41:30 INFO - 'LANG': 'en_US.UTF-8', 21:41:30 INFO - 'LANGUAGE': 'en_US:en', 21:41:30 INFO - 'LOGNAME': 'cltbld', 21:41:30 INFO - 'MAIL': '/var/mail/cltbld', 21:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:30 INFO - 'MOZ_NO_REMOTE': '1', 21:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:30 INFO - 'NO_EM_RESTART': '1', 21:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:30 INFO - 'PWD': '/builds/slave/test', 21:41:30 INFO - 'SHELL': '/bin/bash', 21:41:30 INFO - 'SHLVL': '1', 21:41:30 INFO - 'TERM': 'linux', 21:41:30 INFO - 'TMOUT': '86400', 21:41:30 INFO - 'USER': 'cltbld', 21:41:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:30 INFO - '_': '/tools/buildbot/bin/python'} 21:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:30 INFO - Running setup.py (path:/tmp/pip-meKrtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:30 INFO - Running setup.py (path:/tmp/pip-Vef6dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:30 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)) 21:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:30 INFO - Running setup.py (path:/tmp/pip-sMGxV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:31 INFO - Running setup.py (path:/tmp/pip-swzjKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:31 INFO - Running setup.py (path:/tmp/pip-ol4Hzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:31 INFO - Running setup.py (path:/tmp/pip-6YbcpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:31 INFO - Running setup.py (path:/tmp/pip-H0G_Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:31 INFO - Running setup.py (path:/tmp/pip-ZPwmqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:31 INFO - Running setup.py (path:/tmp/pip-oZznk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:31 INFO - Running setup.py (path:/tmp/pip-6R2o2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:31 INFO - Running setup.py (path:/tmp/pip-4zEADn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:31 INFO - Running setup.py (path:/tmp/pip-LLTLh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:31 INFO - Running setup.py (path:/tmp/pip-RYobaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:31 INFO - Running setup.py (path:/tmp/pip-aeJECz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:31 INFO - Running setup.py (path:/tmp/pip-G5toOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:31 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)) 21:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:31 INFO - Running setup.py (path:/tmp/pip-pXCbqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:32 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)) 21:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:32 INFO - Running setup.py (path:/tmp/pip-MsWq5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:32 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)) 21:41:32 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)) 21:41:32 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)) 21:41:32 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)) 21:41:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:34 INFO - Downloading blessings-1.6.tar.gz 21:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:34 INFO - Installing collected packages: blessings 21:41:34 INFO - Running setup.py install for blessings 21:41:34 INFO - Successfully installed blessings 21:41:34 INFO - Cleaning up... 21:41:34 INFO - Return code: 0 21:41:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:34 INFO - Reading from file tmpfile_stdout 21:41:34 INFO - Current package versions: 21:41:34 INFO - argparse == 1.2.1 21:41:34 INFO - blessings == 1.6 21:41:34 INFO - blobuploader == 1.2.4 21:41:34 INFO - docopt == 0.6.1 21:41:34 INFO - functools32 == 3.2.3-2 21:41:34 INFO - jsonschema == 2.5.1 21:41:34 INFO - manifestparser == 1.1 21:41:34 INFO - mozInstall == 1.12 21:41:34 INFO - mozcrash == 1.0 21:41:34 INFO - mozdebug == 0.1 21:41:34 INFO - mozdevice == 0.50 21:41:34 INFO - mozfile == 1.2 21:41:34 INFO - mozhttpd == 0.7 21:41:34 INFO - mozinfo == 0.9 21:41:34 INFO - mozleak == 0.1 21:41:34 INFO - mozlog == 3.4 21:41:34 INFO - moznetwork == 0.27 21:41:34 INFO - mozprocess == 0.25 21:41:34 INFO - mozprofile == 0.28 21:41:34 INFO - mozrunner == 6.13 21:41:34 INFO - mozscreenshot == 0.1 21:41:34 INFO - mozsystemmonitor == 0.3 21:41:34 INFO - moztest == 0.8 21:41:34 INFO - mozversion == 1.4 21:41:34 INFO - psutil == 3.1.1 21:41:34 INFO - requests == 1.2.3 21:41:34 INFO - wsgiref == 0.1.2 21:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:34 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')]} 21:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 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')]} 21:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:34 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 21:41:34 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 21:41:34 INFO - Using env: {'DISPLAY': ':0', 21:41:34 INFO - 'HOME': '/home/cltbld', 21:41:34 INFO - 'LANG': 'en_US.UTF-8', 21:41:34 INFO - 'LANGUAGE': 'en_US:en', 21:41:34 INFO - 'LOGNAME': 'cltbld', 21:41:34 INFO - 'MAIL': '/var/mail/cltbld', 21:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:34 INFO - 'MOZ_NO_REMOTE': '1', 21:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:34 INFO - 'NO_EM_RESTART': '1', 21:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:34 INFO - 'PWD': '/builds/slave/test', 21:41:34 INFO - 'SHELL': '/bin/bash', 21:41:34 INFO - 'SHLVL': '1', 21:41:34 INFO - 'TERM': 'linux', 21:41:34 INFO - 'TMOUT': '86400', 21:41:34 INFO - 'USER': 'cltbld', 21:41:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:34 INFO - '_': '/tools/buildbot/bin/python'} 21:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 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)) 21:41:34 INFO - Cleaning up... 21:41:34 INFO - Return code: 0 21:41:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:41:34 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')]} 21:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 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')]} 21:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:34 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 0x19641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c02310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, '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': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', '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 21:41:34 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 21:41:34 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 21:41:34 INFO - Using env: {'DISPLAY': ':0', 21:41:34 INFO - 'HOME': '/home/cltbld', 21:41:34 INFO - 'LANG': 'en_US.UTF-8', 21:41:34 INFO - 'LANGUAGE': 'en_US:en', 21:41:34 INFO - 'LOGNAME': 'cltbld', 21:41:34 INFO - 'MAIL': '/var/mail/cltbld', 21:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:34 INFO - 'MOZ_NO_REMOTE': '1', 21:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:34 INFO - 'NO_EM_RESTART': '1', 21:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:34 INFO - 'PWD': '/builds/slave/test', 21:41:34 INFO - 'SHELL': '/bin/bash', 21:41:34 INFO - 'SHLVL': '1', 21:41:34 INFO - 'TERM': 'linux', 21:41:34 INFO - 'TMOUT': '86400', 21:41:34 INFO - 'USER': 'cltbld', 21:41:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:34 INFO - '_': '/tools/buildbot/bin/python'} 21:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:41:35 INFO - Cleaning up... 21:41:35 INFO - Return code: 0 21:41:35 INFO - Running post-action listener: _resource_record_post_action 21:41:35 INFO - Running post-action listener: _start_resource_monitoring 21:41:35 INFO - Starting resource monitoring. 21:41:35 INFO - [mozharness: 2017-04-08 04:41:35.192210Z] Finished create-virtualenv step (success) 21:41:35 INFO - [mozharness: 2017-04-08 04:41:35.192672Z] Running install step. 21:41:35 INFO - Running pre-action listener: _resource_record_pre_action 21:41:35 INFO - Running main action method: install 21:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:35 INFO - Reading from file tmpfile_stdout 21:41:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:35 INFO - Reading from file tmpfile_stdout 21:41:35 INFO - Output received: 21:41:35 INFO - Usage: mozinstall [options] installer 21:41:35 INFO - Options: 21:41:35 INFO - -h, --help show this help message and exit 21:41:35 INFO - -d DEST, --destination=DEST 21:41:35 INFO - Directory to install application into. [default: 21:41:35 INFO - "/builds/slave/test"] 21:41:35 INFO - --app=APP Application being installed. [default: firefox] 21:41:35 INFO - mkdir: /builds/slave/test/build/application 21:41:35 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'] 21:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:41:50 INFO - Reading from file tmpfile_stdout 21:41:50 INFO - Output received: 21:41:50 INFO - /builds/slave/test/build/application/firefox/firefox 21:41:50 INFO - Running post-action listener: _resource_record_post_action 21:41:51 INFO - [mozharness: 2017-04-08 04:41:51.000051Z] Finished install step (success) 21:41:51 INFO - [mozharness: 2017-04-08 04:41:51.000300Z] Running run-tests step. 21:41:51 INFO - Running pre-action listener: _resource_record_pre_action 21:41:51 INFO - Running main action method: run_tests 21:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:51 INFO - Python 2.7.3 21:41:51 INFO - Return code: 0 21:41:51 INFO - grabbing minidump binary from tooltool 21:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:51 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 0x1bff400>, '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 0x1c003b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c00840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:51 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 21:41:51 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 21:41:51 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 21:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:51 INFO - Return code: 0 21:41:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:41:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:51 INFO - ENV: RUST_BACKTRACE is now 1 21:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 21:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 21:41:51 INFO - Using env: {'DISPLAY': ':0', 21:41:51 INFO - 'HOME': '/home/cltbld', 21:41:51 INFO - 'LANG': 'en_US.UTF-8', 21:41:51 INFO - 'LANGUAGE': 'en_US:en', 21:41:51 INFO - 'LOGNAME': 'cltbld', 21:41:51 INFO - 'MAIL': '/var/mail/cltbld', 21:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:51 INFO - 'MOZ_NO_REMOTE': '1', 21:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:51 INFO - 'NO_EM_RESTART': '1', 21:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:51 INFO - 'PWD': '/builds/slave/test', 21:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:51 INFO - 'RUST_BACKTRACE': '1', 21:41:51 INFO - 'SHELL': '/bin/bash', 21:41:51 INFO - 'SHLVL': '1', 21:41:51 INFO - 'TERM': 'linux', 21:41:51 INFO - 'TMOUT': '86400', 21:41:51 INFO - 'USER': 'cltbld', 21:41:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165', 21:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:51 INFO - '_': '/tools/buildbot/bin/python'} 21:41:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 21:41:51 INFO - mozversion application_buildid: 20170407184643 21:41:51 INFO - mozversion application_changeset: e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 21:41:51 INFO - mozversion application_display_name: Nightly 21:41:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:51 INFO - mozversion application_name: Firefox 21:41:51 INFO - mozversion application_remotingname: firefox 21:41:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 21:41:51 INFO - mozversion application_vendor: Mozilla 21:41:51 INFO - mozversion application_version: 55.0a1 21:41:51 INFO - mozversion platform_buildid: 20170407184643 21:41:51 INFO - mozversion platform_changeset: e22c7a25dfff8f5d9919e04b3f9b3fadd364eae6 21:41:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 21:41:51 INFO - mozversion platform_version: 55.0a1 21:41:51 INFO - using testdate: 1491626511 21:41:51 INFO - actual date: 1491626511 21:41:51 INFO - starting webserver on 'localhost:45444' 21:41:51 INFO - SUITE-START | Running 2 tests 21:41:51 INFO - TEST-START | dromaeo_css 21:41:51 INFO - operating with platform_type : linux_ 21:41:51 INFO - Initialising browser for dromaeo_css test... 21:41:51 INFO - TEST-INFO | started process 31813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjtlP1W/profile http://localhost:45444/getInfo.html) 21:41:55 INFO - PID 31813 | __metrics Screen width/height:1600/1200 21:41:55 INFO - PID 31813 | colorDepth:24 21:41:55 INFO - PID 31813 | Browser inner width/height: 1024/697 21:41:55 INFO - PID 31813 | __metrics 21:41:57 INFO - PID 31813 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:57 INFO - PID 31813 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:58 INFO - TEST-INFO | 31813: exit 0 21:41:58 INFO - Browser initialized. 21:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:58 INFO - TEST-INFO | started process 31905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjtlP1W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:10 INFO - PID 31905 | RSS: Main: 154955776 21:42:10 INFO - PID 31905 | 21:45:16 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45444/tests/dromaeo/cssquery-ext.html) 21:45:19 INFO - PID 31905 | RSS: Main: 365805568 21:45:19 INFO - PID 31905 | 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | A coding exception was thrown and uncaught in a Task. 21:47:00 INFO - PID 31905 | 21:47:00 ERROR - PID 31905 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:47:00 INFO - PID 31905 | Full stack: 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | A coding exception was thrown and uncaught in a Task. 21:47:00 INFO - PID 31905 | 21:47:00 ERROR - PID 31905 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:47:00 INFO - PID 31905 | Full stack: 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | A coding exception was thrown and uncaught in a Task. 21:47:00 INFO - PID 31905 | 21:47:00 ERROR - PID 31905 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:47:00 INFO - PID 31905 | Full stack: 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | ************************* 21:47:00 INFO - PID 31905 | A coding exception was thrown and uncaught in a Task. 21:47:00 INFO - PID 31905 | 21:47:00 ERROR - PID 31905 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:47:00 INFO - PID 31905 | Full stack: 21:47:00 INFO - PID 31905 | ************************* 21:48:22 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-ext.html (next: http://localhost:45444/tests/dromaeo/cssquery-jquery.html) 21:48:22 INFO - PID 31905 | RSS: Main: 242114560 21:48:22 INFO - PID 31905 | 21:51:24 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45444/tests/dromaeo/cssquery-mootools.html) 21:51:25 INFO - PID 31905 | RSS: Main: 179347456 21:51:25 INFO - PID 31905 | 21:54:27 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45444/tests/dromaeo/cssquery-prototype.html) 21:54:28 INFO - PID 31905 | RSS: Main: 180670464 21:54:28 INFO - PID 31905 | 21:57:31 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45444/tests/dromaeo/cssquery-yui.html) 21:57:31 INFO - PID 31905 | RSS: Main: 188461056 21:57:31 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | Cycle 1(1): loaded http://localhost:45444/tests/dromaeo/cssquery-yui.html (next: http://localhost:45444/tests/dromaeo/cssquery-dojo.html) 22:00:34 INFO - PID 31905 | RSS: Main: 270110720 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | __start_tp_report 22:00:34 INFO - PID 31905 | _x_x_mozilla_page_load 22:00:34 INFO - PID 31905 | _x_x_mozilla_page_load_details 22:00:34 INFO - PID 31905 | |i|pagename|runs| 22:00:34 INFO - PID 31905 | |0;dojo.html;2697.2178068360176;2706.6616672915884;2744.12188099808;2745.1215611004473;2747.1621155547564;5255.343082114736;5273.604479664026;5287.762050707713;5370.167624018279;5398.6220964532495;5273.446288139738;5323.787048518065;5366.838994830152;5369.167778994252;5423.701696406706;4717.2924061390895;4759.785809638566;4802.23164293713;4870.245112007645;4903.8528844134735;4756.048790241931;4810.869445680262;4814.542618451259;4864.367632207808;4918.336024636664;4725.10223057618;4762.3094651275715;4771.28430735389;4781.713097214179;4783.258594917794;4715.481297057321;4717.410323709536;4717.457492388385;4728.645351598644;4749.287606858964;4702.694324868907;4711.411073615798;4711.858644240679;4713.929291060636;4718.245080787092;5270.683758974474;5286.02208591408;5315.920261196085;5345.786168553253;5377.516023557899;5801.129830525413;5827.562932780016;5830.4169583041785;5834.941650583482;5837.357890632027;5786.537077033827;5849.678267695275;5850.707464626752;5859.44335288147;5866.090755932794;5268.051750684837;5286.312779338661;5330.360356757136;5367.75845086972;5403.567714582863;5773.566982476247;6006.729697163638;6038.245219347582;6052.243469566304;6062.939370606237;5618.690971996498;5649.858753531194;5659.915101273484;5685.033544297479;5692.089265717465;5764.942350576441;5773.364929857712;5787.971060144672;5794.072948328331;5798.420157984167;5547.41752116022;5629.24005259293;5629.549636029108;5742.28221472316;5754.395788442153;5727.856803579861;5749.9712501437225;5753.827385178452;5784.942150578525;5804;4846.927296090562;4859.878503037452;4866.732329721828;4868.513148685103;4912.582430493377;4029.71791974559;4111.650509706648;4129.359949207877;4154.626083652486;4177.56135605757;4884.755762211947;4885.169521181408;4936.136176169156;4946.455889852114;4957.281194226889;5763.4812866842185;5768.769249229984;5768.798092066758;5769.884602308014;5770.509506691894;4861.076395484846;4861.538153875376;4864.22172452413;4876.21980483121;4911.656184067081;5020.924686129711;5032.79868805251;5087.592992560586;5168.328117344797;5229.660072095454;5389.191621256843;5416.864578385572;5423.457654234545;5449.182622606482;5473.124300112122;5832.154337621106;5832.795852145155;5833.387494313036;5834.445727655866;5840.620359676607;5197.168453047494;5281.973590132025;5283;5406.729663516887;5422.240886275846;5554.861128471821;5610.775568977195;5610.85972850682;5617.213590097472;5617.691026993554;5691.601587888808;5694.032014557618;5694.971525142348;5695.943040569541;5697.743601537858;5554.916676249779;5625.09998400254;5670.432956704297;5675.631083979528;5677.318721753416;5645.181448689835;5653.491185793298;5658.321001479849;5659.349174844946;5660.801871934463;5411.485908838654;5506.559475241891;5537.141743029837;5551.861203469945;5557.694326812064;5614.943850561442;5619.690916999604;5640.266765320646;5641.774329026793;5645.633033852787;5485.4788795064405;5495.038368285454;5504.669719816824;5509.641873278224;5514.393416724238 22:00:34 INFO - PID 31905 | |1;ext.html;740.4372676765657;759.2066290726189;1064.4252103863914;1078.1751959750786;1080.389579887364;32320.515192272105;33119.172020699494;33198.834005829995;33220.667793322056;33254.16864578384;34473.31053378937;34931.12672183197;34938.65061349392;34950.30099398017;34968.65031349686;5384.434634363394;5561.277033985576;7080.327368899959;7209.243029481881;7219.819504512377;6929.653517324114;7101.78694639159;7116.6441677916155;7118.145822501281;7122.501424900259;7175.784726458214;7216.458765592575;7216.67524961378;7220.566765994057;7223.783286501387;7128.821779455503;7143.928560714378;7176.067111275527;7186.02988596538;7187.964060179718;7140.107486564179;7174.1032370953635;7189.245129261404;7192.532485388485;7197.532160409557;32155.196120097185;32286;32370.676293237;32433.51349729756;32448;2996.715312045352;3022.4106299271652;3022.9546556801665;3024.1985873743474;3025.0471101602925;24173.153939612206;24213.273601791974;24222.87888560546;24277.271681849572;24298.63552046703;3087.4751292280366;3114.6573876873526;3140.1835522764018;3150.8897188598517;3167.4615315396436;136819;137852.31073844567;137945;137955;138599.30700346435;33592.12137875911;33634.831825840716;37845.810770945965;39583.80208098941;39750.60249397469;39700;39723.40414893779;39805.20389592192;39836.601633983286;39847.40228896569;11272.887271127347;11401.144914131308;11401.657950261506;11407.942960285145;11414.201005929672;8980.730578082668;9005.504697241584;9022.097790220925;9022.368434209673;9042.140996605312;10982.890171098186;11162.832557511643;11229.606963756392;11299.17520619845;11334.716632084099;4668;4688.859334219979;4736.076465089343;4742.691725037862;4748.905021899543;871.2724874729545;885.5970533407284;890.3411475508077;908.5094049213351;917.2845180759018;19667.409977700692;19923.800761992483;20245.89877050635;20339.38981830518;20389.18443262253;956.799072194833;963.9807203855884;966.4877614864133;968.8684893234912;984.9950750246203;10526.052655261063;10535.315204511682;10710.196735244888;10715.624953126604;10741.585824342093;183168;183618;184170;184274;184638;38347.23305533874;38365.80817095897;38410.6158938407;38462.42306365407;38537.614623853966;1184.182280199889;1232.8335674683804;1236.4992178167856;1240.3178251961565;1244.6141696074246;18712.409445196765;18918.243270269035;19786.20855165777;19937.401877943685;20321.390358289274;29067.273318167216;29081.85459072691;29184.27039323949;29192.891244032635;29208;176553;178495;178632;178651;178713.106434467;22726;22962.42593935165;23034.76965230326;26903.596446052932;26987.865060674572;31843.681563184073;31872.521912170872;32313.51529727009;32579;32652.183695407806;23444.53110937806;23834.2072509334;25028.499430011663;25084.24747257585;25197.13973582297;24547.38631534226;25348.74651253464;25782.355441114123;25904.22287331383;26297.342566435993;27432.17703468899;27546.173614791587;27622.309442264104;27806.860965695043;28039.719602804525;23006.334616817785;23495.412614684086;23538.529229415657;23696.40758981039;24429.14497992562;19800.20799168075;20324.390268291976;20364.796352036883;20382.18471261192;20517.58964820725 22:00:34 INFO - PID 31905 | |2;jquery.html;406.82506522195445;425.5649156140639;430.64902104784596;439.11956527163034;450.8962938524139;17199.375221442082;17772.555686107837;17820.554486137855;18304;18442.723359149608;18071.819281807177;18339.266429342842;19021.239150434;19259.711104333448;19263.4220973371;5494.560435165187;5502.9174562381595;5729.140628905656;5760.337561180476;5771.82684519463;5636.2954630671165;5712.571557133231;5712.9428705713035;5717.428257174291;5722.456366645162;5510.889782204354;5654.519365853907;5688.63023903447;5693.089105743082;5698;5457.372402173761;5645.463680950304;5695.060315048012;5702.4582664647205;5702.942970570282;5122.795088196505;5143.974280128613;5159.432462429168;5162.92255616166;5163.948360516384;21758.78241217599;21982.89008554963;22007.889960550256;22143.667844982338;22201.777982220294;1611.0414303489406;1653.0329757092115;1653.1734132933534;1653.9007659540466;1654.5284593890683;14180.787288190686;14352.425902963869;14422;14559.636009099751;14990.250487475583;2084.1455003448664;2133.743950725923;2148.645473496871;2156.54712510373;2173.271953895431;72271.63864180645;78942.60528697378;93320.53339733258;93588;94890.52554737183;10944.781104377867;11096.278741881752;11126.276792008493;11255;11390.25963312382;15984.680306393808;15986.60033499172;15992.840071599136;15994.200289985454;16086.115263660377;7741.5742134183165;7774.961125194338;7961.1242763295995;8050;8061.51630902136;7156.892646610305;7287.380572651384;7315.341619254293;7473.327400533978;7512.812179695551;6984.441244700513;7090.6100164491445;7102.644867756591;7117.92882071183;7160.534565253346;1981.8315443187203;2015.828654564349;2021.3632705697657;2073.8859362735193;2157.568486302746;803.9075506316849;822.5147163173756;827.7268501394525;854.8717692346198;882.4925667741074;16557.420490283024;16728.33086676544;16961.406350777663;17165;17289.82710172907;840.9453385529921;847.3475423923544;862.2713806833216;875.1423604867139;881.8324518341494;9113.225375842994;9224.723258302261;9501.334906556474;9507.144357007903;9590.328676992543;477338;485028;500293;513513;520232;93597;94592;95347.52326238324;95559.52220238854;101703;1044.2533588484118;1068.8503609494676;1093.4636835246492;1114.1254115519441;1120.7758448310371;17295.481135565955;17304.480865574053;17904;18123.184456699215;18250.543736406697;42290.788546057076;42959.570404295555;44251;44477.33284000807;45374.31938520859;56643.251980602996;56725;56881;58811;59281.40718592931;7587.2412758723685;7736.342410894912;7916.44584879076;7991.3606911448105;8106.716264930699;11370.602028928948;12038.398080095785;12072.094592905392;12332.383380830743;12973.610791676265;10618.575256989634;10743.818180000037;10743.89256107429;10812.783744325227;10927.672169834917;10149.64476243328;10196.286259961731;10313.639022634172;10325.9483702581;10455.68632941013;10426.895731042592;10530.526126324487;10693.89306106929;10790.946045269724;10805.945970270099;7270.7455239068495;7293.854122917618;7448.627568621656;7569.243075692607;7651.88522172179;10025.248106392195;10179.134773544332;10319;10442.63450779219;10713.839292410465 22:00:34 INFO - PID 31905 | |3;mootools.html;1268.5369840008398;1329.0895736420546;1336.231666791595;1352.5063351876568;1355.2004317452702;9669.081437263458;10054.547545360458;10061.849072263913;10062.647807326744;10071.345362551438;9887.950560247189;10259;10486.737831554216;10496.107830834388;10504.317219380753;2270.0579259607284;2309.9422514437188;2318.7797159269926;2328.6972693549815;2330.149495434163;1911.1877452082879;2192.5176461178594;2294.093832935989;2297.3452566018686;2319.060780383939;1967.1934506852194;2219.844610877239;2288.9198878039274;2292;2294.804941579968;2099.9790002099935;2127.702121702963;2128.2338358191037;2128.361491552528;2133.6799480078034;2190.1567896359857;2195.1658369819365;2197.2090047582856;2198.5712786006734;2201.086549082129;9829.803403931954;10030.097291243823;10047.648332308334;10050.648227312082;10055.949720251425;5665.688387138705;5871.178035075093;5873.383294754032;5875.500582450497;5878.177055212273;3211.5343275224964;3432.5194472773833;3510.8946731598094;3580.1944562473495;3580.4092324766384;1108.22978030269;1124.5108377855659;1138.2715062360096;1147.2428197389766;1151.3840095548842;15113.622159445991;15288.617784555363;15294.158821264937;15307.617309567238;15311.540653780294;4647.651426143053;4823.807047718052;4995.400551933719;5050.444451110375;5067.543921047123;10917.508712107974;10940.671779846618;10943.28868623537;10944.39805810672;10948.671539853658;5643.971780141155;5670.262865827416;5672.716364181774;5676.659400435987;5687.9431205687415;5136.409312928986;5257.947420525746;5260.316158899319;5311.973440132774;5358.624896257303;3824.2160357126722;3918.6277303656107;3939.2515422069714;3980.5820388859333;3980.800959951991;1174.3188950408742;1178.4343515112623;1181.5214837990627;1199.412287978884;1202.8255902894032;570.3781665446103;701.3267263427065;701.8140192848899;702.1363722621204;723.0925188887912;5977.611455255482;5986.760529578855;6010.639361638316;6063.151158837766;6327;508.65665675668777;509.9923501147486;519.7842895198526;523.3510447045636;644.22049320322;3584.211473475831;3668.523091998023;3762.4920635714375;3833.4249862520287;4005.2590270799997;13221.603351899459;13978.510752123628;13994.650133746534;14004.929975350058;14021.859781402056;13452.1256118352;13578.728425431436;13752.518661846787;13755.243461609707;13770.104943178661;9681.854772178423;9696.563654635558;9834.164096051773;9849.950750246346;9870.457124858201;5957.49361304294;6012.398760123952;6021.367756385692;6039.667818270037;6231.40801623845;11333.829992550283;12366.75266494647;12392.070594705252;12415.93792031034;12427.875721242672;11918.702032449259;11997.40012999364;12068.818967715315;12089.879101209228;12117.454714538044;8031.55826429552;8289.378296627898;8426.452280601741;8428.578571071299;8433.325333973145;9118.635254589743;9401.38890972112;9407.153356197976;9482.95258523703;9506.144446999802;8065.112837587978;8088.94440974391;8172.550509722022;8174.305184059422;8255.215754503313;7585.165631780389;7628.618569071413;7654.196309387434;7692;7748.380129589506;7140.46446516503;7144.571325720473;7216.494845360774;7216.89174662391;7224.313690199423;5311.707856067799;5329.440408757025;5423.294971653818;5500.477454641803;5643.858903527444;5004.199328107486;5041.319421878146;5068.543831055223;5188.092083885381;5262.605304602093 22:00:34 INFO - PID 31905 | |4;prototype.html;377.4338492261606;381.79573927948553;383.7026304613926;384.6230693919959;392.672118780818;5349.22436246744;5365.168398898168;5372.7313634318325;5389.164679474688;5400.324959380073;5014.874628134298;5206.526899722639;5282.392524859642;5297.496737809902;5306.416294207644;4051.250518654044;4058.736182148166;4059.614336638022;4064.695147863922;4072.6538244249273;4061.1268577255883;4066.6949978751563;4071.0229544909303;4075.49056367954;4079.5920407959266;4022.356422972325;4026.8187931543002;4033.616806403387;4034.9596504035026;4041.5352234493116;3853.497136116917;3996.200759848013;4003.7597744135446;4010.8796736097966;4017.4576432181575;3495.9825200873834;3496.9825150874335;3507.824608769577;3516.3494753470436;3518.929621407583;5154.329937108152;5167.018266529348;5172.715500647463;5188.625014371195;5205.583553315726;4521.683482156251;4620.745858977755;4650.139724151043;4673.929891051637;4711.670183087185;5538.196961440609;5572.164175373686;5573.331200255995;5581.665100094007;5583.664980101207;3925;3936.862209822671;3953.09078911849;3955.3275943089743;3957.9010524737114;5670.262865827416;5866.002779527491;5902.61632993854;5923.437273459058;5954.4938680212235;4014.197160567898;4022.7586344819406;4026.8187931543152;4027.3153563894207;4035.2333056719717;4081.2245673321972;4082.8366865325647;4089.795510224477;4090.1615168890903;4091.672666186698;4502.212112880233;4643.535646435329;4683.859484215479;4695.5069717679835;4702.600278976257;5577.470140336662;5599.440055994368;5603.467670571289;5622.32532096151;5647.548196144298;1385.1273697570668;1387.5351757161463;1391.2973948156116;1392.512620582788;1395.8045873577707;890.2210565754964;938.7606160429184;944.8346539355723;951.1439704266078;954.2699834626517;4879.121758083508;4898.436679781799;4904.8773780655765;4908.214685650279;4925.261210818406;5778.422157784188;5806.564507661942;5814.76740930358;5818.970905145532;5867.647941123546;4731.313959475857;4925.458199598042;4929.433115191727;4939.234418665113;4952.306677065214;3057.785954983174;3093.9381212375624;3094.164575564585;3095.839060352368;3106.51848963411;5444.5916556258435;5446.564274858002;5464.508194262536;5469.589780766459;5495.472082841858;5669.951059054089;5826;5947.762089516457;6010.1401133894105;6027.276726792726;5286;5318.335208098988;5413.485718856702;5420.7560659769615;5421.457854214705;5809.448102430262;5840.503557197686;5840.883182336414;5850.327212370462;5854.677992710442;5581.302337207849;5618.297712785902;5634.915081419901;5683.7442315095095;5745.597808153389;5389.784408623611;5395.78416863321;5400.810971615974;5413.458654134555;5429.592780541396;3999.7600743769526;4002.7598344099447;4004.7196696230985;4008.7995600219288;4018.819153138057;5573.693446860461;5772.19189313488;5778.075507918713;5813.563982701399;5835.649861008353;5587.636803607753;5588.636738611977;5614.5789065821045;5627.324721033338;5652.434756524314;5433.375161856437;5635.464630860061;5641.661500309994;5645.943540564542;5649.350324712711;5513.476219759116;5524.66851988882;5531.834044978657;5532.197831314356;5539.786923584231;5626.549876009827;5637.605367624227;5647.770853307773;5671.412004638708;5671.674613408482;5277.894442111213;5486.451354864482;5494.615376923577;5497.285352904097;5529.419410961791 22:00:34 INFO - PID 31905 | |5;yui.html;711.6619605687296;730.6456368661202;750.6171852355297;751.0311697909697;771.467687295766;13867.23730194839;14304.928475357608;14345.354459049342;14431.711365772679;14440.494582689595;13120.934395328033;13173.275469849155;13217.206967581951;13221.07452478327;13239.338033098355;878.3061381508617;909.5952301225957;917.0966597901062;920.5903372999018;921.3136213520936;912.63494602159;913;914.2320450821309;920.1580553793272;926.3191554207652;960.6781728121088;961.3991255465335;961.624966263158;961.7307153996892;964.2286171063122;959.5681943125621;959.6065613098596;960.2462067277223;961.2598299309562;965.2229954886313;709.1242315740056;709.5565271705184;709.6061685764398;710.946678999072;713.2582114600809;13414.798778018338;13920.721585568232;14431.422743090263;14457.277136143255;14621.049631774007;13718.794218086736;14192.645183870383;14222.431102755878;14254.857451425456;14357.56927292183;11685.474153663106;11701.356425396685;11810.173287869853;11817.231879927776;11833.408329583572;2884.610577572022;2926.6488021437563;2928.458235226469;2929.3555417808047;2933.325335172922;63456.68271658658;63948.5792420628;64952;65678.67160664214;66129.33870661329;10716.678499645022;10842.744401843804;10861.1854110942;10899.182561307935;10933.234673572773;21672.78327216739;21784;21832;21946.561068778534;22079.889600552215;6630.635315057718;6750.392464678104;7028.016077749119;7036.120484939383;7105.573665580082;3444.156181735441;3542.4508158462104;3551.751377403557;3566.3045706087582;3569.696575791035;3706.629337066272;4132.566080561558;4311.892202694895;4330.588594083557;4364.1708075466195;792.37798328312;808;818.4516374029415;821.0270829067574;825.9834803303901;591.9674417907056;600.1208229943154;607.2075940897172;616.3836163836164;629.087822657149;8418.663253469793;8802.955985220033;9054.320925930582;9085.863712044325;9114.316426268057;576.6828244465527;595.8838026584862;606.9575129740964;616.5067945643467;617.9926719447362;3929.587393323717;3944.230874979409;4028.254772867029;4037.3245103282397;4163.146554956226;64462.6776866122;65040;65127;65171;67399.32600674029;56410;56451.43548564544;56735;56967.43032569704;57452;37401.625983740356;46810.76594617073;47713.52286477091;48706.51293487091;48746.02507949821;8954.194122529003;9421.813731611624;9487.383320084173;9551.665691700757;9614.807703846023;26937.73062269352;27132.32169195786;27277.86361068182;27487.725122748518;28382.432351352443;32425;32823.835880821396;32929.17677057997;33295.66704333023;33641.327173456884;11706.648800535997;11713.707157321136;11802.704932376759;11899.702507437383;11990.340531270514;12300.935193761663;12307;12324.445399956845;12656.557020504606;12703;12131.955682808415;12249.265044097383;12364.258144511357;12614.873851261369;13085.345732713517;11213.887861121611;11409.486573104396;11422.543098275975;11776.882231177578;12104.939475302566;11350.318980861175;11403;11759.176857619885;11892.702682432662;12049.457774399998;8299.212911432496;8305.335573154254;8322.958385208036;8424.620892059995;8719.738407847775;9520.285978551776;9948.751281218027;9963.153131983863;9964.651237206663;9988.800223995624 22:00:34 INFO - PID 31905 | __end_tp_report 22:00:34 INFO - PID 31905 | __start_cc_report 22:00:34 INFO - PID 31905 | _x_x_mozilla_cycle_collect,2687 22:00:34 INFO - PID 31905 | __end_cc_report 22:00:34 INFO - PID 31905 | __startTimestamp1491627634646__endTimestamp 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | ------- Summary: start ------- 22:00:34 INFO - PID 31905 | Number of tests: 6 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#0] dojo.html Cycles:165 Average:5269.88 Median:5423.46 stddev:628.84 (11.6%) stddev-sans-first:597.50 22:00:34 INFO - PID 31905 | Values: 2697.2 2706.7 2744.1 2745.1 2747.2 5255.3 5273.6 5287.8 5370.2 5398.6 5273.4 5323.8 5366.8 5369.2 5423.7 4717.3 4759.8 4802.2 4870.2 4903.9 4756.0 4810.9 4814.5 4864.4 4918.3 4725.1 4762.3 4771.3 4781.7 4783.3 4715.5 4717.4 4717.5 4728.6 4749.3 4702.7 4711.4 4711.9 4713.9 4718.2 5270.7 5286.0 5315.9 5345.8 5377.5 5801.1 5827.6 5830.4 5834.9 5837.4 5786.5 5849.7 5850.7 5859.4 5866.1 5268.1 5286.3 5330.4 5367.8 5403.6 5773.6 6006.7 6038.2 6052.2 6062.9 5618.7 5649.9 5659.9 5685.0 5692.1 5764.9 5773.4 5788.0 5794.1 5798.4 5547.4 5629.2 5629.5 5742.3 5754.4 5727.9 5750.0 5753.8 5784.9 5804.0 4846.9 4859.9 4866.7 4868.5 4912.6 4029.7 4111.7 4129.4 4154.6 4177.6 4884.8 4885.2 4936.1 4946.5 4957.3 5763.5 5768.8 5768.8 5769.9 5770.5 4861.1 4861.5 4864.2 4876.2 4911.7 5020.9 5032.8 5087.6 5168.3 5229.7 5389.2 5416.9 5423.5 5449.2 5473.1 5832.2 5832.8 5833.4 5834.4 5840.6 5197.2 5282.0 5283.0 5406.7 5422.2 5554.9 5610.8 5610.9 5617.2 5617.7 5691.6 5694.0 5695.0 5695.9 5697.7 5554.9 5625.1 5670.4 5675.6 5677.3 5645.2 5653.5 5658.3 5659.3 5660.8 5411.5 5506.6 5537.1 5551.9 5557.7 5614.9 5619.7 5640.3 5641.8 5645.6 5485.5 5495.0 5504.7 5509.6 5514.4 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#1] ext.html Cycles:180 Average:29974.65 Median:3023.58 stddev:43467.65 (1437.6%) stddev-sans-first:43534.16 22:00:34 INFO - PID 31905 | Values: 740.4 759.2 1064.4 1078.2 1080.4 32320.5 33119.2 33198.8 33220.7 33254.2 34473.3 34931.1 34938.7 34950.3 34968.7 5384.4 5561.3 7080.3 7209.2 7219.8 6929.7 7101.8 7116.6 7118.1 7122.5 7175.8 7216.5 7216.7 7220.6 7223.8 7128.8 7143.9 7176.1 7186.0 7188.0 7140.1 7174.1 7189.2 7192.5 7197.5 32155.2 32286.0 32370.7 32433.5 32448.0 2996.7 3022.4 3023.0 3024.2 3025.0 24173.2 24213.3 24222.9 24277.3 24298.6 3087.5 3114.7 3140.2 3150.9 3167.5 136819.0 137852.3 137945.0 137955.0 138599.3 33592.1 33634.8 37845.8 39583.8 39750.6 39700.0 39723.4 39805.2 39836.6 39847.4 11272.9 11401.1 11401.7 11407.9 11414.2 8980.7 9005.5 9022.1 9022.4 9042.1 10982.9 11162.8 11229.6 11299.2 11334.7 4668.0 4688.9 4736.1 4742.7 4748.9 871.3 885.6 890.3 908.5 917.3 19667.4 19923.8 20245.9 20339.4 20389.2 956.8 964.0 966.5 968.9 985.0 10526.1 10535.3 10710.2 10715.6 10741.6 183168.0 183618.0 184170.0 184274.0 184638.0 38347.2 38365.8 38410.6 38462.4 38537.6 1184.2 1232.8 1236.5 1240.3 1244.6 18712.4 18918.2 19786.2 19937.4 20321.4 29067.3 29081.9 29184.3 29192.9 29208.0 176553.0 178495.0 178632.0 178651.0 178713.1 22726.0 22962.4 23034.8 26903.6 26987.9 31843.7 31872.5 32313.5 32579.0 32652.2 23444.5 23834.2 25028.5 25084.2 25197.1 24547.4 25348.7 25782.4 25904.2 26297.3 27432.2 27546.2 27622.3 27806.9 28039.7 23006.3 23495.4 23538.5 23696.4 24429.1 19800.2 20324.4 20364.8 20382.2 20517.6 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#2] jquery.html Cycles:180 Average:29355.41 Median:434.88 stddev:82574.25 (18987.6%) stddev-sans-first:82777.28 22:00:34 INFO - PID 31905 | Values: 406.8 425.6 430.6 439.1 450.9 17199.4 17772.6 17820.6 18304.0 18442.7 18071.8 18339.3 19021.2 19259.7 19263.4 5494.6 5502.9 5729.1 5760.3 5771.8 5636.3 5712.6 5712.9 5717.4 5722.5 5510.9 5654.5 5688.6 5693.1 5698.0 5457.4 5645.5 5695.1 5702.5 5702.9 5122.8 5144.0 5159.4 5162.9 5163.9 21758.8 21982.9 22007.9 22143.7 22201.8 1611.0 1653.0 1653.2 1653.9 1654.5 14180.8 14352.4 14422.0 14559.6 14990.3 2084.1 2133.7 2148.6 2156.5 2173.3 72271.6 78942.6 93320.5 93588.0 94890.5 10944.8 11096.3 11126.3 11255.0 11390.3 15984.7 15986.6 15992.8 15994.2 16086.1 7741.6 7775.0 7961.1 8050.0 8061.5 7156.9 7287.4 7315.3 7473.3 7512.8 6984.4 7090.6 7102.6 7117.9 7160.5 1981.8 2015.8 2021.4 2073.9 2157.6 803.9 822.5 827.7 854.9 882.5 16557.4 16728.3 16961.4 17165.0 17289.8 840.9 847.3 862.3 875.1 881.8 9113.2 9224.7 9501.3 9507.1 9590.3 477338.0 485028.0 500293.0 513513.0 520232.0 93597.0 94592.0 95347.5 95559.5 101703.0 1044.3 1068.9 1093.5 1114.1 1120.8 17295.5 17304.5 17904.0 18123.2 18250.5 42290.8 42959.6 44251.0 44477.3 45374.3 56643.3 56725.0 56881.0 58811.0 59281.4 7587.2 7736.3 7916.4 7991.4 8106.7 11370.6 12038.4 12072.1 12332.4 12973.6 10618.6 10743.8 10743.9 10812.8 10927.7 10149.6 10196.3 10313.6 10325.9 10455.7 10426.9 10530.5 10693.9 10790.9 10805.9 7270.7 7293.9 7448.6 7569.2 7651.9 10025.2 10179.1 10319.0 10442.6 10713.8 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#3] mootools.html Cycles:180 Average:6394.05 Median:3828.82 stddev:4121.40 (107.6%) stddev-sans-first:4114.97 22:00:34 INFO - PID 31905 | Values: 1268.5 1329.1 1336.2 1352.5 1355.2 9669.1 10054.5 10061.8 10062.6 10071.3 9888.0 10259.0 10486.7 10496.1 10504.3 2270.1 2309.9 2318.8 2328.7 2330.1 1911.2 2192.5 2294.1 2297.3 2319.1 1967.2 2219.8 2288.9 2292.0 2294.8 2100.0 2127.7 2128.2 2128.4 2133.7 2190.2 2195.2 2197.2 2198.6 2201.1 9829.8 10030.1 10047.6 10050.6 10055.9 5665.7 5871.2 5873.4 5875.5 5878.2 3211.5 3432.5 3510.9 3580.2 3580.4 1108.2 1124.5 1138.3 1147.2 1151.4 15113.6 15288.6 15294.2 15307.6 15311.5 4647.7 4823.8 4995.4 5050.4 5067.5 10917.5 10940.7 10943.3 10944.4 10948.7 5644.0 5670.3 5672.7 5676.7 5687.9 5136.4 5257.9 5260.3 5312.0 5358.6 3824.2 3918.6 3939.3 3980.6 3980.8 1174.3 1178.4 1181.5 1199.4 1202.8 570.4 701.3 701.8 702.1 723.1 5977.6 5986.8 6010.6 6063.2 6327.0 508.7 510.0 519.8 523.4 644.2 3584.2 3668.5 3762.5 3833.4 4005.3 13221.6 13978.5 13994.7 14004.9 14021.9 13452.1 13578.7 13752.5 13755.2 13770.1 9681.9 9696.6 9834.2 9850.0 9870.5 5957.5 6012.4 6021.4 6039.7 6231.4 11333.8 12366.8 12392.1 12415.9 12427.9 11918.7 11997.4 12068.8 12089.9 12117.5 8031.6 8289.4 8426.5 8428.6 8433.3 9118.6 9401.4 9407.2 9483.0 9506.1 8065.1 8088.9 8172.6 8174.3 8255.2 7585.2 7628.6 7654.2 7692.0 7748.4 7140.5 7144.6 7216.5 7216.9 7224.3 5311.7 5329.4 5423.3 5500.5 5643.9 5004.2 5041.3 5068.5 5188.1 5262.6 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#4] prototype.html Cycles:180 Average:4624.01 Median:5301.96 stddev:1364.26 (25.7%) stddev-sans-first:1330.33 22:00:34 INFO - PID 31905 | Values: 377.4 381.8 383.7 384.6 392.7 5349.2 5365.2 5372.7 5389.2 5400.3 5014.9 5206.5 5282.4 5297.5 5306.4 4051.3 4058.7 4059.6 4064.7 4072.7 4061.1 4066.7 4071.0 4075.5 4079.6 4022.4 4026.8 4033.6 4035.0 4041.5 3853.5 3996.2 4003.8 4010.9 4017.5 3496.0 3497.0 3507.8 3516.3 3518.9 5154.3 5167.0 5172.7 5188.6 5205.6 4521.7 4620.7 4650.1 4673.9 4711.7 5538.2 5572.2 5573.3 5581.7 5583.7 3925.0 3936.9 3953.1 3955.3 3957.9 5670.3 5866.0 5902.6 5923.4 5954.5 4014.2 4022.8 4026.8 4027.3 4035.2 4081.2 4082.8 4089.8 4090.2 4091.7 4502.2 4643.5 4683.9 4695.5 4702.6 5577.5 5599.4 5603.5 5622.3 5647.5 1385.1 1387.5 1391.3 1392.5 1395.8 890.2 938.8 944.8 951.1 954.3 4879.1 4898.4 4904.9 4908.2 4925.3 5778.4 5806.6 5814.8 5819.0 5867.6 4731.3 4925.5 4929.4 4939.2 4952.3 3057.8 3093.9 3094.2 3095.8 3106.5 5444.6 5446.6 5464.5 5469.6 5495.5 5670.0 5826.0 5947.8 6010.1 6027.3 5286.0 5318.3 5413.5 5420.8 5421.5 5809.4 5840.5 5840.9 5850.3 5854.7 5581.3 5618.3 5634.9 5683.7 5745.6 5389.8 5395.8 5400.8 5413.5 5429.6 3999.8 4002.8 4004.7 4008.8 4018.8 5573.7 5772.2 5778.1 5813.6 5835.6 5587.6 5588.6 5614.6 5627.3 5652.4 5433.4 5635.5 5641.7 5645.9 5649.4 5513.5 5524.7 5531.8 5532.2 5539.8 5626.5 5637.6 5647.8 5671.4 5671.7 5277.9 5486.5 5494.6 5497.3 5529.4 22:00:34 INFO - PID 31905 | 22:00:34 INFO - PID 31905 | [#5] yui.html Cycles:180 Average:14419.86 Median:25587.47 stddev:17430.07 (68.1%) stddev-sans-first:17448.56 22:00:34 INFO - PID 31905 | Values: 711.7 730.6 750.6 751.0 771.5 13867.2 14304.9 14345.4 14431.7 14440.5 13120.9 13173.3 13217.2 13221.1 13239.3 878.3 909.6 917.1 920.6 921.3 912.6 913.0 914.2 920.2 926.3 960.7 961.4 961.6 961.7 964.2 959.6 959.6 960.2 961.3 965.2 709.1 709.6 709.6 710.9 713.3 13414.8 13920.7 14431.4 14457.3 14621.0 13718.8 14192.6 14222.4 14254.9 14357.6 11685.5 11701.4 11810.2 11817.2 11833.4 2884.6 2926.6 2928.5 2929.4 2933.3 63456.7 63948.6 64952.0 65678.7 66129.3 10716.7 10842.7 10861.2 10899.2 10933.2 21672.8 21784.0 21832.0 21946.6 22079.9 6630.6 6750.4 7028.0 7036.1 7105.6 3444.2 3542.5 3551.8 3566.3 3569.7 3706.6 4132.6 4311.9 4330.6 4364.2 792.4 808.0 818.5 821.0 826.0 592.0 600.1 607.2 616.4 629.1 8418.7 8803.0 9054.3 9085.9 9114.3 576.7 595.9 607.0 616.5 618.0 3929.6 3944.2 4028.3 4037.3 4163.1 64462.7 65040.0 65127.0 65171.0 67399.3 56410.0 56451.4 56735.0 56967.4 57452.0 37401.6 46810.8 47713.5 48706.5 48746.0 8954.2 9421.8 9487.4 9551.7 9614.8 26937.7 27132.3 27277.9 27487.7 28382.4 32425.0 32823.8 32929.2 33295.7 33641.3 11706.6 11713.7 11802.7 11899.7 11990.3 12300.9 12307.0 12324.4 12656.6 12703.0 12132.0 12249.3 12364.3 12614.9 13085.3 11213.9 11409.5 11422.5 11776.9 12104.9 11350.3 11403.0 11759.2 11892.7 12049.5 8299.2 8305.3 8323.0 8424.6 8719.7 9520.3 9948.8 9963.2 9964.7 9988.8 22:00:34 INFO - PID 31905 | -------- Summary: end -------- 22:00:34 INFO - PID 31905 | 22:00:35 INFO - TEST-INFO | 31905: exit 0 22:00:35 INFO - TEST-OK | dromaeo_css | took 1124265ms 22:00:35 INFO - TEST-START | kraken 22:00:35 INFO - operating with platform_type : linux_ 22:00:35 INFO - Initialising browser for kraken test... 22:00:35 INFO - TEST-INFO | started process 32228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQLN76/profile http://localhost:45444/getInfo.html) 22:00:39 INFO - PID 32228 | __metrics Screen width/height:1600/1200 22:00:39 INFO - PID 32228 | colorDepth:24 22:00:39 INFO - PID 32228 | Browser inner width/height: 1024/697 22:00:39 INFO - PID 32228 | __metrics 22:00:41 INFO - PID 32228 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:00:41 INFO - PID 32228 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:42 INFO - TEST-INFO | 32228: exit 0 22:00:42 INFO - Browser initialized. 22:00:42 INFO - Running cycle 1/1 for kraken test... 22:00:42 INFO - TEST-INFO | started process 32319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQLN76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:54 INFO - PID 32319 | RSS: Main: 154456064 22:00:54 INFO - PID 32319 | 22:00:57 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45444/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:58 INFO - PID 32319 | RSS: Main: 209592320 22:00:58 INFO - PID 32319 | 22:01:00 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45444/tests/kraken/driver.html?testName=audio-dft) 22:01:01 INFO - PID 32319 | RSS: Main: 188981248 22:01:01 INFO - PID 32319 | 22:01:04 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45444/tests/kraken/driver.html?testName=audio-fft) 22:01:05 INFO - PID 32319 | RSS: Main: 271708160 22:01:05 INFO - PID 32319 | 22:01:07 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45444/tests/kraken/driver.html?testName=audio-oscillator) 22:01:08 INFO - PID 32319 | RSS: Main: 182366208 22:01:08 INFO - PID 32319 | 22:01:10 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:10 INFO - PID 32319 | RSS: Main: 185671680 22:01:10 INFO - PID 32319 | 22:01:14 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45444/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:14 INFO - PID 32319 | RSS: Main: 224489472 22:01:14 INFO - PID 32319 | 22:01:18 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45444/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:18 INFO - PID 32319 | RSS: Main: 220012544 22:01:18 INFO - PID 32319 | 22:01:21 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45444/tests/kraken/driver.html?testName=json-parse-financial) 22:01:22 INFO - PID 32319 | RSS: Main: 220876800 22:01:22 INFO - PID 32319 | 22:01:24 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:24 INFO - PID 32319 | RSS: Main: 185171968 22:01:24 INFO - PID 32319 | 22:01:26 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:27 INFO - PID 32319 | RSS: Main: 191467520 22:01:27 INFO - PID 32319 | 22:01:29 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:29 INFO - PID 32319 | RSS: Main: 200671232 22:01:29 INFO - PID 32319 | 22:01:32 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:33 INFO - PID 32319 | RSS: Main: 211030016 22:01:33 INFO - PID 32319 | 22:01:36 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:01:37 INFO - PID 32319 | RSS: Main: 207077376 22:01:37 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | Cycle 1(1): loaded http://localhost:45444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45444/tests/kraken/driver.html?testName=ai-astar) 22:01:39 INFO - PID 32319 | RSS: Main: 275755008 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | __start_tp_report 22:01:39 INFO - PID 32319 | _x_x_mozilla_page_load 22:01:39 INFO - PID 32319 | _x_x_mozilla_page_load_details 22:01:39 INFO - PID 32319 | |i|pagename|runs| 22:01:39 INFO - PID 32319 | |0;ai-astar;103;111;112;114;110;111;111;114;112;110 22:01:39 INFO - PID 32319 | |1;audio-beat-detection;155;125;123;170;136;123;126;122;149;123 22:01:39 INFO - PID 32319 | |2;audio-dft;163;166;164;176;166;166;164;165;165;164 22:01:39 INFO - PID 32319 | |3;audio-fft;75;77;76;106;75;75;75;76;94;76 22:01:39 INFO - PID 32319 | |4;audio-oscillator;83;85;121;83;84;84;101;83;83;116 22:01:39 INFO - PID 32319 | |5;imaging-gaussian-blur;115;114;114;114;113;114;114;113;114;114 22:01:39 INFO - PID 32319 | |6;imaging-darkroom;150;150;150;149;150;149;150;151;151;150 22:01:39 INFO - PID 32319 | |7;imaging-desaturate;94;94;94;95;94;94;95;95;95;95 22:01:39 INFO - PID 32319 | |8;json-parse-financial;52;53;53;52;53;54;54;60;55;55 22:01:39 INFO - PID 32319 | |9;json-stringify-tinderbox;55;55;56;55;56;58;59;57;58;56 22:01:39 INFO - PID 32319 | |10;stanford-crypto-aes;83;83;83;83;83;83;83;82;84;82 22:01:39 INFO - PID 32319 | |11;stanford-crypto-ccm;135;136;146;137;145;139;144;134;188;138 22:01:39 INFO - PID 32319 | |12;stanford-crypto-pbkdf2;198;194;197;199;198;198;192;202;206;196 22:01:39 INFO - PID 32319 | |13;stanford-crypto-sha256-iterative;74;73;74;71;70;76;75;71;73;71 22:01:39 INFO - PID 32319 | __end_tp_report 22:01:39 INFO - PID 32319 | __start_cc_report 22:01:39 INFO - PID 32319 | _x_x_mozilla_cycle_collect,1997 22:01:39 INFO - PID 32319 | __end_cc_report 22:01:39 INFO - PID 32319 | __startTimestamp1491627699445__endTimestamp 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | ------- Summary: start ------- 22:01:39 INFO - PID 32319 | Number of tests: 14 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.08 (2.8%) stddev-sans-first:1.50 22:01:39 INFO - PID 32319 | Values: 103.0 111.0 112.0 114.0 110.0 111.0 111.0 114.0 112.0 110.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:131.00 stddev:17.01 (13.0%) stddev-sans-first:16.46 22:01:39 INFO - PID 32319 | Values: 155.0 125.0 123.0 170.0 136.0 123.0 126.0 122.0 149.0 123.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:3.70 (2.2%) stddev-sans-first:3.77 22:01:39 INFO - PID 32319 | Values: 163.0 166.0 164.0 176.0 166.0 166.0 164.0 165.0 165.0 164.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.68 (14.1%) stddev-sans-first:11.14 22:01:39 INFO - PID 32319 | Values: 75.0 77.0 76.0 106.0 75.0 75.0 75.0 76.0 94.0 76.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.90 (18.0%) stddev-sans-first:15.42 22:01:39 INFO - PID 32319 | Values: 83.0 85.0 121.0 83.0 84.0 84.0 101.0 83.0 83.0 116.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 22:01:39 INFO - PID 32319 | Values: 115.0 114.0 114.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 22:01:39 INFO - PID 32319 | Values: 150.0 150.0 150.0 149.0 150.0 149.0 150.0 151.0 151.0 150.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 22:01:39 INFO - PID 32319 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:2.33 (4.3%) stddev-sans-first:2.35 22:01:39 INFO - PID 32319 | Values: 52.0 53.0 53.0 52.0 53.0 54.0 54.0 60.0 55.0 55.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:1.43 (2.5%) stddev-sans-first:1.41 22:01:39 INFO - PID 32319 | Values: 55.0 55.0 56.0 55.0 56.0 58.0 59.0 57.0 58.0 56.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 22:01:39 INFO - PID 32319 | Values: 83.0 83.0 83.0 83.0 83.0 83.0 83.0 82.0 84.0 82.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.50 stddev:15.97 (11.3%) stddev-sans-first:16.59 22:01:39 INFO - PID 32319 | Values: 135.0 136.0 146.0 137.0 145.0 139.0 144.0 134.0 188.0 138.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.00 Median:198.00 stddev:3.92 (2.0%) stddev-sans-first:4.15 22:01:39 INFO - PID 32319 | Values: 198.0 194.0 197.0 199.0 198.0 198.0 192.0 202.0 206.0 196.0 22:01:39 INFO - PID 32319 | 22:01:39 INFO - PID 32319 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.50 stddev:1.99 (2.7%) stddev-sans-first:2.06 22:01:39 INFO - PID 32319 | Values: 74.0 73.0 74.0 71.0 70.0 76.0 75.0 71.0 73.0 71.0 22:01:39 INFO - PID 32319 | -------- Summary: end -------- 22:01:39 INFO - PID 32319 | 22:01:40 INFO - TEST-INFO | 32319: exit 0 22:01:40 INFO - TEST-OK | kraken | took 65257ms 22:01:40 INFO - SUITE-END | took 1189s 22:01:41 INFO - Completed test suite (00:19:49) 22:01:41 INFO - javascript benchmark 22:01:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6653.126450037498, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.2178068360176, 2706.6616672915884, 2744.12188099808, 2745.1215611004473, 2747.1621155547564, 5255.343082114736, 5273.604479664026, 5287.762050707713, 5370.167624018279, 5398.6220964532495, 5273.446288139738, 5323.787048518065, 5366.838994830152, 5369.167778994252, 5423.701696406706, 4717.2924061390895, 4759.785809638566, 4802.23164293713, 4870.245112007645, 4903.8528844134735, 4756.048790241931, 4810.869445680262, 4814.542618451259, 4864.367632207808, 4918.336024636664, 4725.10223057618, 4762.3094651275715, 4771.28430735389, 4781.713097214179, 4783.258594917794, 4715.481297057321, 4717.410323709536, 4717.457492388385, 4728.645351598644, 4749.287606858964, 4702.694324868907, 4711.411073615798, 4711.858644240679, 4713.929291060636, 4718.245080787092, 5270.683758974474, 5286.02208591408, 5315.920261196085, 5345.786168553253, 5377.516023557899, 5801.129830525413, 5827.562932780016, 5830.4169583041785, 5834.941650583482, 5837.357890632027, 5786.537077033827, 5849.678267695275, 5850.707464626752, 5859.44335288147, 5866.090755932794, 5268.051750684837, 5286.312779338661, 5330.360356757136, 5367.75845086972, 5403.567714582863, 5773.566982476247, 6006.729697163638, 6038.245219347582, 6052.243469566304, 6062.939370606237, 5618.690971996498, 5649.858753531194, 5659.915101273484, 5685.033544297479, 5692.089265717465, 5764.942350576441, 5773.364929857712, 5787.971060144672, 5794.072948328331, 5798.420157984167, 5547.41752116022, 5629.24005259293, 5629.549636029108, 5742.28221472316, 5754.395788442153, 5727.856803579861, 5749.9712501437225, 5753.827385178452, 5784.942150578525, 5804.0, 4846.927296090562, 4859.878503037452, 4866.732329721828, 4868.513148685103, 4912.582430493377, 4029.71791974559, 4111.650509706648, 4129.359949207877, 4154.626083652486, 4177.56135605757, 4884.755762211947, 4885.169521181408, 4936.136176169156, 4946.455889852114, 4957.281194226889, 5763.4812866842185, 5768.769249229984, 5768.798092066758, 5769.884602308014, 5770.509506691894, 4861.076395484846, 4861.538153875376, 4864.22172452413, 4876.21980483121, 4911.656184067081, 5020.924686129711, 5032.79868805251, 5087.592992560586, 5168.328117344797, 5229.660072095454, 5389.191621256843, 5416.864578385572, 5423.457654234545, 5449.182622606482, 5473.124300112122, 5832.154337621106, 5832.795852145155, 5833.387494313036, 5834.445727655866, 5840.620359676607, 5197.168453047494, 5281.973590132025, 5283.0, 5406.729663516887, 5422.240886275846, 5554.861128471821, 5610.775568977195, 5610.85972850682, 5617.213590097472, 5617.691026993554, 5691.601587888808, 5694.032014557618, 5694.971525142348, 5695.943040569541, 5697.743601537858, 5554.916676249779, 5625.09998400254, 5670.432956704297, 5675.631083979528, 5677.318721753416, 5645.181448689835, 5653.491185793298, 5658.321001479849, 5659.349174844946, 5660.801871934463, 5411.485908838654, 5506.559475241891, 5537.141743029837, 5551.861203469945, 5557.694326812064, 5614.943850561442, 5619.690916999604, 5640.266765320646, 5641.774329026793, 5645.633033852787, 5485.4788795064405, 5495.038368285454, 5504.669719816824, 5509.641873278224, 5514.393416724238], "value": 5223.041959091506, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4372676765657, 759.2066290726189, 1064.4252103863914, 1078.1751959750786, 1080.389579887364, 32320.515192272105, 33119.172020699494, 33198.834005829995, 33220.667793322056, 33254.16864578384, 34473.31053378937, 34931.12672183197, 34938.65061349392, 34950.30099398017, 34968.65031349686, 5384.434634363394, 5561.277033985576, 7080.327368899959, 7209.243029481881, 7219.819504512377, 6929.653517324114, 7101.78694639159, 7116.6441677916155, 7118.145822501281, 7122.501424900259, 7175.784726458214, 7216.458765592575, 7216.67524961378, 7220.566765994057, 7223.783286501387, 7128.821779455503, 7143.928560714378, 7176.067111275527, 7186.02988596538, 7187.964060179718, 7140.107486564179, 7174.1032370953635, 7189.245129261404, 7192.532485388485, 7197.532160409557, 32155.196120097185, 32286.0, 32370.676293237, 32433.51349729756, 32448.0, 2996.715312045352, 3022.4106299271652, 3022.9546556801665, 3024.1985873743474, 3025.0471101602925, 24173.153939612206, 24213.273601791974, 24222.87888560546, 24277.271681849572, 24298.63552046703, 3087.4751292280366, 3114.6573876873526, 3140.1835522764018, 3150.8897188598517, 3167.4615315396436, 136819.0, 137852.31073844567, 137945.0, 137955.0, 138599.30700346435, 33592.12137875911, 33634.831825840716, 37845.810770945965, 39583.80208098941, 39750.60249397469, 39700.0, 39723.40414893779, 39805.20389592192, 39836.601633983286, 39847.40228896569, 11272.887271127347, 11401.144914131308, 11401.657950261506, 11407.942960285145, 11414.201005929672, 8980.730578082668, 9005.504697241584, 9022.097790220925, 9022.368434209673, 9042.140996605312, 10982.890171098186, 11162.832557511643, 11229.606963756392, 11299.17520619845, 11334.716632084099, 4668.0, 4688.859334219979, 4736.076465089343, 4742.691725037862, 4748.905021899543, 871.2724874729545, 885.5970533407284, 890.3411475508077, 908.5094049213351, 917.2845180759018, 19667.409977700692, 19923.800761992483, 20245.89877050635, 20339.38981830518, 20389.18443262253, 956.799072194833, 963.9807203855884, 966.4877614864133, 968.8684893234912, 984.9950750246203, 10526.052655261063, 10535.315204511682, 10710.196735244888, 10715.624953126604, 10741.585824342093, 183168.0, 183618.0, 184170.0, 184274.0, 184638.0, 38347.23305533874, 38365.80817095897, 38410.6158938407, 38462.42306365407, 38537.614623853966, 1184.182280199889, 1232.8335674683804, 1236.4992178167856, 1240.3178251961565, 1244.6141696074246, 18712.409445196765, 18918.243270269035, 19786.20855165777, 19937.401877943685, 20321.390358289274, 29067.273318167216, 29081.85459072691, 29184.27039323949, 29192.891244032635, 29208.0, 176553.0, 178495.0, 178632.0, 178651.0, 178713.106434467, 22726.0, 22962.42593935165, 23034.76965230326, 26903.596446052932, 26987.865060674572, 31843.681563184073, 31872.521912170872, 32313.51529727009, 32579.0, 32652.183695407806, 23444.53110937806, 23834.2072509334, 25028.499430011663, 25084.24747257585, 25197.13973582297, 24547.38631534226, 25348.74651253464, 25782.355441114123, 25904.22287331383, 26297.342566435993, 27432.17703468899, 27546.173614791587, 27622.309442264104, 27806.860965695043, 28039.719602804525, 23006.334616817785, 23495.412614684086, 23538.529229415657, 23696.40758981039, 24429.14497992562, 19800.20799168075, 20324.390268291976, 20364.796352036883, 20382.18471261192, 20517.58964820725], "value": 13955.169096550315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.82506522195445, 425.5649156140639, 430.64902104784596, 439.11956527163034, 450.8962938524139, 17199.375221442082, 17772.555686107837, 17820.554486137855, 18304.0, 18442.723359149608, 18071.819281807177, 18339.266429342842, 19021.239150434, 19259.711104333448, 19263.4220973371, 5494.560435165187, 5502.9174562381595, 5729.140628905656, 5760.337561180476, 5771.82684519463, 5636.2954630671165, 5712.571557133231, 5712.9428705713035, 5717.428257174291, 5722.456366645162, 5510.889782204354, 5654.519365853907, 5688.63023903447, 5693.089105743082, 5698.0, 5457.372402173761, 5645.463680950304, 5695.060315048012, 5702.4582664647205, 5702.942970570282, 5122.795088196505, 5143.974280128613, 5159.432462429168, 5162.92255616166, 5163.948360516384, 21758.78241217599, 21982.89008554963, 22007.889960550256, 22143.667844982338, 22201.777982220294, 1611.0414303489406, 1653.0329757092115, 1653.1734132933534, 1653.9007659540466, 1654.5284593890683, 14180.787288190686, 14352.425902963869, 14422.0, 14559.636009099751, 14990.250487475583, 2084.1455003448664, 2133.743950725923, 2148.645473496871, 2156.54712510373, 2173.271953895431, 72271.63864180645, 78942.60528697378, 93320.53339733258, 93588.0, 94890.52554737183, 10944.781104377867, 11096.278741881752, 11126.276792008493, 11255.0, 11390.25963312382, 15984.680306393808, 15986.60033499172, 15992.840071599136, 15994.200289985454, 16086.115263660377, 7741.5742134183165, 7774.961125194338, 7961.1242763295995, 8050.0, 8061.51630902136, 7156.892646610305, 7287.380572651384, 7315.341619254293, 7473.327400533978, 7512.812179695551, 6984.441244700513, 7090.6100164491445, 7102.644867756591, 7117.92882071183, 7160.534565253346, 1981.8315443187203, 2015.828654564349, 2021.3632705697657, 2073.8859362735193, 2157.568486302746, 803.9075506316849, 822.5147163173756, 827.7268501394525, 854.8717692346198, 882.4925667741074, 16557.420490283024, 16728.33086676544, 16961.406350777663, 17165.0, 17289.82710172907, 840.9453385529921, 847.3475423923544, 862.2713806833216, 875.1423604867139, 881.8324518341494, 9113.225375842994, 9224.723258302261, 9501.334906556474, 9507.144357007903, 9590.328676992543, 477338.0, 485028.0, 500293.0, 513513.0, 520232.0, 93597.0, 94592.0, 95347.52326238324, 95559.52220238854, 101703.0, 1044.2533588484118, 1068.8503609494676, 1093.4636835246492, 1114.1254115519441, 1120.7758448310371, 17295.481135565955, 17304.480865574053, 17904.0, 18123.184456699215, 18250.543736406697, 42290.788546057076, 42959.570404295555, 44251.0, 44477.33284000807, 45374.31938520859, 56643.251980602996, 56725.0, 56881.0, 58811.0, 59281.40718592931, 7587.2412758723685, 7736.342410894912, 7916.44584879076, 7991.3606911448105, 8106.716264930699, 11370.602028928948, 12038.398080095785, 12072.094592905392, 12332.383380830743, 12973.610791676265, 10618.575256989634, 10743.818180000037, 10743.89256107429, 10812.783744325227, 10927.672169834917, 10149.64476243328, 10196.286259961731, 10313.639022634172, 10325.9483702581, 10455.68632941013, 10426.895731042592, 10530.526126324487, 10693.89306106929, 10790.946045269724, 10805.945970270099, 7270.7455239068495, 7293.854122917618, 7448.627568621656, 7569.243075692607, 7651.88522172179, 10025.248106392195, 10179.134773544332, 10319.0, 10442.63450779219, 10713.839292410465], "value": 9041.438176793103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.5369840008398, 1329.0895736420546, 1336.231666791595, 1352.5063351876568, 1355.2004317452702, 9669.081437263458, 10054.547545360458, 10061.849072263913, 10062.647807326744, 10071.345362551438, 9887.950560247189, 10259.0, 10486.737831554216, 10496.107830834388, 10504.317219380753, 2270.0579259607284, 2309.9422514437188, 2318.7797159269926, 2328.6972693549815, 2330.149495434163, 1911.1877452082879, 2192.5176461178594, 2294.093832935989, 2297.3452566018686, 2319.060780383939, 1967.1934506852194, 2219.844610877239, 2288.9198878039274, 2292.0, 2294.804941579968, 2099.9790002099935, 2127.702121702963, 2128.2338358191037, 2128.361491552528, 2133.6799480078034, 2190.1567896359857, 2195.1658369819365, 2197.2090047582856, 2198.5712786006734, 2201.086549082129, 9829.803403931954, 10030.097291243823, 10047.648332308334, 10050.648227312082, 10055.949720251425, 5665.688387138705, 5871.178035075093, 5873.383294754032, 5875.500582450497, 5878.177055212273, 3211.5343275224964, 3432.5194472773833, 3510.8946731598094, 3580.1944562473495, 3580.4092324766384, 1108.22978030269, 1124.5108377855659, 1138.2715062360096, 1147.2428197389766, 1151.3840095548842, 15113.622159445991, 15288.617784555363, 15294.158821264937, 15307.617309567238, 15311.540653780294, 4647.651426143053, 4823.807047718052, 4995.400551933719, 5050.444451110375, 5067.543921047123, 10917.508712107974, 10940.671779846618, 10943.28868623537, 10944.39805810672, 10948.671539853658, 5643.971780141155, 5670.262865827416, 5672.716364181774, 5676.659400435987, 5687.9431205687415, 5136.409312928986, 5257.947420525746, 5260.316158899319, 5311.973440132774, 5358.624896257303, 3824.2160357126722, 3918.6277303656107, 3939.2515422069714, 3980.5820388859333, 3980.800959951991, 1174.3188950408742, 1178.4343515112623, 1181.5214837990627, 1199.412287978884, 1202.8255902894032, 570.3781665446103, 701.3267263427065, 701.8140192848899, 702.1363722621204, 723.0925188887912, 5977.611455255482, 5986.760529578855, 6010.639361638316, 6063.151158837766, 6327.0, 508.65665675668777, 509.9923501147486, 519.7842895198526, 523.3510447045636, 644.22049320322, 3584.211473475831, 3668.523091998023, 3762.4920635714375, 3833.4249862520287, 4005.2590270799997, 13221.603351899459, 13978.510752123628, 13994.650133746534, 14004.929975350058, 14021.859781402056, 13452.1256118352, 13578.728425431436, 13752.518661846787, 13755.243461609707, 13770.104943178661, 9681.854772178423, 9696.563654635558, 9834.164096051773, 9849.950750246346, 9870.457124858201, 5957.49361304294, 6012.398760123952, 6021.367756385692, 6039.667818270037, 6231.40801623845, 11333.829992550283, 12366.75266494647, 12392.070594705252, 12415.93792031034, 12427.875721242672, 11918.702032449259, 11997.40012999364, 12068.818967715315, 12089.879101209228, 12117.454714538044, 8031.55826429552, 8289.378296627898, 8426.452280601741, 8428.578571071299, 8433.325333973145, 9118.635254589743, 9401.38890972112, 9407.153356197976, 9482.95258523703, 9506.144446999802, 8065.112837587978, 8088.94440974391, 8172.550509722022, 8174.305184059422, 8255.215754503313, 7585.165631780389, 7628.618569071413, 7654.196309387434, 7692.0, 7748.380129589506, 7140.46446516503, 7144.571325720473, 7216.494845360774, 7216.89174662391, 7224.313690199423, 5311.707856067799, 5329.440408757025, 5423.294971653818, 5500.477454641803, 5643.858903527444, 5004.199328107486, 5041.319421878146, 5068.543831055223, 5188.092083885381, 5262.605304602093], "value": 4764.2175063452305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.4338492261606, 381.79573927948553, 383.7026304613926, 384.6230693919959, 392.672118780818, 5349.22436246744, 5365.168398898168, 5372.7313634318325, 5389.164679474688, 5400.324959380073, 5014.874628134298, 5206.526899722639, 5282.392524859642, 5297.496737809902, 5306.416294207644, 4051.250518654044, 4058.736182148166, 4059.614336638022, 4064.695147863922, 4072.6538244249273, 4061.1268577255883, 4066.6949978751563, 4071.0229544909303, 4075.49056367954, 4079.5920407959266, 4022.356422972325, 4026.8187931543002, 4033.616806403387, 4034.9596504035026, 4041.5352234493116, 3853.497136116917, 3996.200759848013, 4003.7597744135446, 4010.8796736097966, 4017.4576432181575, 3495.9825200873834, 3496.9825150874335, 3507.824608769577, 3516.3494753470436, 3518.929621407583, 5154.329937108152, 5167.018266529348, 5172.715500647463, 5188.625014371195, 5205.583553315726, 4521.683482156251, 4620.745858977755, 4650.139724151043, 4673.929891051637, 4711.670183087185, 5538.196961440609, 5572.164175373686, 5573.331200255995, 5581.665100094007, 5583.664980101207, 3925.0, 3936.862209822671, 3953.09078911849, 3955.3275943089743, 3957.9010524737114, 5670.262865827416, 5866.002779527491, 5902.61632993854, 5923.437273459058, 5954.4938680212235, 4014.197160567898, 4022.7586344819406, 4026.8187931543152, 4027.3153563894207, 4035.2333056719717, 4081.2245673321972, 4082.8366865325647, 4089.795510224477, 4090.1615168890903, 4091.672666186698, 4502.212112880233, 4643.535646435329, 4683.859484215479, 4695.5069717679835, 4702.600278976257, 5577.470140336662, 5599.440055994368, 5603.467670571289, 5622.32532096151, 5647.548196144298, 1385.1273697570668, 1387.5351757161463, 1391.2973948156116, 1392.512620582788, 1395.8045873577707, 890.2210565754964, 938.7606160429184, 944.8346539355723, 951.1439704266078, 954.2699834626517, 4879.121758083508, 4898.436679781799, 4904.8773780655765, 4908.214685650279, 4925.261210818406, 5778.422157784188, 5806.564507661942, 5814.76740930358, 5818.970905145532, 5867.647941123546, 4731.313959475857, 4925.458199598042, 4929.433115191727, 4939.234418665113, 4952.306677065214, 3057.785954983174, 3093.9381212375624, 3094.164575564585, 3095.839060352368, 3106.51848963411, 5444.5916556258435, 5446.564274858002, 5464.508194262536, 5469.589780766459, 5495.472082841858, 5669.951059054089, 5826.0, 5947.762089516457, 6010.1401133894105, 6027.276726792726, 5286.0, 5318.335208098988, 5413.485718856702, 5420.7560659769615, 5421.457854214705, 5809.448102430262, 5840.503557197686, 5840.883182336414, 5850.327212370462, 5854.677992710442, 5581.302337207849, 5618.297712785902, 5634.915081419901, 5683.7442315095095, 5745.597808153389, 5389.784408623611, 5395.78416863321, 5400.810971615974, 5413.458654134555, 5429.592780541396, 3999.7600743769526, 4002.7598344099447, 4004.7196696230985, 4008.7995600219288, 4018.819153138057, 5573.693446860461, 5772.19189313488, 5778.075507918713, 5813.563982701399, 5835.649861008353, 5587.636803607753, 5588.636738611977, 5614.5789065821045, 5627.324721033338, 5652.434756524314, 5433.375161856437, 5635.464630860061, 5641.661500309994, 5645.943540564542, 5649.350324712711, 5513.476219759116, 5524.66851988882, 5531.834044978657, 5532.197831314356, 5539.786923584231, 5626.549876009827, 5637.605367624227, 5647.770853307773, 5671.412004638708, 5671.674613408482, 5277.894442111213, 5486.451354864482, 5494.615376923577, 5497.285352904097, 5529.419410961791], "value": 4205.028443665375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6619605687296, 730.6456368661202, 750.6171852355297, 751.0311697909697, 771.467687295766, 13867.23730194839, 14304.928475357608, 14345.354459049342, 14431.711365772679, 14440.494582689595, 13120.934395328033, 13173.275469849155, 13217.206967581951, 13221.07452478327, 13239.338033098355, 878.3061381508617, 909.5952301225957, 917.0966597901062, 920.5903372999018, 921.3136213520936, 912.63494602159, 913.0, 914.2320450821309, 920.1580553793272, 926.3191554207652, 960.6781728121088, 961.3991255465335, 961.624966263158, 961.7307153996892, 964.2286171063122, 959.5681943125621, 959.6065613098596, 960.2462067277223, 961.2598299309562, 965.2229954886313, 709.1242315740056, 709.5565271705184, 709.6061685764398, 710.946678999072, 713.2582114600809, 13414.798778018338, 13920.721585568232, 14431.422743090263, 14457.277136143255, 14621.049631774007, 13718.794218086736, 14192.645183870383, 14222.431102755878, 14254.857451425456, 14357.56927292183, 11685.474153663106, 11701.356425396685, 11810.173287869853, 11817.231879927776, 11833.408329583572, 2884.610577572022, 2926.6488021437563, 2928.458235226469, 2929.3555417808047, 2933.325335172922, 63456.68271658658, 63948.5792420628, 64952.0, 65678.67160664214, 66129.33870661329, 10716.678499645022, 10842.744401843804, 10861.1854110942, 10899.182561307935, 10933.234673572773, 21672.78327216739, 21784.0, 21832.0, 21946.561068778534, 22079.889600552215, 6630.635315057718, 6750.392464678104, 7028.016077749119, 7036.120484939383, 7105.573665580082, 3444.156181735441, 3542.4508158462104, 3551.751377403557, 3566.3045706087582, 3569.696575791035, 3706.629337066272, 4132.566080561558, 4311.892202694895, 4330.588594083557, 4364.1708075466195, 792.37798328312, 808.0, 818.4516374029415, 821.0270829067574, 825.9834803303901, 591.9674417907056, 600.1208229943154, 607.2075940897172, 616.3836163836164, 629.087822657149, 8418.663253469793, 8802.955985220033, 9054.320925930582, 9085.863712044325, 9114.316426268057, 576.6828244465527, 595.8838026584862, 606.9575129740964, 616.5067945643467, 617.9926719447362, 3929.587393323717, 3944.230874979409, 4028.254772867029, 4037.3245103282397, 4163.146554956226, 64462.6776866122, 65040.0, 65127.0, 65171.0, 67399.32600674029, 56410.0, 56451.43548564544, 56735.0, 56967.43032569704, 57452.0, 37401.625983740356, 46810.76594617073, 47713.52286477091, 48706.51293487091, 48746.02507949821, 8954.194122529003, 9421.813731611624, 9487.383320084173, 9551.665691700757, 9614.807703846023, 26937.73062269352, 27132.32169195786, 27277.86361068182, 27487.725122748518, 28382.432351352443, 32425.0, 32823.835880821396, 32929.17677057997, 33295.66704333023, 33641.327173456884, 11706.648800535997, 11713.707157321136, 11802.704932376759, 11899.702507437383, 11990.340531270514, 12300.935193761663, 12307.0, 12324.445399956845, 12656.557020504606, 12703.0, 12131.955682808415, 12249.265044097383, 12364.258144511357, 12614.873851261369, 13085.345732713517, 11213.887861121611, 11409.486573104396, 11422.543098275975, 11776.882231177578, 12104.939475302566, 11350.318980861175, 11403.0, 11759.176857619885, 11892.702682432662, 12049.457774399998, 8299.212911432496, 8305.335573154254, 8322.958385208036, 8424.620892059995, 8719.738407847775, 9520.285978551776, 9948.751281218027, 9963.153131983863, 9964.651237206663, 9988.800223995624], "value": 6568.509368115375, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 114.0, 110.0, 111.0, 111.0, 114.0, 112.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 123.0, 170.0, 136.0, 123.0, 126.0, 122.0, 149.0, 123.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 176.0, 166.0, 166.0, 164.0, 165.0, 165.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 106.0, 75.0, 75.0, 75.0, 76.0, 94.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 121.0, 83.0, 84.0, 84.0, 101.0, 83.0, 83.0, 116.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 149.0, 150.0, 149.0, 150.0, 151.0, 151.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 53.0, 54.0, 54.0, 60.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 56.0, 58.0, 59.0, 57.0, 58.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 146.0, 137.0, 145.0, 139.0, 144.0, 134.0, 188.0, 138.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 194.0, 197.0, 199.0, 198.0, 198.0, 192.0, 202.0, 206.0, 196.0], "value": 198.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 71.0, 70.0, 76.0, 75.0, 71.0, 73.0, 71.0], "value": 72.8, "unit": "score"}]}]} 22:01:41 INFO - Return code: 0 22:01:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:01:41 ERROR - # TBPL SUCCESS # 22:01:41 INFO - Running post-action listener: _resource_record_post_action 22:01:41 INFO - [mozharness: 2017-04-08 05:01:41.242059Z] Finished run-tests step (success) 22:01:41 INFO - Running post-run listener: _resource_record_post_run 22:01:41 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356585472; Read time: 8; Write time: 225736 22:01:41 INFO - TinderboxPrint: CPU usage
13.0% 22:01:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:01:41 INFO - TinderboxPrint: I/O write bytes / time
356,585,472 / 225,736 22:01:41 INFO - TinderboxPrint: CPU idle
8,365.5 (87.0%) 22:01:41 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 22:01:41 INFO - TinderboxPrint: Swap in / out
0 / 0 22:01:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101240832; Read time: 0; Write time: 61620 22:01:41 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255344640; Read time: 8; Write time: 164116 22:01:41 INFO - Running post-run listener: _upload_blobber_files 22:01:41 INFO - Blob upload gear active. 22:01:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:01:41 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 22:01:41 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:01:41 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:01:42 INFO - (blobuploader) - INFO - Open directory for files ... 22:01:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:01:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:01:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:43 INFO - (blobuploader) - INFO - Done attempting. 22:01:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:01:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:46 INFO - (blobuploader) - INFO - Done attempting. 22:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:47 INFO - (blobuploader) - INFO - Done attempting. 22:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:47 INFO - (blobuploader) - INFO - Done attempting. 22:01:47 INFO - (blobuploader) - INFO - Iteration through files over. 22:01:47 INFO - Return code: 0 22:01:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:01:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:01:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/111fded5bbd7aa5701bdbf25902adba2401a1ae55a03f3799ad0d8d6d7fc7a8a5f87552f9b4c69bdc52dfed772022851b7124aac514c4fa714eb09fc0d91456a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d8bcc480547df08b6f1e5f84278dcaecab4da21200a0a052ed449b1416807ab25353c8af83df98db914c20447cd232442c191272fc0ff6b67fba950d153a809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2036881bce94781148df004b1afff8bcc1f0f5ce2ceb1b5d6f51c8954511b84149ad21ef03b53a83da0a0bce50766a515dc3286de5d67f3134ab6f5f55c11a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/aab8080d4a4e4f549bf02503fb14e6d23ee2cb6e114b5887fa7a4d5f4cd9d2db72b945c6ef358110ec0499983a0c4cd9c6a8df6c4c6d06b5cc9e2ef10a9d69a4"} 22:01:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:01:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:01:47 INFO - Contents: 22:01:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/111fded5bbd7aa5701bdbf25902adba2401a1ae55a03f3799ad0d8d6d7fc7a8a5f87552f9b4c69bdc52dfed772022851b7124aac514c4fa714eb09fc0d91456a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d8bcc480547df08b6f1e5f84278dcaecab4da21200a0a052ed449b1416807ab25353c8af83df98db914c20447cd232442c191272fc0ff6b67fba950d153a809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2036881bce94781148df004b1afff8bcc1f0f5ce2ceb1b5d6f51c8954511b84149ad21ef03b53a83da0a0bce50766a515dc3286de5d67f3134ab6f5f55c11a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/aab8080d4a4e4f549bf02503fb14e6d23ee2cb6e114b5887fa7a4d5f4cd9d2db72b945c6ef358110ec0499983a0c4cd9c6a8df6c4c6d06b5cc9e2ef10a9d69a4"} 22:01:47 INFO - Running post-run listener: copy_logs_to_upload_dir 22:01:47 INFO - Copying logs to upload dir... 22:01:47 INFO - mkdir: /builds/slave/test/build/upload/logs 22:01:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.916277 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-07 22:01:47.579924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 22:01:47.583901) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/111fded5bbd7aa5701bdbf25902adba2401a1ae55a03f3799ad0d8d6d7fc7a8a5f87552f9b4c69bdc52dfed772022851b7124aac514c4fa714eb09fc0d91456a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d8bcc480547df08b6f1e5f84278dcaecab4da21200a0a052ed449b1416807ab25353c8af83df98db914c20447cd232442c191272fc0ff6b67fba950d153a809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2036881bce94781148df004b1afff8bcc1f0f5ce2ceb1b5d6f51c8954511b84149ad21ef03b53a83da0a0bce50766a515dc3286de5d67f3134ab6f5f55c11a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/aab8080d4a4e4f549bf02503fb14e6d23ee2cb6e114b5887fa7a4d5f4cd9d2db72b945c6ef358110ec0499983a0c4cd9c6a8df6c4c6d06b5cc9e2ef10a9d69a4"} build_url:https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/LsBSD0zvTeahS9JDb0v94g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/111fded5bbd7aa5701bdbf25902adba2401a1ae55a03f3799ad0d8d6d7fc7a8a5f87552f9b4c69bdc52dfed772022851b7124aac514c4fa714eb09fc0d91456a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0d8bcc480547df08b6f1e5f84278dcaecab4da21200a0a052ed449b1416807ab25353c8af83df98db914c20447cd232442c191272fc0ff6b67fba950d153a809", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/c2036881bce94781148df004b1afff8bcc1f0f5ce2ceb1b5d6f51c8954511b84149ad21ef03b53a83da0a0bce50766a515dc3286de5d67f3134ab6f5f55c11a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/aab8080d4a4e4f549bf02503fb14e6d23ee2cb6e114b5887fa7a4d5f4cd9d2db72b945c6ef358110ec0499983a0c4cd9c6a8df6c4c6d06b5cc9e2ef10a9d69a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 22:01:47.609113) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 22:01:47.609428) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1491626441.692128-1987758165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 22:01:47.694421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 22:01:47.694746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 22:01:47.695047) ========= ========= Total master_lag: 0.17 =========