builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1490312830.92 results: success (0) revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:10.918820) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:10.919283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:10.919550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:10.944464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:10.944757) ========= 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=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 16:47:11-- 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% 46.8M=0s 2017-03-23 16:47:11 (46.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117336 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.090592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.090933) ========= 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=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052180 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.155686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.156006) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01d1dedf400d4be413b1a0d48090dca7acf29637 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 01d1dedf400d4be413b1a0d48090dca7acf29637 --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=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 16:47:11,555 truncating revision to first 12 chars 2017-03-23 16:47:11,555 Setting DEBUG logging. 2017-03-23 16:47:11,555 attempt 1/10 2017-03-23 16:47:11,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01d1dedf400d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 16:47:11,863 unpacking tar archive at: mozilla-central-01d1dedf400d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.897976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.900110) ========= script_repo_revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.900546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.900807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:11.908066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-03-23 16:47:11.908339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:47:12 INFO - MultiFileLogger online at 20170323 16:47:12 in /builds/slave/test 16:47:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:47:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:47:12 INFO - {'append_to_log': False, 16:47:12 INFO - 'base_work_dir': '/builds/slave/test', 16:47:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:47:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:47:12 INFO - 'branch': 'Firefox-Non-PGO', 16:47:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:47:12 INFO - 'config_files': ('talos/linux_config.py',), 16:47:12 INFO - 'default_actions': ('clobber', 16:47:12 INFO - 'read-buildbot-config', 16:47:12 INFO - 'download-and-extract', 16:47:12 INFO - 'populate-webroot', 16:47:12 INFO - 'create-virtualenv', 16:47:12 INFO - 'install', 16:47:12 INFO - 'run-tests'), 16:47:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:47:12 INFO - 'download_minidump_stackwalk': True, 16:47:12 INFO - 'download_symbols': 'ondemand', 16:47:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:47:12 INFO - 'tooltool.py': '/tools/tooltool.py', 16:47:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:47:12 INFO - '/tools/misc-python/virtualenv.py')}, 16:47:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:47:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:47:12 INFO - 'gecko_profile': False, 16:47:12 INFO - 'gecko_profile_interval': 0, 16:47:12 INFO - 'installer_path': 'installer.exe', 16:47:12 INFO - 'log_level': 'info', 16:47:12 INFO - 'log_name': 'talos', 16:47:12 INFO - 'log_to_console': True, 16:47:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:47:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:47:12 INFO - 'opt_config_files': (), 16:47:12 INFO - 'pip_index': False, 16:47:12 INFO - 'suite': 'dromaeojs', 16:47:12 INFO - 'system_bits': '32', 16:47:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:47:12 INFO - 'title': 'talos-linux64-ix-017', 16:47:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:47:12 INFO - 'use_talos_json': True, 16:47:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:47:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:47:12 INFO - 'work_dir': 'build'} 16:47:12 INFO - [mozharness: 2017-03-23 23:47:12.486149Z] Running clobber step. 16:47:12 INFO - Running pre-action listener: _resource_record_pre_action 16:47:12 INFO - Running main action method: clobber 16:47:12 INFO - rmtree: /builds/slave/test/build 16:47:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:47:14 INFO - Running post-action listener: _resource_record_post_action 16:47:14 INFO - [mozharness: 2017-03-23 23:47:14.586707Z] Finished clobber step (success) 16:47:14 INFO - [mozharness: 2017-03-23 23:47:14.586835Z] Running read-buildbot-config step. 16:47:14 INFO - Running pre-action listener: _resource_record_pre_action 16:47:14 INFO - Running main action method: read_buildbot_config 16:47:14 INFO - Using buildbot properties: 16:47:14 INFO - { 16:47:14 INFO - "project": "", 16:47:14 INFO - "product": "firefox", 16:47:14 INFO - "who": "kwierso@gmail.com", 16:47:14 INFO - "installer_path": "public/build/target.tar.bz2", 16:47:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:47:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:47:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:47:14 INFO - "stage_platform": "linux64", 16:47:14 INFO - "basedir": "/builds/slave/test", 16:47:14 INFO - "buildnumber": 509, 16:47:14 INFO - "platform": "ubuntu64_hw", 16:47:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:47:14 INFO - "slavebuilddir": "test", 16:47:14 INFO - "taskId": "bp1aOUiGTt--NqS1N5RpFg", 16:47:14 INFO - "branch": "mozilla-central", 16:47:14 INFO - "script_repo_revision": "production", 16:47:14 INFO - "revision": "01d1dedf400d4be413b1a0d48090dca7acf29637", 16:47:14 INFO - "slavename": "talos-linux64-ix-017", 16:47:14 INFO - "repo_path": "mozilla-central" 16:47:14 INFO - } 16:47:14 INFO - Finding installer, test and symbols from parent task. 16:47:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bp1aOUiGTt--NqS1N5RpFg'}, attempt #1 16:47:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bp1aOUiGTt--NqS1N5RpFg'}, attempt #1 16:47:15 INFO - Task dependencies: Bg3_ZOuERsGBA1k1GNxQSA 16:47:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA'}, attempt #1 16:47:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:47:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/test_packages.json 16:47:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip 16:47:15 INFO - Running post-action listener: _resource_record_post_action 16:47:15 INFO - [mozharness: 2017-03-23 23:47:15.972711Z] Finished read-buildbot-config step (success) 16:47:15 INFO - [mozharness: 2017-03-23 23:47:15.972925Z] Running download-and-extract step. 16:47:15 INFO - Running pre-action listener: _resource_record_pre_action 16:47:15 INFO - Running main action method: download_and_extract 16:47:15 INFO - mkdir: /builds/slave/test/build/tests 16:47: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')]} 16:47:15 INFO - trying https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json 16:47:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:47:16 INFO - Downloaded 986 bytes. 16:47:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:47:16 INFO - Using the following test package requirements: 16:47:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:47:16 INFO - u'common': [u'target.common.tests.zip'], 16:47:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:47:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:47:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:47:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:47:16 INFO - u'mozbase': [u'target.common.tests.zip'], 16:47:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:47:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:47:16 INFO - u'web-platform': [u'target.common.tests.zip', 16:47:16 INFO - u'target.web-platform.tests.zip'], 16:47:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:47:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:47:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip 16:47:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:47:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip into memory 16:47:17 INFO - Expected file size: 58125575 16:47:17 INFO - Obtained file size: 58125575 16:47:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip 16:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip into memory 16:47:28 INFO - Expected file size: 58125575 16:47:28 INFO - Obtained file size: 58125575 16:47:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip 16:47:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:47:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip into memory 16:47:40 INFO - Expected file size: 14404171 16:47:40 INFO - Obtained file size: 14404171 16:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:40 INFO - trying https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:47:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:47:41 INFO - Downloaded 62433763 bytes. 16:47:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:47:41 INFO - mkdir: /builds/slave/test/properties 16:47:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:47:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:47:41 INFO - Contents: 16:47:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:47:41 INFO - Running post-action listener: _resource_record_post_action 16:47:41 INFO - Running post-action listener: set_extra_try_arguments 16:47:41 INFO - [mozharness: 2017-03-23 23:47:41.491852Z] Finished download-and-extract step (success) 16:47:41 INFO - [mozharness: 2017-03-23 23:47:41.491947Z] Running populate-webroot step. 16:47:41 INFO - Running pre-action listener: _resource_record_pre_action 16:47:41 INFO - Running main action method: populate_webroot 16:47:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:41 INFO - '--tppagecycles', 16:47:41 INFO - '7'], 16:47:41 INFO - 'tests': ['tsvgm']}}, 16:47:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:47:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:47:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['damp', 'tps']}, 16:47:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'tests': ['damp', 'tps']}, 16:47:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['dromaeo_dom']}, 16:47:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['basic_compositor_video']}, 16:47:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:47:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['a11yr', 16:47:41 INFO - 'ts_paint', 16:47:41 INFO - 'tpaint', 16:47:41 INFO - 'sessionrestore', 16:47:41 INFO - 'sessionrestore_no_auto_restore', 16:47:41 INFO - 'tabpaint']}, 16:47:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['tsvgx', 16:47:41 INFO - 'tsvgr_opacity', 16:47:41 INFO - 'tart', 16:47:41 INFO - 'tscrollx', 16:47:41 INFO - 'cart', 16:47:41 INFO - 'tsvg_static']}, 16:47:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:47:41 INFO - 'tsvgr_opacity', 16:47:41 INFO - 'tart', 16:47:41 INFO - 'tscrollx', 16:47:41 INFO - 'cart', 16:47:41 INFO - 'tsvg_static']}, 16:47:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'talos_options': ['--disable-e10s'], 16:47:41 INFO - 'tests': ['tp5o']}, 16:47:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:47:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'talos_options': ['--disable-e10s', 16:47:41 INFO - '--xperf_path', 16:47:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:41 INFO - 'tests': ['tp5n']}, 16:47:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:47:41 INFO - 'talos_options': ['--xperf_path', 16:47:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:41 INFO - 'tests': ['tp5n']}}, 16:47:41 INFO - 'talos.zip': {'path': '', 16:47:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:41 INFO - Running post-action listener: _resource_record_post_action 16:47:41 INFO - [mozharness: 2017-03-23 23:47:41.504976Z] Finished populate-webroot step (success) 16:47:41 INFO - [mozharness: 2017-03-23 23:47:41.505064Z] Running create-virtualenv step. 16:47:41 INFO - Running pre-action listener: _resource_record_pre_action 16:47:41 INFO - Running main action method: create_virtualenv 16:47:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:47:41 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 16:47:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:47:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:41 INFO - Using real prefix '/usr' 16:47:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:47:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:44 INFO - Installing pip.................done. 16:47:44 INFO - Return code: 0 16:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:47:45 INFO - Reading from file tmpfile_stdout 16:47:45 INFO - Output received: 16:47:45 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) 16:47:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:45 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 16:47:45 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 16:47:45 INFO - Using env: {'DISPLAY': ':0', 16:47:45 INFO - 'HOME': '/home/cltbld', 16:47:45 INFO - 'LANG': 'en_US.UTF-8', 16:47:45 INFO - 'LANGUAGE': 'en_US:en', 16:47:45 INFO - 'LOGNAME': 'cltbld', 16:47:45 INFO - 'MAIL': '/var/mail/cltbld', 16:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:45 INFO - 'MOZ_NO_REMOTE': '1', 16:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:45 INFO - 'NO_EM_RESTART': '1', 16:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:45 INFO - 'PWD': '/builds/slave/test', 16:47:45 INFO - 'SHELL': '/bin/bash', 16:47:45 INFO - 'SHLVL': '1', 16:47:45 INFO - 'TERM': 'linux', 16:47:45 INFO - 'TMOUT': '86400', 16:47:45 INFO - 'USER': 'cltbld', 16:47:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:45 INFO - '_': '/tools/buildbot/bin/python'} 16:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:45 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 16:47:45 INFO - Cleaning up... 16:47:45 INFO - Return code: 0 16:47:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:45 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 16:47:45 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 16:47:45 INFO - Using env: {'DISPLAY': ':0', 16:47:45 INFO - 'HOME': '/home/cltbld', 16:47:45 INFO - 'LANG': 'en_US.UTF-8', 16:47:45 INFO - 'LANGUAGE': 'en_US:en', 16:47:45 INFO - 'LOGNAME': 'cltbld', 16:47:45 INFO - 'MAIL': '/var/mail/cltbld', 16:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:45 INFO - 'MOZ_NO_REMOTE': '1', 16:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:45 INFO - 'NO_EM_RESTART': '1', 16:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:45 INFO - 'PWD': '/builds/slave/test', 16:47:45 INFO - 'SHELL': '/bin/bash', 16:47:45 INFO - 'SHLVL': '1', 16:47:45 INFO - 'TERM': 'linux', 16:47:45 INFO - 'TMOUT': '86400', 16:47:45 INFO - 'USER': 'cltbld', 16:47:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:45 INFO - '_': '/tools/buildbot/bin/python'} 16:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:45 INFO - Downloading/unpacking psutil>=3.1.1 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:47 INFO - Installing collected packages: psutil 16:47:47 INFO - Running setup.py install for psutil 16:47:47 INFO - building 'psutil._psutil_linux' extension 16:47:47 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 16:47:48 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 16:47:48 INFO - building 'psutil._psutil_posix' extension 16:47:48 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 16:47:49 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 16:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:49 INFO - Successfully installed psutil 16:47:49 INFO - Cleaning up... 16:47:49 INFO - Return code: 0 16:47:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:47:49 INFO - Using env: {'DISPLAY': ':0', 16:47:49 INFO - 'HOME': '/home/cltbld', 16:47:49 INFO - 'LANG': 'en_US.UTF-8', 16:47:49 INFO - 'LANGUAGE': 'en_US:en', 16:47:49 INFO - 'LOGNAME': 'cltbld', 16:47:49 INFO - 'MAIL': '/var/mail/cltbld', 16:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:49 INFO - 'MOZ_NO_REMOTE': '1', 16:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:49 INFO - 'NO_EM_RESTART': '1', 16:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:49 INFO - 'PWD': '/builds/slave/test', 16:47:49 INFO - 'SHELL': '/bin/bash', 16:47:49 INFO - 'SHLVL': '1', 16:47:49 INFO - 'TERM': 'linux', 16:47:49 INFO - 'TMOUT': '86400', 16:47:49 INFO - 'USER': 'cltbld', 16:47:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:49 INFO - '_': '/tools/buildbot/bin/python'} 16:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:51 INFO - Installing collected packages: mozsystemmonitor 16:47:51 INFO - Running setup.py install for mozsystemmonitor 16:47:51 INFO - Successfully installed mozsystemmonitor 16:47:51 INFO - Cleaning up... 16:47:51 INFO - Return code: 0 16:47:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:47:51 INFO - Using env: {'DISPLAY': ':0', 16:47:51 INFO - 'HOME': '/home/cltbld', 16:47:51 INFO - 'LANG': 'en_US.UTF-8', 16:47:51 INFO - 'LANGUAGE': 'en_US:en', 16:47:51 INFO - 'LOGNAME': 'cltbld', 16:47:51 INFO - 'MAIL': '/var/mail/cltbld', 16:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:51 INFO - 'MOZ_NO_REMOTE': '1', 16:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:51 INFO - 'NO_EM_RESTART': '1', 16:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:51 INFO - 'PWD': '/builds/slave/test', 16:47:51 INFO - 'SHELL': '/bin/bash', 16:47:51 INFO - 'SHLVL': '1', 16:47:51 INFO - 'TERM': 'linux', 16:47:51 INFO - 'TMOUT': '86400', 16:47:51 INFO - 'USER': 'cltbld', 16:47:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:51 INFO - '_': '/tools/buildbot/bin/python'} 16:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:51 INFO - Downloading/unpacking jsonschema==2.5.1 16:47:51 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 16:47:51 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 16:47:51 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 16:47:51 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 16:47:51 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 16:47:51 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 16:47:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47:53 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 16:47:53 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 16:47:53 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 16:47:53 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 16:47:53 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 16:47:53 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 16:47:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:54 INFO - warning: no files found matching '*.txt' 16:47:54 INFO - no previously-included directories found matching 'build' 16:47:54 INFO - no previously-included directories found matching 'dist' 16:47:54 INFO - no previously-included directories found matching '.git*' 16:47:54 INFO - Installing collected packages: jsonschema, functools32 16:47:54 INFO - Running setup.py install for functools32 16:47:54 INFO - warning: no files found matching '*.txt' 16:47:54 INFO - no previously-included directories found matching 'build' 16:47:54 INFO - no previously-included directories found matching 'dist' 16:47:54 INFO - no previously-included directories found matching '.git*' 16:47:54 INFO - Successfully installed jsonschema functools32 16:47:54 INFO - Cleaning up... 16:47:54 INFO - Return code: 0 16:47:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:47:54 INFO - Using env: {'DISPLAY': ':0', 16:47:54 INFO - 'HOME': '/home/cltbld', 16:47:54 INFO - 'LANG': 'en_US.UTF-8', 16:47:54 INFO - 'LANGUAGE': 'en_US:en', 16:47:54 INFO - 'LOGNAME': 'cltbld', 16:47:54 INFO - 'MAIL': '/var/mail/cltbld', 16:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:54 INFO - 'MOZ_NO_REMOTE': '1', 16:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:54 INFO - 'NO_EM_RESTART': '1', 16:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:54 INFO - 'PWD': '/builds/slave/test', 16:47:54 INFO - 'SHELL': '/bin/bash', 16:47:54 INFO - 'SHLVL': '1', 16:47:54 INFO - 'TERM': 'linux', 16:47:54 INFO - 'TMOUT': '86400', 16:47:54 INFO - 'USER': 'cltbld', 16:47:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:54 INFO - '_': '/tools/buildbot/bin/python'} 16:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:54 INFO - Cleaning up... 16:47:54 INFO - Return code: 0 16:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:47:54 INFO - Using env: {'DISPLAY': ':0', 16:47:54 INFO - 'HOME': '/home/cltbld', 16:47:54 INFO - 'LANG': 'en_US.UTF-8', 16:47:54 INFO - 'LANGUAGE': 'en_US:en', 16:47:54 INFO - 'LOGNAME': 'cltbld', 16:47:54 INFO - 'MAIL': '/var/mail/cltbld', 16:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:54 INFO - 'MOZ_NO_REMOTE': '1', 16:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:54 INFO - 'NO_EM_RESTART': '1', 16:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:54 INFO - 'PWD': '/builds/slave/test', 16:47:54 INFO - 'SHELL': '/bin/bash', 16:47:54 INFO - 'SHLVL': '1', 16:47:54 INFO - 'TERM': 'linux', 16:47:54 INFO - 'TMOUT': '86400', 16:47:54 INFO - 'USER': 'cltbld', 16:47:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:54 INFO - '_': '/tools/buildbot/bin/python'} 16:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:57 INFO - Downloading docopt-0.6.1.tar.gz 16:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:57 INFO - Running setup.py install for blobuploader 16:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:57 INFO - Running setup.py install for requests 16:47:58 INFO - Running setup.py install for docopt 16:47:58 INFO - Successfully installed blobuploader requests docopt 16:47:58 INFO - Cleaning up... 16:47:58 INFO - Return code: 0 16:47:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:58 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:47:58 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 16:47:58 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 16:47:58 INFO - Using env: {'DISPLAY': ':0', 16:47:58 INFO - 'HOME': '/home/cltbld', 16:47:58 INFO - 'LANG': 'en_US.UTF-8', 16:47:58 INFO - 'LANGUAGE': 'en_US:en', 16:47:58 INFO - 'LOGNAME': 'cltbld', 16:47:58 INFO - 'MAIL': '/var/mail/cltbld', 16:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:58 INFO - 'MOZ_NO_REMOTE': '1', 16:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:58 INFO - 'NO_EM_RESTART': '1', 16:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:58 INFO - 'PWD': '/builds/slave/test', 16:47:58 INFO - 'SHELL': '/bin/bash', 16:47:58 INFO - 'SHLVL': '1', 16:47:58 INFO - 'TERM': 'linux', 16:47:58 INFO - 'TMOUT': '86400', 16:47:58 INFO - 'USER': 'cltbld', 16:47:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:58 INFO - '_': '/tools/buildbot/bin/python'} 16:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:58 INFO - Running setup.py (path:/tmp/pip-QWH3Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:58 INFO - Running setup.py (path:/tmp/pip-q0Xlq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:58 INFO - Running setup.py (path:/tmp/pip-RDGCNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:58 INFO - Running setup.py (path:/tmp/pip-e6x2EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:58 INFO - Running setup.py (path:/tmp/pip-yqkSdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:58 INFO - Running setup.py (path:/tmp/pip-5deBEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:58 INFO - Running setup.py (path:/tmp/pip-9wM9UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:58 INFO - Running setup.py (path:/tmp/pip-Ahspvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:59 INFO - Running setup.py (path:/tmp/pip-7UnIjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:59 INFO - Running setup.py (path:/tmp/pip-H1fu9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:59 INFO - Running setup.py (path:/tmp/pip-e8y54D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:59 INFO - Running setup.py (path:/tmp/pip-hVjUIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:59 INFO - Running setup.py (path:/tmp/pip-zPIIXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:59 INFO - Running setup.py (path:/tmp/pip-8Epgw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:59 INFO - Running setup.py (path:/tmp/pip-DdRnZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:59 INFO - Running setup.py (path:/tmp/pip-KyMbmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:59 INFO - Running setup.py (path:/tmp/pip-hWpHii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:59 INFO - Running setup.py install for manifestparser 16:47:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:59 INFO - Running setup.py install for mozcrash 16:47:59 INFO - Running setup.py install for mozdebug 16:47:59 INFO - Running setup.py install for mozdevice 16:48:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for mozfile 16:48:00 INFO - Running setup.py install for mozhttpd 16:48:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for mozinfo 16:48:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for mozInstall 16:48:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for mozleak 16:48:00 INFO - Running setup.py install for mozlog 16:48:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for moznetwork 16:48:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:48:00 INFO - Running setup.py install for mozprocess 16:48:00 INFO - Running setup.py install for mozprofile 16:48:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:48:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:48:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:48:01 INFO - Running setup.py install for mozrunner 16:48:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:48:01 INFO - Running setup.py install for mozscreenshot 16:48:01 INFO - Running setup.py install for moztest 16:48:01 INFO - Running setup.py install for mozversion 16:48:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:48:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:48:01 INFO - Cleaning up... 16:48:01 INFO - Return code: 0 16:48:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:01 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:48:01 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 16:48:01 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 16:48:01 INFO - Using env: {'DISPLAY': ':0', 16:48:01 INFO - 'HOME': '/home/cltbld', 16:48:01 INFO - 'LANG': 'en_US.UTF-8', 16:48:01 INFO - 'LANGUAGE': 'en_US:en', 16:48:01 INFO - 'LOGNAME': 'cltbld', 16:48:01 INFO - 'MAIL': '/var/mail/cltbld', 16:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:01 INFO - 'MOZ_NO_REMOTE': '1', 16:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:01 INFO - 'NO_EM_RESTART': '1', 16:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:01 INFO - 'PWD': '/builds/slave/test', 16:48:01 INFO - 'SHELL': '/bin/bash', 16:48:01 INFO - 'SHLVL': '1', 16:48:01 INFO - 'TERM': 'linux', 16:48:01 INFO - 'TMOUT': '86400', 16:48:01 INFO - 'USER': 'cltbld', 16:48:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:01 INFO - '_': '/tools/buildbot/bin/python'} 16:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:01 INFO - Running setup.py (path:/tmp/pip-Psyolc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:01 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)) 16:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:01 INFO - Running setup.py (path:/tmp/pip-NsVjQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:01 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)) 16:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:01 INFO - Running setup.py (path:/tmp/pip-Bg48Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:01 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)) 16:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:01 INFO - Running setup.py (path:/tmp/pip-PUlyoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:01 INFO - Running setup.py (path:/tmp/pip-OHVpFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:02 INFO - Running setup.py (path:/tmp/pip-ZrNq56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:02 INFO - Running setup.py (path:/tmp/pip-DTpveG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:02 INFO - Running setup.py (path:/tmp/pip-KJGMo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:02 INFO - Running setup.py (path:/tmp/pip-nNGiN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:02 INFO - Running setup.py (path:/tmp/pip-4gMMzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:02 INFO - Running setup.py (path:/tmp/pip-xnozWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:02 INFO - Running setup.py (path:/tmp/pip-rSEnv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:02 INFO - Running setup.py (path:/tmp/pip-zXVcGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:02 INFO - Running setup.py (path:/tmp/pip-aIvLXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:02 INFO - Running setup.py (path:/tmp/pip-ef3jlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:02 INFO - Running setup.py (path:/tmp/pip-PazQOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:02 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)) 16:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:02 INFO - Running setup.py (path:/tmp/pip-Y2wK33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 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)) 16:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:02 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 16:48:04 INFO - Downloading blessings-1.6.tar.gz 16:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:48:05 INFO - Installing collected packages: blessings 16:48:05 INFO - Running setup.py install for blessings 16:48:05 INFO - Successfully installed blessings 16:48:05 INFO - Cleaning up... 16:48:05 INFO - Return code: 0 16:48:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:05 INFO - Reading from file tmpfile_stdout 16:48:05 INFO - Current package versions: 16:48:05 INFO - argparse == 1.2.1 16:48:05 INFO - blessings == 1.6 16:48:05 INFO - blobuploader == 1.2.4 16:48:05 INFO - docopt == 0.6.1 16:48:05 INFO - functools32 == 3.2.3-2 16:48:05 INFO - jsonschema == 2.5.1 16:48:05 INFO - manifestparser == 1.1 16:48:05 INFO - mozInstall == 1.12 16:48:05 INFO - mozcrash == 1.0 16:48:05 INFO - mozdebug == 0.1 16:48:05 INFO - mozdevice == 0.49 16:48:05 INFO - mozfile == 1.2 16:48:05 INFO - mozhttpd == 0.7 16:48:05 INFO - mozinfo == 0.9 16:48:05 INFO - mozleak == 0.1 16:48:05 INFO - mozlog == 3.4 16:48:05 INFO - moznetwork == 0.27 16:48:05 INFO - mozprocess == 0.25 16:48:05 INFO - mozprofile == 0.28 16:48:05 INFO - mozrunner == 6.13 16:48:05 INFO - mozscreenshot == 0.1 16:48:05 INFO - mozsystemmonitor == 0.3 16:48:05 INFO - moztest == 0.8 16:48:05 INFO - mozversion == 1.4 16:48:05 INFO - psutil == 3.1.1 16:48:05 INFO - requests == 1.2.3 16:48:05 INFO - wsgiref == 0.1.2 16:48:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:05 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')]} 16:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:05 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')]} 16:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:05 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:48:05 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 16:48:05 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 16:48:05 INFO - Using env: {'DISPLAY': ':0', 16:48:05 INFO - 'HOME': '/home/cltbld', 16:48:05 INFO - 'LANG': 'en_US.UTF-8', 16:48:05 INFO - 'LANGUAGE': 'en_US:en', 16:48:05 INFO - 'LOGNAME': 'cltbld', 16:48:05 INFO - 'MAIL': '/var/mail/cltbld', 16:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:05 INFO - 'MOZ_NO_REMOTE': '1', 16:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:05 INFO - 'NO_EM_RESTART': '1', 16:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:05 INFO - 'PWD': '/builds/slave/test', 16:48:05 INFO - 'SHELL': '/bin/bash', 16:48:05 INFO - 'SHLVL': '1', 16:48:05 INFO - 'TERM': 'linux', 16:48:05 INFO - 'TMOUT': '86400', 16:48:05 INFO - 'USER': 'cltbld', 16:48:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:05 INFO - '_': '/tools/buildbot/bin/python'} 16:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 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)) 16:48:05 INFO - Cleaning up... 16:48:05 INFO - Return code: 0 16:48:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:48:05 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')]} 16:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:05 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')]} 16:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:05 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 0x10551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, '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': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', '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 16:48:05 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 16:48:05 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 16:48:05 INFO - Using env: {'DISPLAY': ':0', 16:48:05 INFO - 'HOME': '/home/cltbld', 16:48:05 INFO - 'LANG': 'en_US.UTF-8', 16:48:05 INFO - 'LANGUAGE': 'en_US:en', 16:48:05 INFO - 'LOGNAME': 'cltbld', 16:48:05 INFO - 'MAIL': '/var/mail/cltbld', 16:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:05 INFO - 'MOZ_NO_REMOTE': '1', 16:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:05 INFO - 'NO_EM_RESTART': '1', 16:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:05 INFO - 'PWD': '/builds/slave/test', 16:48:05 INFO - 'SHELL': '/bin/bash', 16:48:05 INFO - 'SHLVL': '1', 16:48:05 INFO - 'TERM': 'linux', 16:48:05 INFO - 'TMOUT': '86400', 16:48:05 INFO - 'USER': 'cltbld', 16:48:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:05 INFO - '_': '/tools/buildbot/bin/python'} 16:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:48:05 INFO - Cleaning up... 16:48:05 INFO - Return code: 0 16:48:05 INFO - Running post-action listener: _resource_record_post_action 16:48:05 INFO - Running post-action listener: _start_resource_monitoring 16:48:05 INFO - Starting resource monitoring. 16:48:05 INFO - [mozharness: 2017-03-23 23:48:05.975015Z] Finished create-virtualenv step (success) 16:48:05 INFO - [mozharness: 2017-03-23 23:48:05.975468Z] Running install step. 16:48:05 INFO - Running pre-action listener: _resource_record_pre_action 16:48:05 INFO - Running main action method: install 16:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:06 INFO - Reading from file tmpfile_stdout 16:48:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:48:06 INFO - Reading from file tmpfile_stdout 16:48:06 INFO - Output received: 16:48:06 INFO - Usage: mozinstall [options] installer 16:48:06 INFO - Options: 16:48:06 INFO - -h, --help show this help message and exit 16:48:06 INFO - -d DEST, --destination=DEST 16:48:06 INFO - Directory to install application into. [default: 16:48:06 INFO - "/builds/slave/test"] 16:48:06 INFO - --app=APP Application being installed. [default: firefox] 16:48:06 INFO - mkdir: /builds/slave/test/build/application 16:48:06 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'] 16:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:48:21 INFO - Reading from file tmpfile_stdout 16:48:21 INFO - Output received: 16:48:21 INFO - /builds/slave/test/build/application/firefox/firefox 16:48:21 INFO - Running post-action listener: _resource_record_post_action 16:48:21 INFO - [mozharness: 2017-03-23 23:48:21.899379Z] Finished install step (success) 16:48:21 INFO - [mozharness: 2017-03-23 23:48:21.899654Z] Running run-tests step. 16:48:21 INFO - Running pre-action listener: _resource_record_pre_action 16:48:21 INFO - Running main action method: run_tests 16:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:48:21 INFO - Python 2.7.3 16:48:21 INFO - Return code: 0 16:48:21 INFO - grabbing minidump binary from tooltool 16:48:21 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')]} 16:48:21 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 0x12f0290>, '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 0x12f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f1040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:48:21 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 16:48:21 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 16:48:21 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 16:48:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:22 INFO - Return code: 0 16:48:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:48:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:48:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:48:22 INFO - ENV: RUST_BACKTRACE is now 1 16:48:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:48:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 16:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 16:48:22 INFO - Using env: {'DISPLAY': ':0', 16:48:22 INFO - 'HOME': '/home/cltbld', 16:48:22 INFO - 'LANG': 'en_US.UTF-8', 16:48:22 INFO - 'LANGUAGE': 'en_US:en', 16:48:22 INFO - 'LOGNAME': 'cltbld', 16:48:22 INFO - 'MAIL': '/var/mail/cltbld', 16:48:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:48:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:22 INFO - 'MOZ_NO_REMOTE': '1', 16:48:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:22 INFO - 'NO_EM_RESTART': '1', 16:48:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:22 INFO - 'PWD': '/builds/slave/test', 16:48:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:48:22 INFO - 'RUST_BACKTRACE': '1', 16:48:22 INFO - 'SHELL': '/bin/bash', 16:48:22 INFO - 'SHLVL': '1', 16:48:22 INFO - 'TERM': 'linux', 16:48:22 INFO - 'TMOUT': '86400', 16:48:22 INFO - 'USER': 'cltbld', 16:48:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966', 16:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:22 INFO - '_': '/tools/buildbot/bin/python'} 16:48:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 16:48:22 INFO - mozversion application_buildid: 20170323231546 16:48:22 INFO - mozversion application_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 16:48:22 INFO - mozversion application_display_name: Nightly 16:48:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:22 INFO - mozversion application_name: Firefox 16:48:22 INFO - mozversion application_remotingname: firefox 16:48:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:48:22 INFO - mozversion application_vendor: Mozilla 16:48:22 INFO - mozversion application_version: 55.0a1 16:48:22 INFO - mozversion platform_buildid: 20170323231546 16:48:22 INFO - mozversion platform_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 16:48:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:48:22 INFO - mozversion platform_version: 55.0a1 16:48:22 INFO - using testdate: 1490312902 16:48:22 INFO - actual date: 1490312902 16:48:22 INFO - starting webserver on 'localhost:43198' 16:48:22 INFO - SUITE-START | Running 2 tests 16:48:22 INFO - TEST-START | dromaeo_css 16:48:22 INFO - operating with platform_type : linux_ 16:48:22 INFO - Initialising browser for dromaeo_css test... 16:48:22 INFO - TEST-INFO | started process 3293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1kKjaO/profile http://localhost:43198/getInfo.html) 16:48:27 INFO - PID 3293 | __metrics Screen width/height:1600/1200 16:48:27 INFO - PID 3293 | colorDepth:24 16:48:27 INFO - PID 3293 | Browser inner width/height: 1024/697 16:48:27 INFO - PID 3293 | __metrics 16:48:28 INFO - PID 3293 | 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" 16:48:28 INFO - PID 3293 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:29 INFO - TEST-INFO | 3293: exit 0 16:48:29 INFO - Browser initialized. 16:48:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:29 INFO - TEST-INFO | started process 3386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1kKjaO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:41 INFO - PID 3386 | RSS: Main: 149450752 16:48:41 INFO - PID 3386 | 16:51:48 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43198/tests/dromaeo/cssquery-ext.html) 16:51:49 INFO - PID 3386 | RSS: Main: 255668224 16:51:49 INFO - PID 3386 | 16:53:31 INFO - PID 3386 | ************************* 16:53:31 INFO - PID 3386 | A coding exception was thrown and uncaught in a Task. 16:53:31 INFO - PID 3386 | 16:53:31 ERROR - PID 3386 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:53:31 INFO - PID 3386 | Full stack: 16:53:31 INFO - PID 3386 | ************************* 16:54:52 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-ext.html (next: http://localhost:43198/tests/dromaeo/cssquery-jquery.html) 16:54:52 INFO - PID 3386 | RSS: Main: 233439232 16:54:52 INFO - PID 3386 | 16:57:54 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43198/tests/dromaeo/cssquery-mootools.html) 16:57:55 INFO - PID 3386 | RSS: Main: 184152064 16:57:55 INFO - PID 3386 | 17:00:57 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43198/tests/dromaeo/cssquery-prototype.html) 17:00:58 INFO - PID 3386 | RSS: Main: 178176000 17:00:58 INFO - PID 3386 | 17:04:01 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43198/tests/dromaeo/cssquery-yui.html) 17:04:02 INFO - PID 3386 | RSS: Main: 187445248 17:04:02 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | Cycle 1(1): loaded http://localhost:43198/tests/dromaeo/cssquery-yui.html (next: http://localhost:43198/tests/dromaeo/cssquery-dojo.html) 17:07:05 INFO - PID 3386 | RSS: Main: 272465920 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | __start_tp_report 17:07:05 INFO - PID 3386 | _x_x_mozilla_page_load 17:07:05 INFO - PID 3386 | _x_x_mozilla_page_load_details 17:07:05 INFO - PID 3386 | |i|pagename|runs| 17:07:05 INFO - PID 3386 | |0;dojo.html;2673.0876605248463;2699.9865000674995;2715.3483164040636;2719.836809791412;2725.4004119093793;4982.676126051813;5070.13807652699;5081.644284900059;5115.976804639073;5180.300659410983;5025.597952163827;5070.416902056265;5074.061298659742;5075.213341931997;5078.365204349457;4612.3542704021465;4657.953420465803;4671.275952227394;4727.976360118195;4732.408448943882;4687.859364219079;4708.693934894238;4735.73953432561;4743.573078422941;4783.425988881322;4732.45576758672;4772.403449568804;4793.185158523042;4793.880152996186;4799;4762.499937506546;4764.928526072112;4764.952350476486;4765.761711914391;4793.808247670089;4688.109259240733;4725.574698277172;4736.550027747358;4741.8103275868925;4780.067886762083;4881;4976.402831660224;5013.824516141954;5132.3327967364;5161.1742121260795;5308.362996440414;5317.361916569997;5362.2224777407055;5476.835694929158;5479.506844384025;5541.0580201365865;5547.972260138714;5558.471945165203;5560.527355174815;5565.276514053187;5013.498650134958;5173.76718047685;5182.792688292426;5182.974085129626;5234.685918844843;5542.778288868481;5556.166575013699;5598.468145526169;5628.971855140698;5640.576956728261;5362.65142765719;5378.757955891994;5381.892362152735;5387.057264978613;5415.079436495806;5443.673379597237;5457.154141108134;5464.508194262536;5466.699331536804;5520.779168833282;5303.708296043677;5361.571074314045;5367.919481207785;5405.918911216335;5427.3758517770175;5395.379531353945;5443.237946687467;5476.205950137208;5493.121100623881;5503.559715222853;4554.817807287738;4568.862934111982;4577.5880170784785;4578.061497393093;4600.263957766808;3882.6699730523223;3899.922001559953;3902.2195560887367;3957.56466788653;3959.6238357356006;4629.930551041737;4634.513376095461;4660.790264438108;4670.719756814534;4680.227762419231;5493.917591236134;5498.972505137449;5499.1476321170285;5505.862353441116;5546.805861794818;4561.270196768501;4694.7417892016265;4695.718256904596;4696.647751418657;4702.247640377524;4779.904401911942;4795.856124316276;4806.831760888422;4820.9517904821205;4852.126617208795;5138.177891537336;5148.227765835155;5152.072626927189;5167.069927413102;5201.765920533509;5453.863653408696;5487.039768040657;5500.724963751876;5517.200005999188;5521.668699878021;4982.67612605194;4984.800607975785;5037.722925239147;5129.461406552258;5146.25379319989;5306.469353064663;5316.441773613869;5318.388385335736;5319.414864364994;5320.042392369411;5371.140617501181;5385.784568617211;5422.186671999074;5424.83725488236;5467.890642187213;5380.058489764354;5390.757415916371;5391.29913111293;5392.325959255093;5423.267858839006;5307.920381194363;5369.838904832861;5371.033214021513;5374.167004114369;5419.620626556103;5112.437631860566;5162.380514338303;5264.578833693372;5279.10255256615;5295.602829787858;5413.458654134555;5413.918791218056;5417.8103766367985;5455.263539422286;5465.808696695596;5262.210668399771;5265.052290587731;5266.183741520071;5266.73666316675;5277.366715994105 17:07:05 INFO - PID 3386 | |1;ext.html;629.9496040316773;675.719576375804;693.4972145194732;1075.9623413180536;1093.7703082352705;26799.86600067002;32283.192920177007;32629;32722.67277327226;32847;33715.49426758601;34078.65921340786;34132.317353652914;37752.81123594385;37808;5681.545476361881;7497.2502749725;7682.5006374585755;7700.11448683403;7702.8844567331535;5549.112142057252;7087.078679771623;7093.219745827955;7107.182673992479;7228.963855180717;7188.856222875539;7481.6633251503545;7608.429367797409;7617.657205425741;7618.276263754934;5653.519450846683;7511.624418779066;7589.165191828894;7591.848163036763;7600.277973592528;5724.084146536576;7176.784696459063;7252.528585641917;7262.745803896838;7263;31617.84191079053;31951.84024079888;31971;31973;32029.679703202903;2626.0808716948914;2633.0652618320605;2643.572930842509;2643.722409147031;2646.2193652872447;23975.160869369487;24137.879310603512;24246.39384015396;24346.904389302523;25050.123245686496;2651.191386627078;2655.907043253477;2682.383051898055;2688.946221075587;2708.9864550677316;148345;150286.24856875645;150411;150533;151007.24496377556;43757.34363984543;43877.56122438799;43955.34066988998;43967.340489892675;43974.340384894254;46777.76611116923;46813;46836.7658161707;46865.07916668769;46947.29579056317;11633.360165190996;11789.941050294694;11791.88208117925;11802.704932376588;11804.40977951099;7932.246436588515;7999.520028798291;9203;9208.355415121012;9223.677171298972;10888.237823352447;11005.779884402267;11010.944945275221;11943.701407464709;12158.817617735742;4791.061365364792;5136.43499215086;5179.559737422286;5242.449542798027;5314.893702125936;871.6121326009865;896.5472436419566;900.5407242306471;901.3150005995491;915.1214833759665;20754.792452075588;21594.56810863774;21636.134554617638;21747.347579572637;21778.167960254494;959.6928982725461;961.990380096204;972.8374592362201;975.7950830325711;988.2280204027771;10854.185936054828;11068.28056176346;11224.326540407601;11299.49152288149;11371.54513819438;217246;217842;219618;219874;220343;42465;42501.78749106234;42549.36175957363;42564.1487170261;42599.36100958488;1148.5396796531486;1212.6543934978488;1224.12475080318;1228.3305598448867;1236.0297166724079;19275.650704451116;19871.701924471432;20359.694604580647;20447.4888127798;20758;30147.397052059274;30523.694763052084;30536.236594085327;30542;30589.23526911845;222829;222944;222969;223292;223577;28590.714092858805;29584.260393490335;29614.703852961196;29673;29690.55464167996;26766.464670706868;30275.545866812456;31800.204994874388;32334.83832580822;36418.27163456769;24173.274801755975;24358;24760.380990474663;24965.87517062403;25340;24445.633315500636;24752.50494990126;25052.373690657878;25071.623925641496;27024.97312701516;29014.854925725238;29209.707902920698;29390.179276693892;29417.411651767274;29471.55792663069;25761.484770304865;25769.474635420167;25984.220473385827;26045.6093158599;26066.86966565231;19569.315073972342;21246.362609121752;21281.7871821286;21291.467713306673;22922.656160157945 17:07:05 INFO - PID 3386 | |2;jquery.html;408.2875382457612;418.3703526193083;424.9277622804123;438.69729886378394;438.7871882137164;15376.308066137022;17474.82525174748;17985.550361240974;18203.453896383096;18205.544861378454;17510.299588016496;17629.20668569914;17699.380521681745;17709.7343539847;17825.108744562785;5213.504717051884;5429.239906413105;5616.971915140419;5685.545156387499;5689.260396148495;5587.804426845061;5665.518430933375;5677.886442271152;5686.431356864301;5687.687177205252;5452.972735136319;5615.494605485505;5620.353659329188;5647.802326918559;5663.348714897798;5639.436056394348;5669.6314739541795;5675.829725108253;5677.687727175004;5680.886382272352;5023.246513023039;5056.74716264189;5087.338645976037;5094.541491265767;5096.51583099605;20840.166393344247;21102.788972110237;23457.178998734962;23506;23574.88212558926;1632.9183540822912;1659.9253033613516;1670.9331626734916;1685.494351694499;1688.8564472019893;14968.625784355369;15086.773698394532;15516.61208469786;15635.140067296294;15826.683466330724;1794.4078454110113;1820.599468117012;1876.6340563590106;1879.0510792049927;1880.2666959885655;79603.60198198972;87681.56159219163;88429.55785221097;89316;91628.08371916262;17580.38468653591;17688;17691.557711057325;17835.46493605194;17860.285588576313;32912;32927;33038.66961330356;33066.834665826515;33367.33265334728;7975.800604984922;8073.959630201812;8155.347572194329;8184.754457366289;8347.248747612744;6274.874502510015;6334.3665633436285;6360.9045864312075;6518.054882042077;6534.346565343428;9380.484073375894;9397.483138427315;9532.142107210384;9630.3516532954;9694.90305096954;3539.628339024417;3734.8506059757847;3746.587875333711;3967.532013155151;4098.262312783728;822.3585603229491;837.3803385494812;862.1464749897556;864.8400045991511;870.1559487297311;16169;16254.106024168785;16346.67306653884;16463.91768041152;16982.320707171573;842.5366048673205;858.553552152877;860.3289434241177;863.2705363967438;867.4231635962141;8499.490030598185;9072.183503484717;9428.858567121499;9448.95275523618;9557.90442095584;448362.3073192423;448397;449413;449577;449593;86922;87078.56460717655;87471.56264218639;87885.56057219801;88078.55960720155;1033.2405681823852;1048.5962904281753;1076.252004856617;1079.6005477973201;1080.135891286983;14035.105260789664;14292.785608216092;14380.928095359457;14496.782548261996;15034.699306014038;42267.1546569073;42431.575684242765;42510.57489425066;42654.78672606617;44259.33610995773;52320.215196771314;52502;52740;52839.47160528499;53531;11089.94455027752;11118.826967751476;11279.379634120201;11453.828192577284;11652.592159274385;12521.436535355748;12738.108332416641;12790.808137877753;12853.35733213317;13339.66650833737;10976.396298203676;11095;11111.833322500008;11117.27737697047;11219.102471802073;10325;10510.842337364793;10516.947415262875;10539.262251642618;10797.082248009006;10974.176936729618;11082.33505989611;11083.445827708743;11130;11354.772904542027;10803.297785643908;11246.212765106364;11311.886881131084;11342.546298148312;11374.772504550028;10591.311564748266;10629.04338609498;11102.389368584805;11133.721656958642;11243.044341231087 17:07:05 INFO - PID 3386 | |3;mootools.html;1148.8563929508812;1259.3766085787536;1332.873377029182;1346.5354452713816;1352.3238380809596;8218.137095604958;9575.377600455975;9847.803043939126;9867.506624668773;9879.456629885372;9567.138957493842;9648.758781030478;9661.420314781119;9662.565184566694;9686.806263874718;1887.6696578098847;2247.786460286274;2284.7486776454575;2286.862788232703;2288.965665515019;1926.3257859749117;2206.6248737714627;2290.3815969688258;2292.1633603734685;2301.355620426283;2213.6015517206897;2251.043306594699;2255.436140964759;2259.559385919746;2260.6156953317895;2202.702635144251;2204.9889750551306;2206.305013920618;2206.5917805206086;2207.2164381644448;1922.7500424944808;1937.2638397409034;1949.0449679657008;2140.56118495708;2140.636091864387;9885.060919212663;9921.851172232422;9989.400635961792;10015.09864112226;10018.849717254247;5212.817551385721;5393.892122157535;5395.433479484637;5404;5412.5940554458175;3235.919102022445;3394.7114495267933;3394.8981530554124;3397.8810741623925;3402.795832250073;1068.7167900506372;1129.6893354327626;1145.4959817680194;1148.8161894096904;1174.4714878304712;15011.549653510412;15022.549323520203;15043.022203556844;15055.774163387558;15085.472008479761;4759.833405830779;5038.34501514808;5055.292259083732;5060.367454068241;5072.492750724898;10713.250072495006;10830.620928267474;10839.67480975572;11108.61119860801;11114.277571957797;5498.285222920995;5501.669899806025;5504.587155963319;5526.861828454321;5533.778648854081;4239.236937351307;4361.542038086019;4922.581580565692;4997.225430058346;5042.09242336383;3394.372041172391;3481.3211423772123;3494.266204097168;3506.4564992425703;3775.981120094437;1111.827666711661;1120.78705046041;1121.5401685308984;1147.1568397228032;1156.8843115688533;687.669918439152;700.1458220970408;713.0658836923647;723.106962900817;740.6666999850089;5699.629524081004;5945.851353716192;5965.313988891333;6083.330833608299;6197.287311959092;803.5941849366033;810.339573247813;810.720301495983;820.3806126374549;826.5784449930578;3240.6273278573267;3324.2188085799817;3345.9330813383594;3594.281143771256;3794.658480736747;12411.875881241072;12911.289879056741;13228.007899407583;13251.93374033143;13266.73466530664;12958.870411295955;13238.338083095807;13240.470381184838;13247.271400072896;13265.535706250428;9343.252539796937;9536.427814331162;9544.09331113557;9544.475053871965;9549.713508594754;5728.283964504437;5742.397048309867;5744.368119506935;5810.448007439287;5889.322727886348;11563.364014979257;11770.234934729215;11785.175037747274;11968.640940771791;11980.940095299467;12237.143399961917;12260.26438413698;12319.876801231872;12336.62990110298;12467.750644986869;7603.0876294844975;7645.120811106572;7662.118856331594;7735.955645987945;7741.496802707806;7880.881786773318;8105.635246413807;8671.696490622799;8940.552972351486;9018;7625.809354766176;7626.122995855548;7636.427267954815;7732.536047837148;7823.452358334862;7501.512401693873;7531.133919599097;7589.975353327451;7603.581803000667;7642.350400216044;6866.862662746617;6984.860302794017;7031.753888613874;7032.578045317297;7034.718611255493;4987.226979818134;5105.030044291572;5118.155504341891;5136.614753893398;5138.407093800934;5040.798368065236;5197;5269.446708095595;5270.762815673227;5397.676139431646 17:07:05 INFO - PID 3386 | |4;prototype.html;392.14316717971235;395.63206218217056;398.5755170743158;409.3920528015894;409.4247582147083;5370.2750128732605;5452.345718513779;5486.807961721341;5499.532539734118;5564.610477266593;5200.917279935252;5239.13554263547;5348.625596208267;5361.169018802092;5421.918671219935;4364.847230346939;4371.125774845028;4371.235033869076;4372.934405983913;4379.934300985472;4359.738415695053;4361.454818147731;4369.257226271541;4382.693211475198;4390.331673963889;4259.829606815723;4322.589354011364;4331.740095594275;4342.174986752522;4353.564643535653;4324.610785029331;4336.284513055342;4336.91326173478;4338.6095251427205;4343.6959412841115;3886.591907849663;3907.628775266345;3916.549596796348;3920.1375697346825;3931.862384816546;5109.540141387256;5302.231176479428;5315.123004704219;5326.44072372403;5331.680099194022;5009.724465154415;5034.54689077981;5034.773435195425;5035.521625445577;5047.293378926953;5680.460356266148;5683.010946168849;5710.573006472233;5743.827685169452;5778.711064446761;4213.30480470722;4263.87208383749;4272.145570885836;4330.523642399334;4332.783360831977;5654.010548154057;5873.471387575096;5903.114532820068;5927.199828023205;5945.405459454063;4327.307630779123;4454.487733910577;4459.955400446019;4465;4468.396766436555;4504.144212599595;4532.5694059064335;4534.206513860061;4541.250693635579;4551.931721024187;4720.268358404453;4829.1790395632825;4848.369711937426;4982.2775697524385;4991.625628077909;5692.971535142297;5718.399568045378;5726.599138060295;5732.484076433141;5744.798932037359;1550.9612259693597;1565.4286185542423;1566.216891554223;1567.404386333209;1571.1123215383273;1086.462201210406;1113.7939481196004;1119.3563700871869;1120.641394753671;1127.689885281554;4912.975435122801;4917.729524876167;4931.495893752368;4936.6297527685565;4942.8764280893265;5830.82507524775;5837.795677151279;5862.677552734555;5875.383084776037;5882;4763.904721905543;4891.241857512091;4924.4583095859425;4937.802487900515;4960.553550180501;3040.3615240799236;3055.6486004109365;3070.8003979741693;3080.2299425143715;3081.92295192622;5294.841154765363;5468.972655136698;5470.179473078991;5473.917891231635;5500.119980803052;5953.851153721192;5978.372270911492;5979.222701048923;5984.521238301013;6007.10421006878;5468.91796623051;5488.313960754906;5500.477454641803;5504.779808807602;5529.253550770675;5665.886682266414;5846.795362162474;5869.7945571904775;5882.764689412375;5898.764049438146;5787.276590426197;5788.334341550775;5789.507891829242;5797.275340582427;5799.94200057994;5205.635605507729;5298.947010529845;5382.590496550942;5396.379416367168;5454.972725136349;4414.337849322627;4424.336349547593;4428.601425871687;4445.155420470101;4450.577195166454;5792.918774174253;5830.76676932918;5854;5877.735501902339;5896.6756828374855;5665.631733937281;5677.630953987978;5693.743781529924;5713.771449142154;5717.914231286451;5639.802606908738;5675.31896172462;5700.629459085146;5701.686407247641;5706.714664266853;5512.989523139216;5516.503514683698;5560.666360018412;5572.554195664418;5621.241132447068;5662.915056274077;5694.886102277848;5716.342620598518;5717.828465146053;5739.253896993364;5400.540954018952;5518.841043380935;5526.761661527088;5551.7779288828;5566 17:07:05 INFO - PID 3386 | |5;yui.html;678.5284227461916;697.7209116353458;698.3714656808872;712.113418793602;731.1137265854095;11794.941025294873;12382.752344953096;12697.428615712292;12809.679758006054;13028.934855325733;12420.19268747533;12511.311877846714;12631;12667.113302068836;12695.047871409635;832.0680837462036;835.8746188071807;861.7199410191681;867.9305655547572;868.8827008353886;860.8192279621287;869.0874581689233;872.371892237591;872.8079822439054;874.1040433555593;904.145582424609;905.4160066756938;906.8821053263066;907.2651152566409;907.3920473282883;890.4968692688642;891.4695756025154;892.3441270666056;892.9910700892973;893.2942975049735;670.7954074007425;670.9161354830646;671.8958561422987;673.0745225315192;673.4645956464623;13264.270465124415;13479.865201347959;13776;13848.792268115987;13856.722865542633;13409.46362145513;14325.283735813167;14345.569632911029;14396.784048239284;14406.495772648012;9045.185933266037;9195.356325057248;9223.44659320443;9307.534623268877;9510.191633711143;2415.456522282472;2426.235735743235;2465.753424657538;2477.1082410332265;2481.10680155144;64909;66777.3322266776;67970.3202967969;68689.31310686929;69405;10445.64972881111;10475.528601212964;10561.788764224673;10579.62971296001;10671.35971841692;19816.50458738514;19851.702224466644;19873.701894471593;19923.501912452015;20061.699074513603;5783.248177736868;5922.2597175353085;5945.047035170942;5981.222441082718;6087;2982.537706655472;3030.575719399286;3046.3907218555933;3136.98431507841;3149.0710240479116;3353.413152698268;3393.3043726036103;3397.11674964511;3420.8289585520624;3441.741869359808;580.3471095018105;583.5069366385397;586.6802592586965;593.1458699472831;598.019248432571;535.4351159526659;547.8520799384223;553.698234462219;558.9608727389044;559.0886854427339;7441.739539116214;7719.305262526287;8091;8166.877496837434;8309;513.2455290722631;532.1485623003164;542.9513282916396;548.1485146065733;549.3215878390185;3601.3877640801124;3680.5951345352523;3716;3846.769193848378;3880.1269714314053;60382.698086510165;60456.69771651202;60830.39169608336;61526.69236653877;61568.384316157164;54609.45390546123;55261.44738552644;55638.721806390706;55679.721601391735;55748.72125639427;47864.7606761964;48050.27924581064;48843.267350989765;49262;49398;8352.665893364197;8954.328425368254;9052;9112.134347237003;9180.862287065565;23454.296371108892;23701.644475332538;24249.63625545583;24471.87764061168;25173.87413062923;39752.40371394489;39866.60133398629;40503.98740031523;40953.1809363817;41646.37530437107;10513.316634418738;10790.298630589301;11023.17326200522;11111.11111111093;11230.94384528072;11875.465604047666;12102.515899363927;12124.878751212374;12282.38588070575;12308.323042232763;11347.489362978851;11397.715057123307;11622.94188529052;11839.644810655695;12031.518739250332;10642.574297028343;10904.945475272572;10917.508712108132;10975.725606859893;11342.829857551978;11094.667159985212;11474.598389056342;11479.713007174887;11598.884011160118;11615.941920290345;8981.595828187617;9417.764555886157;9443.905560944302;9459.574319155792;9518.714438566854;8501.404901657072;8956.28349732033;9253.58358873839;9335.813283734424;9386.530673466163 17:07:05 INFO - PID 3386 | __end_tp_report 17:07:05 INFO - PID 3386 | __start_cc_report 17:07:05 INFO - PID 3386 | _x_x_mozilla_cycle_collect,1180 17:07:05 INFO - PID 3386 | __end_cc_report 17:07:05 INFO - PID 3386 | __startTimestamp1490314025328__endTimestamp 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | ------- Summary: start ------- 17:07:05 INFO - PID 3386 | Number of tests: 6 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#0] dojo.html Cycles:165 Average:5037.73 Median:5180.30 stddev:557.74 (10.8%) stddev-sans-first:527.70 17:07:05 INFO - PID 3386 | Values: 2673.1 2700.0 2715.3 2719.8 2725.4 4982.7 5070.1 5081.6 5116.0 5180.3 5025.6 5070.4 5074.1 5075.2 5078.4 4612.4 4658.0 4671.3 4728.0 4732.4 4687.9 4708.7 4735.7 4743.6 4783.4 4732.5 4772.4 4793.2 4793.9 4799.0 4762.5 4764.9 4765.0 4765.8 4793.8 4688.1 4725.6 4736.6 4741.8 4780.1 4881.0 4976.4 5013.8 5132.3 5161.2 5308.4 5317.4 5362.2 5476.8 5479.5 5541.1 5548.0 5558.5 5560.5 5565.3 5013.5 5173.8 5182.8 5183.0 5234.7 5542.8 5556.2 5598.5 5629.0 5640.6 5362.7 5378.8 5381.9 5387.1 5415.1 5443.7 5457.2 5464.5 5466.7 5520.8 5303.7 5361.6 5367.9 5405.9 5427.4 5395.4 5443.2 5476.2 5493.1 5503.6 4554.8 4568.9 4577.6 4578.1 4600.3 3882.7 3899.9 3902.2 3957.6 3959.6 4629.9 4634.5 4660.8 4670.7 4680.2 5493.9 5499.0 5499.1 5505.9 5546.8 4561.3 4694.7 4695.7 4696.6 4702.2 4779.9 4795.9 4806.8 4821.0 4852.1 5138.2 5148.2 5152.1 5167.1 5201.8 5453.9 5487.0 5500.7 5517.2 5521.7 4982.7 4984.8 5037.7 5129.5 5146.3 5306.5 5316.4 5318.4 5319.4 5320.0 5371.1 5385.8 5422.2 5424.8 5467.9 5380.1 5390.8 5391.3 5392.3 5423.3 5307.9 5369.8 5371.0 5374.2 5419.6 5112.4 5162.4 5264.6 5279.1 5295.6 5413.5 5413.9 5417.8 5455.3 5465.8 5262.2 5265.1 5266.2 5266.7 5277.4 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#1] ext.html Cycles:180 Average:33371.26 Median:29599.48 stddev:52229.03 (176.5%) stddev-sans-first:52317.69 17:07:05 INFO - PID 3386 | Values: 629.9 675.7 693.5 1076.0 1093.8 26799.9 32283.2 32629.0 32722.7 32847.0 33715.5 34078.7 34132.3 37752.8 37808.0 5681.5 7497.3 7682.5 7700.1 7702.9 5549.1 7087.1 7093.2 7107.2 7229.0 7188.9 7481.7 7608.4 7617.7 7618.3 5653.5 7511.6 7589.2 7591.8 7600.3 5724.1 7176.8 7252.5 7262.7 7263.0 31617.8 31951.8 31971.0 31973.0 32029.7 2626.1 2633.1 2643.6 2643.7 2646.2 23975.2 24137.9 24246.4 24346.9 25050.1 2651.2 2655.9 2682.4 2688.9 2709.0 148345.0 150286.2 150411.0 150533.0 151007.2 43757.3 43877.6 43955.3 43967.3 43974.3 46777.8 46813.0 46836.8 46865.1 46947.3 11633.4 11789.9 11791.9 11802.7 11804.4 7932.2 7999.5 9203.0 9208.4 9223.7 10888.2 11005.8 11010.9 11943.7 12158.8 4791.1 5136.4 5179.6 5242.4 5314.9 871.6 896.5 900.5 901.3 915.1 20754.8 21594.6 21636.1 21747.3 21778.2 959.7 962.0 972.8 975.8 988.2 10854.2 11068.3 11224.3 11299.5 11371.5 217246.0 217842.0 219618.0 219874.0 220343.0 42465.0 42501.8 42549.4 42564.1 42599.4 1148.5 1212.7 1224.1 1228.3 1236.0 19275.7 19871.7 20359.7 20447.5 20758.0 30147.4 30523.7 30536.2 30542.0 30589.2 222829.0 222944.0 222969.0 223292.0 223577.0 28590.7 29584.3 29614.7 29673.0 29690.6 26766.5 30275.5 31800.2 32334.8 36418.3 24173.3 24358.0 24760.4 24965.9 25340.0 24445.6 24752.5 25052.4 25071.6 27025.0 29014.9 29209.7 29390.2 29417.4 29471.6 25761.5 25769.5 25984.2 26045.6 26066.9 19569.3 21246.4 21281.8 21291.5 22922.7 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#2] jquery.html Cycles:180 Average:28462.32 Median:3637.24 stddev:74185.23 (2039.6%) stddev-sans-first:74363.43 17:07:05 INFO - PID 3386 | Values: 408.3 418.4 424.9 438.7 438.8 15376.3 17474.8 17985.6 18203.5 18205.5 17510.3 17629.2 17699.4 17709.7 17825.1 5213.5 5429.2 5617.0 5685.5 5689.3 5587.8 5665.5 5677.9 5686.4 5687.7 5453.0 5615.5 5620.4 5647.8 5663.3 5639.4 5669.6 5675.8 5677.7 5680.9 5023.2 5056.7 5087.3 5094.5 5096.5 20840.2 21102.8 23457.2 23506.0 23574.9 1632.9 1659.9 1670.9 1685.5 1688.9 14968.6 15086.8 15516.6 15635.1 15826.7 1794.4 1820.6 1876.6 1879.1 1880.3 79603.6 87681.6 88429.6 89316.0 91628.1 17580.4 17688.0 17691.6 17835.5 17860.3 32912.0 32927.0 33038.7 33066.8 33367.3 7975.8 8074.0 8155.3 8184.8 8347.2 6274.9 6334.4 6360.9 6518.1 6534.3 9380.5 9397.5 9532.1 9630.4 9694.9 3539.6 3734.9 3746.6 3967.5 4098.3 822.4 837.4 862.1 864.8 870.2 16169.0 16254.1 16346.7 16463.9 16982.3 842.5 858.6 860.3 863.3 867.4 8499.5 9072.2 9428.9 9449.0 9557.9 448362.3 448397.0 449413.0 449577.0 449593.0 86922.0 87078.6 87471.6 87885.6 88078.6 1033.2 1048.6 1076.3 1079.6 1080.1 14035.1 14292.8 14380.9 14496.8 15034.7 42267.2 42431.6 42510.6 42654.8 44259.3 52320.2 52502.0 52740.0 52839.5 53531.0 11089.9 11118.8 11279.4 11453.8 11652.6 12521.4 12738.1 12790.8 12853.4 13339.7 10976.4 11095.0 11111.8 11117.3 11219.1 10325.0 10510.8 10516.9 10539.3 10797.1 10974.2 11082.3 11083.4 11130.0 11354.8 10803.3 11246.2 11311.9 11342.5 11374.8 10591.3 10629.0 11102.4 11133.7 11243.0 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#3] mootools.html Cycles:180 Average:6176.21 Median:4954.90 stddev:3995.30 (80.6%) stddev-sans-first:3988.65 17:07:05 INFO - PID 3386 | Values: 1148.9 1259.4 1332.9 1346.5 1352.3 8218.1 9575.4 9847.8 9867.5 9879.5 9567.1 9648.8 9661.4 9662.6 9686.8 1887.7 2247.8 2284.7 2286.9 2289.0 1926.3 2206.6 2290.4 2292.2 2301.4 2213.6 2251.0 2255.4 2259.6 2260.6 2202.7 2205.0 2206.3 2206.6 2207.2 1922.8 1937.3 1949.0 2140.6 2140.6 9885.1 9921.9 9989.4 10015.1 10018.8 5212.8 5393.9 5395.4 5404.0 5412.6 3235.9 3394.7 3394.9 3397.9 3402.8 1068.7 1129.7 1145.5 1148.8 1174.5 15011.5 15022.5 15043.0 15055.8 15085.5 4759.8 5038.3 5055.3 5060.4 5072.5 10713.3 10830.6 10839.7 11108.6 11114.3 5498.3 5501.7 5504.6 5526.9 5533.8 4239.2 4361.5 4922.6 4997.2 5042.1 3394.4 3481.3 3494.3 3506.5 3776.0 1111.8 1120.8 1121.5 1147.2 1156.9 687.7 700.1 713.1 723.1 740.7 5699.6 5945.9 5965.3 6083.3 6197.3 803.6 810.3 810.7 820.4 826.6 3240.6 3324.2 3345.9 3594.3 3794.7 12411.9 12911.3 13228.0 13251.9 13266.7 12958.9 13238.3 13240.5 13247.3 13265.5 9343.3 9536.4 9544.1 9544.5 9549.7 5728.3 5742.4 5744.4 5810.4 5889.3 11563.4 11770.2 11785.2 11968.6 11980.9 12237.1 12260.3 12319.9 12336.6 12467.8 7603.1 7645.1 7662.1 7736.0 7741.5 7880.9 8105.6 8671.7 8940.6 9018.0 7625.8 7626.1 7636.4 7732.5 7823.5 7501.5 7531.1 7590.0 7603.6 7642.4 6866.9 6984.9 7031.8 7032.6 7034.7 4987.2 5105.0 5118.2 5136.6 5138.4 5040.8 5197.0 5269.4 5270.8 5397.7 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#4] prototype.html Cycles:180 Average:4777.74 Median:5300.59 stddev:1325.44 (25.0%) stddev-sans-first:1287.64 17:07:05 INFO - PID 3386 | Values: 392.1 395.6 398.6 409.4 409.4 5370.3 5452.3 5486.8 5499.5 5564.6 5200.9 5239.1 5348.6 5361.2 5421.9 4364.8 4371.1 4371.2 4372.9 4379.9 4359.7 4361.5 4369.3 4382.7 4390.3 4259.8 4322.6 4331.7 4342.2 4353.6 4324.6 4336.3 4336.9 4338.6 4343.7 3886.6 3907.6 3916.5 3920.1 3931.9 5109.5 5302.2 5315.1 5326.4 5331.7 5009.7 5034.5 5034.8 5035.5 5047.3 5680.5 5683.0 5710.6 5743.8 5778.7 4213.3 4263.9 4272.1 4330.5 4332.8 5654.0 5873.5 5903.1 5927.2 5945.4 4327.3 4454.5 4460.0 4465.0 4468.4 4504.1 4532.6 4534.2 4541.3 4551.9 4720.3 4829.2 4848.4 4982.3 4991.6 5693.0 5718.4 5726.6 5732.5 5744.8 1551.0 1565.4 1566.2 1567.4 1571.1 1086.5 1113.8 1119.4 1120.6 1127.7 4913.0 4917.7 4931.5 4936.6 4942.9 5830.8 5837.8 5862.7 5875.4 5882.0 4763.9 4891.2 4924.5 4937.8 4960.6 3040.4 3055.6 3070.8 3080.2 3081.9 5294.8 5469.0 5470.2 5473.9 5500.1 5953.9 5978.4 5979.2 5984.5 6007.1 5468.9 5488.3 5500.5 5504.8 5529.3 5665.9 5846.8 5869.8 5882.8 5898.8 5787.3 5788.3 5789.5 5797.3 5799.9 5205.6 5298.9 5382.6 5396.4 5455.0 4414.3 4424.3 4428.6 4445.2 4450.6 5792.9 5830.8 5854.0 5877.7 5896.7 5665.6 5677.6 5693.7 5713.8 5717.9 5639.8 5675.3 5700.6 5701.7 5706.7 5513.0 5516.5 5560.7 5572.6 5621.2 5662.9 5694.9 5716.3 5717.8 5739.3 5400.5 5518.8 5526.8 5551.8 5566.0 17:07:05 INFO - PID 3386 | 17:07:05 INFO - PID 3386 | [#5] yui.html Cycles:180 Average:14100.83 Median:522.70 stddev:17638.26 (3374.5%) stddev-sans-first:17658.94 17:07:05 INFO - PID 3386 | Values: 678.5 697.7 698.4 712.1 731.1 11794.9 12382.8 12697.4 12809.7 13028.9 12420.2 12511.3 12631.0 12667.1 12695.0 832.1 835.9 861.7 867.9 868.9 860.8 869.1 872.4 872.8 874.1 904.1 905.4 906.9 907.3 907.4 890.5 891.5 892.3 893.0 893.3 670.8 670.9 671.9 673.1 673.5 13264.3 13479.9 13776.0 13848.8 13856.7 13409.5 14325.3 14345.6 14396.8 14406.5 9045.2 9195.4 9223.4 9307.5 9510.2 2415.5 2426.2 2465.8 2477.1 2481.1 64909.0 66777.3 67970.3 68689.3 69405.0 10445.6 10475.5 10561.8 10579.6 10671.4 19816.5 19851.7 19873.7 19923.5 20061.7 5783.2 5922.3 5945.0 5981.2 6087.0 2982.5 3030.6 3046.4 3137.0 3149.1 3353.4 3393.3 3397.1 3420.8 3441.7 580.3 583.5 586.7 593.1 598.0 535.4 547.9 553.7 559.0 559.1 7441.7 7719.3 8091.0 8166.9 8309.0 513.2 532.1 543.0 548.1 549.3 3601.4 3680.6 3716.0 3846.8 3880.1 60382.7 60456.7 60830.4 61526.7 61568.4 54609.5 55261.4 55638.7 55679.7 55748.7 47864.8 48050.3 48843.3 49262.0 49398.0 8352.7 8954.3 9052.0 9112.1 9180.9 23454.3 23701.6 24249.6 24471.9 25173.9 39752.4 39866.6 40504.0 40953.2 41646.4 10513.3 10790.3 11023.2 11111.1 11230.9 11875.5 12102.5 12124.9 12282.4 12308.3 11347.5 11397.7 11622.9 11839.6 12031.5 10642.6 10904.9 10917.5 10975.7 11342.8 11094.7 11474.6 11479.7 11598.9 11615.9 8981.6 9417.8 9443.9 9459.6 9518.7 8501.4 8956.3 9253.6 9335.8 9386.5 17:07:05 INFO - PID 3386 | -------- Summary: end -------- 17:07:05 INFO - PID 3386 | 17:07:06 INFO - TEST-INFO | 3386: exit 0 17:07:06 INFO - TEST-OK | dromaeo_css | took 1123877ms 17:07:06 INFO - TEST-START | kraken 17:07:06 INFO - operating with platform_type : linux_ 17:07:06 INFO - Initialising browser for kraken test... 17:07:06 INFO - TEST-INFO | started process 3706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpruIaoo/profile http://localhost:43198/getInfo.html) 17:07:10 INFO - PID 3706 | __metrics Screen width/height:1600/1200 17:07:10 INFO - PID 3706 | colorDepth:24 17:07:10 INFO - PID 3706 | Browser inner width/height: 1024/697 17:07:10 INFO - PID 3706 | __metrics 17:07:11 INFO - PID 3706 | 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" 17:07:11 INFO - PID 3706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:07:11 INFO - TEST-INFO | 3706: exit 0 17:07:11 INFO - Browser initialized. 17:07:11 INFO - Running cycle 1/1 for kraken test... 17:07:12 INFO - TEST-INFO | started process 3800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpruIaoo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:24 INFO - PID 3800 | RSS: Main: 150085632 17:07:24 INFO - PID 3800 | 17:07:26 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43198/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:27 INFO - PID 3800 | RSS: Main: 204873728 17:07:27 INFO - PID 3800 | 17:07:30 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43198/tests/kraken/driver.html?testName=audio-dft) 17:07:31 INFO - PID 3800 | RSS: Main: 183369728 17:07:31 INFO - PID 3800 | 17:07:34 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43198/tests/kraken/driver.html?testName=audio-fft) 17:07:34 INFO - PID 3800 | RSS: Main: 266559488 17:07:34 INFO - PID 3800 | 17:07:36 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43198/tests/kraken/driver.html?testName=audio-oscillator) 17:07:37 INFO - PID 3800 | RSS: Main: 177721344 17:07:37 INFO - PID 3800 | 17:07:39 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:40 INFO - PID 3800 | RSS: Main: 181157888 17:07:40 INFO - PID 3800 | 17:07:43 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43198/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:44 INFO - PID 3800 | RSS: Main: 219615232 17:07:44 INFO - PID 3800 | 17:07:47 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43198/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:48 INFO - PID 3800 | RSS: Main: 214757376 17:07:48 INFO - PID 3800 | 17:07:51 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43198/tests/kraken/driver.html?testName=json-parse-financial) 17:07:51 INFO - PID 3800 | RSS: Main: 216838144 17:07:51 INFO - PID 3800 | 17:07:53 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:54 INFO - PID 3800 | RSS: Main: 180875264 17:07:54 INFO - PID 3800 | 17:07:56 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:56 INFO - PID 3800 | RSS: Main: 187125760 17:07:56 INFO - PID 3800 | 17:07:58 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:59 INFO - PID 3800 | RSS: Main: 197279744 17:07:59 INFO - PID 3800 | 17:08:02 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:08:03 INFO - PID 3800 | RSS: Main: 205901824 17:08:03 INFO - PID 3800 | 17:08:06 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:08:06 INFO - PID 3800 | RSS: Main: 202633216 17:08:06 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | Cycle 1(1): loaded http://localhost:43198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43198/tests/kraken/driver.html?testName=ai-astar) 17:08:08 INFO - PID 3800 | RSS: Main: 271450112 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | __start_tp_report 17:08:08 INFO - PID 3800 | _x_x_mozilla_page_load 17:08:08 INFO - PID 3800 | _x_x_mozilla_page_load_details 17:08:08 INFO - PID 3800 | |i|pagename|runs| 17:08:08 INFO - PID 3800 | |0;ai-astar;102;112;112;111;112;112;110;112;111;111 17:08:08 INFO - PID 3800 | |1;audio-beat-detection;155;123;121;165;123;122;123;124;154;124 17:08:08 INFO - PID 3800 | |2;audio-dft;163;163;163;163;163;164;162;161;162;165 17:08:08 INFO - PID 3800 | |3;audio-fft;74;75;78;111;75;76;78;75;92;75 17:08:08 INFO - PID 3800 | |4;audio-oscillator;84;85;104;83;84;83;101;83;84;111 17:08:08 INFO - PID 3800 | |5;imaging-gaussian-blur;113;113;113;113;113;114;114;114;113;113 17:08:08 INFO - PID 3800 | |6;imaging-darkroom;150;150;148;149;149;149;149;150;148;150 17:08:08 INFO - PID 3800 | |7;imaging-desaturate;93;94;94;94;94;93;93;93;94;93 17:08:08 INFO - PID 3800 | |8;json-parse-financial;71;64;64;65;65;66;66;69;66;69 17:08:08 INFO - PID 3800 | |9;json-stringify-tinderbox;55;55;55;56;55;56;55;56;56;56 17:08:08 INFO - PID 3800 | |10;stanford-crypto-aes;84;82;84;84;82;82;81;83;83;81 17:08:08 INFO - PID 3800 | |11;stanford-crypto-ccm;139;136;131;138;142;137;130;134;186;138 17:08:08 INFO - PID 3800 | |12;stanford-crypto-pbkdf2;184;193;197;205;194;190;203;193;193;193 17:08:08 INFO - PID 3800 | |13;stanford-crypto-sha256-iterative;73;69;71;73;73;73;71;71;72;69 17:08:08 INFO - PID 3800 | __end_tp_report 17:08:08 INFO - PID 3800 | __start_cc_report 17:08:08 INFO - PID 3800 | _x_x_mozilla_cycle_collect,2005 17:08:08 INFO - PID 3800 | __end_cc_report 17:08:08 INFO - PID 3800 | __startTimestamp1490314088981__endTimestamp 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | ------- Summary: start ------- 17:08:08 INFO - PID 3800 | Number of tests: 14 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:0.73 17:08:08 INFO - PID 3800 | Values: 102.0 112.0 112.0 111.0 112.0 112.0 110.0 112.0 111.0 111.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:124.00 stddev:17.24 (13.9%) stddev-sans-first:16.42 17:08:08 INFO - PID 3800 | Values: 155.0 123.0 121.0 165.0 123.0 122.0 123.0 124.0 154.0 124.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 17:08:08 INFO - PID 3800 | Values: 163.0 163.0 163.0 163.0 163.0 164.0 162.0 161.0 162.0 165.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:11.82 (15.7%) stddev-sans-first:12.27 17:08:08 INFO - PID 3800 | Values: 74.0 75.0 78.0 111.0 75.0 76.0 78.0 75.0 92.0 75.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.50 stddev:10.74 (12.9%) stddev-sans-first:11.15 17:08:08 INFO - PID 3800 | Values: 84.0 85.0 104.0 83.0 84.0 83.0 101.0 83.0 84.0 111.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:08:08 INFO - PID 3800 | Values: 113.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:08:08 INFO - PID 3800 | Values: 150.0 150.0 148.0 149.0 149.0 149.0 149.0 150.0 148.0 150.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 17:08:08 INFO - PID 3800 | Values: 93.0 94.0 94.0 94.0 94.0 93.0 93.0 93.0 94.0 93.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:2.37 (3.6%) stddev-sans-first:1.87 17:08:08 INFO - PID 3800 | Values: 71.0 64.0 64.0 65.0 65.0 66.0 66.0 69.0 66.0 69.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 17:08:08 INFO - PID 3800 | Values: 55.0 55.0 55.0 56.0 55.0 56.0 55.0 56.0 56.0 56.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.17 (1.4%) stddev-sans-first:1.13 17:08:08 INFO - PID 3800 | Values: 84.0 82.0 84.0 84.0 82.0 82.0 81.0 83.0 83.0 81.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:138.00 stddev:16.19 (11.7%) stddev-sans-first:17.15 17:08:08 INFO - PID 3800 | Values: 139.0 136.0 131.0 138.0 142.0 137.0 130.0 134.0 186.0 138.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:193.50 stddev:6.04 (3.1%) stddev-sans-first:5.07 17:08:08 INFO - PID 3800 | Values: 184.0 193.0 197.0 205.0 194.0 190.0 203.0 193.0 193.0 193.0 17:08:08 INFO - PID 3800 | 17:08:08 INFO - PID 3800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.50 stddev:1.58 (2.2%) stddev-sans-first:1.58 17:08:08 INFO - PID 3800 | Values: 73.0 69.0 71.0 73.0 73.0 73.0 71.0 71.0 72.0 69.0 17:08:08 INFO - PID 3800 | -------- Summary: end -------- 17:08:08 INFO - PID 3800 | 17:08:10 INFO - TEST-INFO | 3800: exit 0 17:08:10 INFO - TEST-OK | kraken | took 64024ms 17:08:10 INFO - SUITE-END | took 1187s 17:08:10 INFO - Completed test suite (00:19:48) 17:08:10 INFO - javascript benchmark 17:08:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6652.875838484428, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.0876605248463, 2699.9865000674995, 2715.3483164040636, 2719.836809791412, 2725.4004119093793, 4982.676126051813, 5070.13807652699, 5081.644284900059, 5115.976804639073, 5180.300659410983, 5025.597952163827, 5070.416902056265, 5074.061298659742, 5075.213341931997, 5078.365204349457, 4612.3542704021465, 4657.953420465803, 4671.275952227394, 4727.976360118195, 4732.408448943882, 4687.859364219079, 4708.693934894238, 4735.73953432561, 4743.573078422941, 4783.425988881322, 4732.45576758672, 4772.403449568804, 4793.185158523042, 4793.880152996186, 4799.0, 4762.499937506546, 4764.928526072112, 4764.952350476486, 4765.761711914391, 4793.808247670089, 4688.109259240733, 4725.574698277172, 4736.550027747358, 4741.8103275868925, 4780.067886762083, 4881.0, 4976.402831660224, 5013.824516141954, 5132.3327967364, 5161.1742121260795, 5308.362996440414, 5317.361916569997, 5362.2224777407055, 5476.835694929158, 5479.506844384025, 5541.0580201365865, 5547.972260138714, 5558.471945165203, 5560.527355174815, 5565.276514053187, 5013.498650134958, 5173.76718047685, 5182.792688292426, 5182.974085129626, 5234.685918844843, 5542.778288868481, 5556.166575013699, 5598.468145526169, 5628.971855140698, 5640.576956728261, 5362.65142765719, 5378.757955891994, 5381.892362152735, 5387.057264978613, 5415.079436495806, 5443.673379597237, 5457.154141108134, 5464.508194262536, 5466.699331536804, 5520.779168833282, 5303.708296043677, 5361.571074314045, 5367.919481207785, 5405.918911216335, 5427.3758517770175, 5395.379531353945, 5443.237946687467, 5476.205950137208, 5493.121100623881, 5503.559715222853, 4554.817807287738, 4568.862934111982, 4577.5880170784785, 4578.061497393093, 4600.263957766808, 3882.6699730523223, 3899.922001559953, 3902.2195560887367, 3957.56466788653, 3959.6238357356006, 4629.930551041737, 4634.513376095461, 4660.790264438108, 4670.719756814534, 4680.227762419231, 5493.917591236134, 5498.972505137449, 5499.1476321170285, 5505.862353441116, 5546.805861794818, 4561.270196768501, 4694.7417892016265, 4695.718256904596, 4696.647751418657, 4702.247640377524, 4779.904401911942, 4795.856124316276, 4806.831760888422, 4820.9517904821205, 4852.126617208795, 5138.177891537336, 5148.227765835155, 5152.072626927189, 5167.069927413102, 5201.765920533509, 5453.863653408696, 5487.039768040657, 5500.724963751876, 5517.200005999188, 5521.668699878021, 4982.67612605194, 4984.800607975785, 5037.722925239147, 5129.461406552258, 5146.25379319989, 5306.469353064663, 5316.441773613869, 5318.388385335736, 5319.414864364994, 5320.042392369411, 5371.140617501181, 5385.784568617211, 5422.186671999074, 5424.83725488236, 5467.890642187213, 5380.058489764354, 5390.757415916371, 5391.29913111293, 5392.325959255093, 5423.267858839006, 5307.920381194363, 5369.838904832861, 5371.033214021513, 5374.167004114369, 5419.620626556103, 5112.437631860566, 5162.380514338303, 5264.578833693372, 5279.10255256615, 5295.602829787858, 5413.458654134555, 5413.918791218056, 5417.8103766367985, 5455.263539422286, 5465.808696695596, 5262.210668399771, 5265.052290587731, 5266.183741520071, 5266.73666316675, 5277.366715994105], "value": 4999.090656779275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.9496040316773, 675.719576375804, 693.4972145194732, 1075.9623413180536, 1093.7703082352705, 26799.86600067002, 32283.192920177007, 32629.0, 32722.67277327226, 32847.0, 33715.49426758601, 34078.65921340786, 34132.317353652914, 37752.81123594385, 37808.0, 5681.545476361881, 7497.2502749725, 7682.5006374585755, 7700.11448683403, 7702.8844567331535, 5549.112142057252, 7087.078679771623, 7093.219745827955, 7107.182673992479, 7228.963855180717, 7188.856222875539, 7481.6633251503545, 7608.429367797409, 7617.657205425741, 7618.276263754934, 5653.519450846683, 7511.624418779066, 7589.165191828894, 7591.848163036763, 7600.277973592528, 5724.084146536576, 7176.784696459063, 7252.528585641917, 7262.745803896838, 7263.0, 31617.84191079053, 31951.84024079888, 31971.0, 31973.0, 32029.679703202903, 2626.0808716948914, 2633.0652618320605, 2643.572930842509, 2643.722409147031, 2646.2193652872447, 23975.160869369487, 24137.879310603512, 24246.39384015396, 24346.904389302523, 25050.123245686496, 2651.191386627078, 2655.907043253477, 2682.383051898055, 2688.946221075587, 2708.9864550677316, 148345.0, 150286.24856875645, 150411.0, 150533.0, 151007.24496377556, 43757.34363984543, 43877.56122438799, 43955.34066988998, 43967.340489892675, 43974.340384894254, 46777.76611116923, 46813.0, 46836.7658161707, 46865.07916668769, 46947.29579056317, 11633.360165190996, 11789.941050294694, 11791.88208117925, 11802.704932376588, 11804.40977951099, 7932.246436588515, 7999.520028798291, 9203.0, 9208.355415121012, 9223.677171298972, 10888.237823352447, 11005.779884402267, 11010.944945275221, 11943.701407464709, 12158.817617735742, 4791.061365364792, 5136.43499215086, 5179.559737422286, 5242.449542798027, 5314.893702125936, 871.6121326009865, 896.5472436419566, 900.5407242306471, 901.3150005995491, 915.1214833759665, 20754.792452075588, 21594.56810863774, 21636.134554617638, 21747.347579572637, 21778.167960254494, 959.6928982725461, 961.990380096204, 972.8374592362201, 975.7950830325711, 988.2280204027771, 10854.185936054828, 11068.28056176346, 11224.326540407601, 11299.49152288149, 11371.54513819438, 217246.0, 217842.0, 219618.0, 219874.0, 220343.0, 42465.0, 42501.78749106234, 42549.36175957363, 42564.1487170261, 42599.36100958488, 1148.5396796531486, 1212.6543934978488, 1224.12475080318, 1228.3305598448867, 1236.0297166724079, 19275.650704451116, 19871.701924471432, 20359.694604580647, 20447.4888127798, 20758.0, 30147.397052059274, 30523.694763052084, 30536.236594085327, 30542.0, 30589.23526911845, 222829.0, 222944.0, 222969.0, 223292.0, 223577.0, 28590.714092858805, 29584.260393490335, 29614.703852961196, 29673.0, 29690.55464167996, 26766.464670706868, 30275.545866812456, 31800.204994874388, 32334.83832580822, 36418.27163456769, 24173.274801755975, 24358.0, 24760.380990474663, 24965.87517062403, 25340.0, 24445.633315500636, 24752.50494990126, 25052.373690657878, 25071.623925641496, 27024.97312701516, 29014.854925725238, 29209.707902920698, 29390.179276693892, 29417.411651767274, 29471.55792663069, 25761.484770304865, 25769.474635420167, 25984.220473385827, 26045.6093158599, 26066.86966565231, 19569.315073972342, 21246.362609121752, 21281.7871821286, 21291.467713306673, 22922.656160157945], "value": 14422.286350969107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.2875382457612, 418.3703526193083, 424.9277622804123, 438.69729886378394, 438.7871882137164, 15376.308066137022, 17474.82525174748, 17985.550361240974, 18203.453896383096, 18205.544861378454, 17510.299588016496, 17629.20668569914, 17699.380521681745, 17709.7343539847, 17825.108744562785, 5213.504717051884, 5429.239906413105, 5616.971915140419, 5685.545156387499, 5689.260396148495, 5587.804426845061, 5665.518430933375, 5677.886442271152, 5686.431356864301, 5687.687177205252, 5452.972735136319, 5615.494605485505, 5620.353659329188, 5647.802326918559, 5663.348714897798, 5639.436056394348, 5669.6314739541795, 5675.829725108253, 5677.687727175004, 5680.886382272352, 5023.246513023039, 5056.74716264189, 5087.338645976037, 5094.541491265767, 5096.51583099605, 20840.166393344247, 21102.788972110237, 23457.178998734962, 23506.0, 23574.88212558926, 1632.9183540822912, 1659.9253033613516, 1670.9331626734916, 1685.494351694499, 1688.8564472019893, 14968.625784355369, 15086.773698394532, 15516.61208469786, 15635.140067296294, 15826.683466330724, 1794.4078454110113, 1820.599468117012, 1876.6340563590106, 1879.0510792049927, 1880.2666959885655, 79603.60198198972, 87681.56159219163, 88429.55785221097, 89316.0, 91628.08371916262, 17580.38468653591, 17688.0, 17691.557711057325, 17835.46493605194, 17860.285588576313, 32912.0, 32927.0, 33038.66961330356, 33066.834665826515, 33367.33265334728, 7975.800604984922, 8073.959630201812, 8155.347572194329, 8184.754457366289, 8347.248747612744, 6274.874502510015, 6334.3665633436285, 6360.9045864312075, 6518.054882042077, 6534.346565343428, 9380.484073375894, 9397.483138427315, 9532.142107210384, 9630.3516532954, 9694.90305096954, 3539.628339024417, 3734.8506059757847, 3746.587875333711, 3967.532013155151, 4098.262312783728, 822.3585603229491, 837.3803385494812, 862.1464749897556, 864.8400045991511, 870.1559487297311, 16169.0, 16254.106024168785, 16346.67306653884, 16463.91768041152, 16982.320707171573, 842.5366048673205, 858.553552152877, 860.3289434241177, 863.2705363967438, 867.4231635962141, 8499.490030598185, 9072.183503484717, 9428.858567121499, 9448.95275523618, 9557.90442095584, 448362.3073192423, 448397.0, 449413.0, 449577.0, 449593.0, 86922.0, 87078.56460717655, 87471.56264218639, 87885.56057219801, 88078.55960720155, 1033.2405681823852, 1048.5962904281753, 1076.252004856617, 1079.6005477973201, 1080.135891286983, 14035.105260789664, 14292.785608216092, 14380.928095359457, 14496.782548261996, 15034.699306014038, 42267.1546569073, 42431.575684242765, 42510.57489425066, 42654.78672606617, 44259.33610995773, 52320.215196771314, 52502.0, 52740.0, 52839.47160528499, 53531.0, 11089.94455027752, 11118.826967751476, 11279.379634120201, 11453.828192577284, 11652.592159274385, 12521.436535355748, 12738.108332416641, 12790.808137877753, 12853.35733213317, 13339.66650833737, 10976.396298203676, 11095.0, 11111.833322500008, 11117.27737697047, 11219.102471802073, 10325.0, 10510.842337364793, 10516.947415262875, 10539.262251642618, 10797.082248009006, 10974.176936729618, 11082.33505989611, 11083.445827708743, 11130.0, 11354.772904542027, 10803.297785643908, 11246.212765106364, 11311.886881131084, 11342.546298148312, 11374.772504550028, 10591.311564748266, 10629.04338609498, 11102.389368584805, 11133.721656958642, 11243.044341231087], "value": 9613.925750735283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1148.8563929508812, 1259.3766085787536, 1332.873377029182, 1346.5354452713816, 1352.3238380809596, 8218.137095604958, 9575.377600455975, 9847.803043939126, 9867.506624668773, 9879.456629885372, 9567.138957493842, 9648.758781030478, 9661.420314781119, 9662.565184566694, 9686.806263874718, 1887.6696578098847, 2247.786460286274, 2284.7486776454575, 2286.862788232703, 2288.965665515019, 1926.3257859749117, 2206.6248737714627, 2290.3815969688258, 2292.1633603734685, 2301.355620426283, 2213.6015517206897, 2251.043306594699, 2255.436140964759, 2259.559385919746, 2260.6156953317895, 2202.702635144251, 2204.9889750551306, 2206.305013920618, 2206.5917805206086, 2207.2164381644448, 1922.7500424944808, 1937.2638397409034, 1949.0449679657008, 2140.56118495708, 2140.636091864387, 9885.060919212663, 9921.851172232422, 9989.400635961792, 10015.09864112226, 10018.849717254247, 5212.817551385721, 5393.892122157535, 5395.433479484637, 5404.0, 5412.5940554458175, 3235.919102022445, 3394.7114495267933, 3394.8981530554124, 3397.8810741623925, 3402.795832250073, 1068.7167900506372, 1129.6893354327626, 1145.4959817680194, 1148.8161894096904, 1174.4714878304712, 15011.549653510412, 15022.549323520203, 15043.022203556844, 15055.774163387558, 15085.472008479761, 4759.833405830779, 5038.34501514808, 5055.292259083732, 5060.367454068241, 5072.492750724898, 10713.250072495006, 10830.620928267474, 10839.67480975572, 11108.61119860801, 11114.277571957797, 5498.285222920995, 5501.669899806025, 5504.587155963319, 5526.861828454321, 5533.778648854081, 4239.236937351307, 4361.542038086019, 4922.581580565692, 4997.225430058346, 5042.09242336383, 3394.372041172391, 3481.3211423772123, 3494.266204097168, 3506.4564992425703, 3775.981120094437, 1111.827666711661, 1120.78705046041, 1121.5401685308984, 1147.1568397228032, 1156.8843115688533, 687.669918439152, 700.1458220970408, 713.0658836923647, 723.106962900817, 740.6666999850089, 5699.629524081004, 5945.851353716192, 5965.313988891333, 6083.330833608299, 6197.287311959092, 803.5941849366033, 810.339573247813, 810.720301495983, 820.3806126374549, 826.5784449930578, 3240.6273278573267, 3324.2188085799817, 3345.9330813383594, 3594.281143771256, 3794.658480736747, 12411.875881241072, 12911.289879056741, 13228.007899407583, 13251.93374033143, 13266.73466530664, 12958.870411295955, 13238.338083095807, 13240.470381184838, 13247.271400072896, 13265.535706250428, 9343.252539796937, 9536.427814331162, 9544.09331113557, 9544.475053871965, 9549.713508594754, 5728.283964504437, 5742.397048309867, 5744.368119506935, 5810.448007439287, 5889.322727886348, 11563.364014979257, 11770.234934729215, 11785.175037747274, 11968.640940771791, 11980.940095299467, 12237.143399961917, 12260.26438413698, 12319.876801231872, 12336.62990110298, 12467.750644986869, 7603.0876294844975, 7645.120811106572, 7662.118856331594, 7735.955645987945, 7741.496802707806, 7880.881786773318, 8105.635246413807, 8671.696490622799, 8940.552972351486, 9018.0, 7625.809354766176, 7626.122995855548, 7636.427267954815, 7732.536047837148, 7823.452358334862, 7501.512401693873, 7531.133919599097, 7589.975353327451, 7603.581803000667, 7642.350400216044, 6866.862662746617, 6984.860302794017, 7031.753888613874, 7032.578045317297, 7034.718611255493, 4987.226979818134, 5105.030044291572, 5118.155504341891, 5136.614753893398, 5138.407093800934, 5040.798368065236, 5197.0, 5269.446708095595, 5270.762815673227, 5397.676139431646], "value": 4661.571703477619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.14316717971235, 395.63206218217056, 398.5755170743158, 409.3920528015894, 409.4247582147083, 5370.2750128732605, 5452.345718513779, 5486.807961721341, 5499.532539734118, 5564.610477266593, 5200.917279935252, 5239.13554263547, 5348.625596208267, 5361.169018802092, 5421.918671219935, 4364.847230346939, 4371.125774845028, 4371.235033869076, 4372.934405983913, 4379.934300985472, 4359.738415695053, 4361.454818147731, 4369.257226271541, 4382.693211475198, 4390.331673963889, 4259.829606815723, 4322.589354011364, 4331.740095594275, 4342.174986752522, 4353.564643535653, 4324.610785029331, 4336.284513055342, 4336.91326173478, 4338.6095251427205, 4343.6959412841115, 3886.591907849663, 3907.628775266345, 3916.549596796348, 3920.1375697346825, 3931.862384816546, 5109.540141387256, 5302.231176479428, 5315.123004704219, 5326.44072372403, 5331.680099194022, 5009.724465154415, 5034.54689077981, 5034.773435195425, 5035.521625445577, 5047.293378926953, 5680.460356266148, 5683.010946168849, 5710.573006472233, 5743.827685169452, 5778.711064446761, 4213.30480470722, 4263.87208383749, 4272.145570885836, 4330.523642399334, 4332.783360831977, 5654.010548154057, 5873.471387575096, 5903.114532820068, 5927.199828023205, 5945.405459454063, 4327.307630779123, 4454.487733910577, 4459.955400446019, 4465.0, 4468.396766436555, 4504.144212599595, 4532.5694059064335, 4534.206513860061, 4541.250693635579, 4551.931721024187, 4720.268358404453, 4829.1790395632825, 4848.369711937426, 4982.2775697524385, 4991.625628077909, 5692.971535142297, 5718.399568045378, 5726.599138060295, 5732.484076433141, 5744.798932037359, 1550.9612259693597, 1565.4286185542423, 1566.216891554223, 1567.404386333209, 1571.1123215383273, 1086.462201210406, 1113.7939481196004, 1119.3563700871869, 1120.641394753671, 1127.689885281554, 4912.975435122801, 4917.729524876167, 4931.495893752368, 4936.6297527685565, 4942.8764280893265, 5830.82507524775, 5837.795677151279, 5862.677552734555, 5875.383084776037, 5882.0, 4763.904721905543, 4891.241857512091, 4924.4583095859425, 4937.802487900515, 4960.553550180501, 3040.3615240799236, 3055.6486004109365, 3070.8003979741693, 3080.2299425143715, 3081.92295192622, 5294.841154765363, 5468.972655136698, 5470.179473078991, 5473.917891231635, 5500.119980803052, 5953.851153721192, 5978.372270911492, 5979.222701048923, 5984.521238301013, 6007.10421006878, 5468.91796623051, 5488.313960754906, 5500.477454641803, 5504.779808807602, 5529.253550770675, 5665.886682266414, 5846.795362162474, 5869.7945571904775, 5882.764689412375, 5898.764049438146, 5787.276590426197, 5788.334341550775, 5789.507891829242, 5797.275340582427, 5799.94200057994, 5205.635605507729, 5298.947010529845, 5382.590496550942, 5396.379416367168, 5454.972725136349, 4414.337849322627, 4424.336349547593, 4428.601425871687, 4445.155420470101, 4450.577195166454, 5792.918774174253, 5830.76676932918, 5854.0, 5877.735501902339, 5896.6756828374855, 5665.631733937281, 5677.630953987978, 5693.743781529924, 5713.771449142154, 5717.914231286451, 5639.802606908738, 5675.31896172462, 5700.629459085146, 5701.686407247641, 5706.714664266853, 5512.989523139216, 5516.503514683698, 5560.666360018412, 5572.554195664418, 5621.241132447068, 5662.915056274077, 5694.886102277848, 5716.342620598518, 5717.828465146053, 5739.253896993364, 5400.540954018952, 5518.841043380935, 5526.761661527088, 5551.7779288828, 5566.0], "value": 4381.544970021047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.5284227461916, 697.7209116353458, 698.3714656808872, 712.113418793602, 731.1137265854095, 11794.941025294873, 12382.752344953096, 12697.428615712292, 12809.679758006054, 13028.934855325733, 12420.19268747533, 12511.311877846714, 12631.0, 12667.113302068836, 12695.047871409635, 832.0680837462036, 835.8746188071807, 861.7199410191681, 867.9305655547572, 868.8827008353886, 860.8192279621287, 869.0874581689233, 872.371892237591, 872.8079822439054, 874.1040433555593, 904.145582424609, 905.4160066756938, 906.8821053263066, 907.2651152566409, 907.3920473282883, 890.4968692688642, 891.4695756025154, 892.3441270666056, 892.9910700892973, 893.2942975049735, 670.7954074007425, 670.9161354830646, 671.8958561422987, 673.0745225315192, 673.4645956464623, 13264.270465124415, 13479.865201347959, 13776.0, 13848.792268115987, 13856.722865542633, 13409.46362145513, 14325.283735813167, 14345.569632911029, 14396.784048239284, 14406.495772648012, 9045.185933266037, 9195.356325057248, 9223.44659320443, 9307.534623268877, 9510.191633711143, 2415.456522282472, 2426.235735743235, 2465.753424657538, 2477.1082410332265, 2481.10680155144, 64909.0, 66777.3322266776, 67970.3202967969, 68689.31310686929, 69405.0, 10445.64972881111, 10475.528601212964, 10561.788764224673, 10579.62971296001, 10671.35971841692, 19816.50458738514, 19851.702224466644, 19873.701894471593, 19923.501912452015, 20061.699074513603, 5783.248177736868, 5922.2597175353085, 5945.047035170942, 5981.222441082718, 6087.0, 2982.537706655472, 3030.575719399286, 3046.3907218555933, 3136.98431507841, 3149.0710240479116, 3353.413152698268, 3393.3043726036103, 3397.11674964511, 3420.8289585520624, 3441.741869359808, 580.3471095018105, 583.5069366385397, 586.6802592586965, 593.1458699472831, 598.019248432571, 535.4351159526659, 547.8520799384223, 553.698234462219, 558.9608727389044, 559.0886854427339, 7441.739539116214, 7719.305262526287, 8091.0, 8166.877496837434, 8309.0, 513.2455290722631, 532.1485623003164, 542.9513282916396, 548.1485146065733, 549.3215878390185, 3601.3877640801124, 3680.5951345352523, 3716.0, 3846.769193848378, 3880.1269714314053, 60382.698086510165, 60456.69771651202, 60830.39169608336, 61526.69236653877, 61568.384316157164, 54609.45390546123, 55261.44738552644, 55638.721806390706, 55679.721601391735, 55748.72125639427, 47864.7606761964, 48050.27924581064, 48843.267350989765, 49262.0, 49398.0, 8352.665893364197, 8954.328425368254, 9052.0, 9112.134347237003, 9180.862287065565, 23454.296371108892, 23701.644475332538, 24249.63625545583, 24471.87764061168, 25173.87413062923, 39752.40371394489, 39866.60133398629, 40503.98740031523, 40953.1809363817, 41646.37530437107, 10513.316634418738, 10790.298630589301, 11023.17326200522, 11111.11111111093, 11230.94384528072, 11875.465604047666, 12102.515899363927, 12124.878751212374, 12282.38588070575, 12308.323042232763, 11347.489362978851, 11397.715057123307, 11622.94188529052, 11839.644810655695, 12031.518739250332, 10642.574297028343, 10904.945475272572, 10917.508712108132, 10975.725606859893, 11342.829857551978, 11094.667159985212, 11474.598389056342, 11479.713007174887, 11598.884011160118, 11615.941920290345, 8981.595828187617, 9417.764555886157, 9443.905560944302, 9459.574319155792, 9518.714438566854, 8501.404901657072, 8956.28349732033, 9253.58358873839, 9335.813283734424, 9386.530673466163], "value": 6124.029882668267, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 111.0, 112.0, 112.0, 110.0, 112.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 121.0, 165.0, 123.0, 122.0, 123.0, 124.0, 154.0, 124.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 164.0, 162.0, 161.0, 162.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 111.0, 75.0, 76.0, 78.0, 75.0, 92.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 104.0, 83.0, 84.0, 83.0, 101.0, 83.0, 84.0, 111.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 149.0, 149.0, 149.0, 149.0, 150.0, 148.0, 150.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 64.0, 65.0, 65.0, 66.0, 66.0, 69.0, 66.0, 69.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 84.0, 82.0, 82.0, 81.0, 83.0, 83.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 131.0, 138.0, 142.0, 137.0, 130.0, 134.0, 186.0, 138.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 193.0, 197.0, 205.0, 194.0, 190.0, 203.0, 193.0, 193.0, 193.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 71.0, 73.0, 73.0, 73.0, 71.0, 71.0, 72.0, 69.0], "value": 71.5, "unit": "score"}]}]} 17:08:10 INFO - Return code: 0 17:08:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:08:10 ERROR - # TBPL SUCCESS # 17:08:10 INFO - Running post-action listener: _resource_record_post_action 17:08:10 INFO - [mozharness: 2017-03-24 00:08:10.793387Z] Finished run-tests step (success) 17:08:10 INFO - Running post-run listener: _resource_record_post_run 17:08:10 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7598080; Write bytes: 366567424; Read time: 1392; Write time: 250564 17:08:10 INFO - TinderboxPrint: CPU usage
13.0% 17:08:10 INFO - TinderboxPrint: I/O read bytes / time
7,598,080 / 1,392 17:08:10 INFO - TinderboxPrint: I/O write bytes / time
366,567,424 / 250,564 17:08:10 INFO - TinderboxPrint: CPU idle
8,362.8 (87.0%) 17:08:10 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 17:08:10 INFO - TinderboxPrint: Swap in / out
0 / 0 17:08:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119005184; Read time: 28; Write time: 95724 17:08:10 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 7593984; Write bytes: 247562240; Read time: 1364; Write time: 154840 17:08:11 INFO - Running post-run listener: _upload_blobber_files 17:08:11 INFO - Blob upload gear active. 17:08:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:08:11 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 17:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:08:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:08:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:08:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:08:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:12 INFO - (blobuploader) - INFO - Done attempting. 17:08:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:08:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:14 INFO - (blobuploader) - INFO - Done attempting. 17:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:08:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:15 INFO - (blobuploader) - INFO - Done attempting. 17:08:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:08:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:30 INFO - (blobuploader) - INFO - Done attempting. 17:08:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:08:30 INFO - Return code: 0 17:08:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:08:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:08:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/894e1b25a23eef9acf323de8b0730441cd27966534fa0679aa17a61334fe00d31f607cb469ccd4e691638176150f3a086552e2daccff8c4e059668dbf54e7f1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/726f9d3d2f913c42d74017a911f6513048bcdee4db6d7c3cbee51af2c5e160cb54f756acd860a2c41c20a7ac82ec8439ad80b88b124f8f90f23c1525c42e9605", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/309193168d96317d505512f86247debcce1a2f6fd067f17e0070aebedbf2d98d36aec187a331bf31f3ac71aa984680d83161ac6fe9729ed80e8d9b4b195403df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d923cfa87921b6ea468e1c95bba02d5001f077f7e8dd106050f22cac6fd6e10ec3e0536c9a01f66710296e04baa42535ebf045c3ebcbda5dd7d5411859ca7e59"} 17:08:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:08:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:08:30 INFO - Contents: 17:08:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/894e1b25a23eef9acf323de8b0730441cd27966534fa0679aa17a61334fe00d31f607cb469ccd4e691638176150f3a086552e2daccff8c4e059668dbf54e7f1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/726f9d3d2f913c42d74017a911f6513048bcdee4db6d7c3cbee51af2c5e160cb54f756acd860a2c41c20a7ac82ec8439ad80b88b124f8f90f23c1525c42e9605", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/309193168d96317d505512f86247debcce1a2f6fd067f17e0070aebedbf2d98d36aec187a331bf31f3ac71aa984680d83161ac6fe9729ed80e8d9b4b195403df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d923cfa87921b6ea468e1c95bba02d5001f077f7e8dd106050f22cac6fd6e10ec3e0536c9a01f66710296e04baa42535ebf045c3ebcbda5dd7d5411859ca7e59"} 17:08:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:08:30 INFO - Copying logs to upload dir... 17:08:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:08:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.896794 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-03-23 17:08:30.226829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:30.230675) ========= 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=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/894e1b25a23eef9acf323de8b0730441cd27966534fa0679aa17a61334fe00d31f607cb469ccd4e691638176150f3a086552e2daccff8c4e059668dbf54e7f1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/726f9d3d2f913c42d74017a911f6513048bcdee4db6d7c3cbee51af2c5e160cb54f756acd860a2c41c20a7ac82ec8439ad80b88b124f8f90f23c1525c42e9605", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/309193168d96317d505512f86247debcce1a2f6fd067f17e0070aebedbf2d98d36aec187a331bf31f3ac71aa984680d83161ac6fe9729ed80e8d9b4b195403df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d923cfa87921b6ea468e1c95bba02d5001f077f7e8dd106050f22cac6fd6e10ec3e0536c9a01f66710296e04baa42535ebf045c3ebcbda5dd7d5411859ca7e59"} build_url:https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/894e1b25a23eef9acf323de8b0730441cd27966534fa0679aa17a61334fe00d31f607cb469ccd4e691638176150f3a086552e2daccff8c4e059668dbf54e7f1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/726f9d3d2f913c42d74017a911f6513048bcdee4db6d7c3cbee51af2c5e160cb54f756acd860a2c41c20a7ac82ec8439ad80b88b124f8f90f23c1525c42e9605", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/309193168d96317d505512f86247debcce1a2f6fd067f17e0070aebedbf2d98d36aec187a331bf31f3ac71aa984680d83161ac6fe9729ed80e8d9b4b195403df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d923cfa87921b6ea468e1c95bba02d5001f077f7e8dd106050f22cac6fd6e10ec3e0536c9a01f66710296e04baa42535ebf045c3ebcbda5dd7d5411859ca7e59"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:30.256641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:30.256989) ========= 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=0333a256a5e4f052382dd180000001b1-1490312830.238880-1748743966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:30.340667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 17:08:30.341061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 17:08:30.341563) ========= ========= Total master_lag: 0.57 =========