builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1490903876.19 results: success (0) revision: 8df9fabf2587b7020889755acb9e75b664fe13cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.190392) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.190876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.191181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.206404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.206743) ========= 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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-30 12:57:56-- 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% 228M=0s 2017-03-30 12:57:56 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.375859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.376190) ========= 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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020085 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.425831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:56.426178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8df9fabf2587b7020889755acb9e75b664fe13cf --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 8df9fabf2587b7020889755acb9e75b664fe13cf --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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-30 12:57:56,384 truncating revision to first 12 chars 2017-03-30 12:57:56,384 Setting DEBUG logging. 2017-03-30 12:57:56,384 attempt 1/10 2017-03-30 12:57:56,384 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8df9fabf2587?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 12:57:56,690 unpacking tar archive at: mozilla-central-8df9fabf2587/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641700 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:57.080848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:57.081190) ========= script_repo_revision: 8df9fabf2587b7020889755acb9e75b664fe13cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:57.081560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:57.081829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 12:57:57.091565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-03-30 12:57:57.091835) ========= /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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:57:57 INFO - MultiFileLogger online at 20170330 12:57:57 in /builds/slave/test 12:57:57 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 12:57:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:57:57 INFO - {'append_to_log': False, 12:57:57 INFO - 'base_work_dir': '/builds/slave/test', 12:57:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:57:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:57:57 INFO - 'branch': 'Firefox-Non-PGO', 12:57:57 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:57 INFO - 'config_files': ('talos/linux_config.py',), 12:57:57 INFO - 'default_actions': ('clobber', 12:57:57 INFO - 'read-buildbot-config', 12:57:57 INFO - 'download-and-extract', 12:57:57 INFO - 'populate-webroot', 12:57:57 INFO - 'create-virtualenv', 12:57:57 INFO - 'install', 12:57:57 INFO - 'run-tests'), 12:57:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:57 INFO - 'download_minidump_stackwalk': True, 12:57:57 INFO - 'download_symbols': 'ondemand', 12:57:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:57 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:57 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:57 INFO - 'gecko_profile': False, 12:57:57 INFO - 'gecko_profile_interval': 0, 12:57:57 INFO - 'installer_path': 'installer.exe', 12:57:57 INFO - 'log_level': 'info', 12:57:57 INFO - 'log_name': 'talos', 12:57:57 INFO - 'log_to_console': True, 12:57:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:57:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:57:57 INFO - 'opt_config_files': (), 12:57:57 INFO - 'pip_index': False, 12:57:57 INFO - 'suite': 'dromaeojs', 12:57:57 INFO - 'system_bits': '32', 12:57:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:57 INFO - 'title': 'talos-linux64-ix-015', 12:57:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:57 INFO - 'use_talos_json': True, 12:57:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:57:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:57 INFO - 'work_dir': 'build'} 12:57:57 INFO - [mozharness: 2017-03-30 19:57:57.215787Z] Running clobber step. 12:57:57 INFO - Running pre-action listener: _resource_record_pre_action 12:57:57 INFO - Running main action method: clobber 12:57:57 INFO - rmtree: /builds/slave/test/build 12:57:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:58 INFO - Running post-action listener: _resource_record_post_action 12:57:58 INFO - [mozharness: 2017-03-30 19:57:58.215727Z] Finished clobber step (success) 12:57:58 INFO - [mozharness: 2017-03-30 19:57:58.215826Z] Running read-buildbot-config step. 12:57:58 INFO - Running pre-action listener: _resource_record_pre_action 12:57:58 INFO - Running main action method: read_buildbot_config 12:57:58 INFO - Using buildbot properties: 12:57:58 INFO - { 12:57:58 INFO - "project": "", 12:57:58 INFO - "product": "firefox", 12:57:58 INFO - "who": "ryanvm@gmail.com", 12:57:58 INFO - "installer_path": "public/build/target.tar.bz2", 12:57:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:57:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:57:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:57:58 INFO - "stage_platform": "linux64", 12:57:58 INFO - "basedir": "/builds/slave/test", 12:57:58 INFO - "buildnumber": 906, 12:57:58 INFO - "platform": "ubuntu64_hw", 12:57:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:57:58 INFO - "slavebuilddir": "test", 12:57:58 INFO - "taskId": "aDVpoA7XTpuhUS7VwR_qJw", 12:57:58 INFO - "branch": "mozilla-central", 12:57:58 INFO - "script_repo_revision": "production", 12:57:58 INFO - "revision": "8df9fabf2587b7020889755acb9e75b664fe13cf", 12:57:58 INFO - "slavename": "talos-linux64-ix-015", 12:57:58 INFO - "repo_path": "mozilla-central" 12:57:58 INFO - } 12:57:58 INFO - Finding installer, test and symbols from parent task. 12:57:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aDVpoA7XTpuhUS7VwR_qJw'}, attempt #1 12:57:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aDVpoA7XTpuhUS7VwR_qJw'}, attempt #1 12:57:59 INFO - Task dependencies: OHYUZo6ZRJKukjfgIZUegQ 12:57:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ'}, attempt #1 12:57:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 12:57:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/test_packages.json 12:57:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.crashreporter-symbols.zip 12:57:59 INFO - Running post-action listener: _resource_record_post_action 12:57:59 INFO - [mozharness: 2017-03-30 19:57:59.681373Z] Finished read-buildbot-config step (success) 12:57:59 INFO - [mozharness: 2017-03-30 19:57:59.681592Z] Running download-and-extract step. 12:57:59 INFO - Running pre-action listener: _resource_record_pre_action 12:57:59 INFO - Running main action method: download_and_extract 12:57:59 INFO - mkdir: /builds/slave/test/build/tests 12:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:59 INFO - trying https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.test_packages.json 12:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:58:00 INFO - Downloaded 986 bytes. 12:58:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:58:00 INFO - Using the following test package requirements: 12:58:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:58:00 INFO - u'common': [u'target.common.tests.zip'], 12:58:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:58:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:58:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:58:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:58:00 INFO - u'mozbase': [u'target.common.tests.zip'], 12:58:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:58:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:58:00 INFO - u'web-platform': [u'target.common.tests.zip', 12:58:00 INFO - u'target.web-platform.tests.zip'], 12:58:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:58:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:58:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip 12:58:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:58:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip into memory 12:58:01 INFO - Expected file size: 58227757 12:58:01 INFO - Obtained file size: 58227757 12:58:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:58:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip 12:58:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:58:11 INFO - Fetch https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.common.tests.zip into memory 12:58:12 INFO - Expected file size: 58227757 12:58:12 INFO - Obtained file size: 58227757 12:58:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.talos.tests.zip 12:58:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:58:23 INFO - Fetch https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.talos.tests.zip into memory 12:58:24 INFO - Expected file size: 14404152 12:58:24 INFO - Obtained file size: 14404152 12:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:24 INFO - trying https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 12:58:24 INFO - Downloading https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:58:25 INFO - Downloaded 62531688 bytes. 12:58:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 12:58:25 INFO - mkdir: /builds/slave/test/properties 12:58:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:58:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:58:25 INFO - Contents: 12:58:25 INFO - build_url:https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 12:58:25 INFO - Running post-action listener: _resource_record_post_action 12:58:25 INFO - Running post-action listener: set_extra_try_arguments 12:58:25 INFO - [mozharness: 2017-03-30 19:58:25.747012Z] Finished download-and-extract step (success) 12:58:25 INFO - [mozharness: 2017-03-30 19:58:25.747109Z] Running populate-webroot step. 12:58:25 INFO - Running pre-action listener: _resource_record_pre_action 12:58:25 INFO - Running main action method: populate_webroot 12:58:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:25 INFO - '--tppagecycles', 12:58:25 INFO - '7'], 12:58:25 INFO - 'tests': ['tsvgm']}}, 12:58:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:58:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:58:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:58:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['damp', 'tps']}, 12:58:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'tests': ['damp', 'tps']}, 12:58:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['dromaeo_dom']}, 12:58:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['basic_compositor_video']}, 12:58:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:58:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'other-e10s': {'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['a11yr', 12:58:25 INFO - 'ts_paint', 12:58:25 INFO - 'tpaint', 12:58:25 INFO - 'sessionrestore', 12:58:25 INFO - 'sessionrestore_no_auto_restore', 12:58:25 INFO - 'tabpaint']}, 12:58:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['tsvgx', 12:58:25 INFO - 'tsvgr_opacity', 12:58:25 INFO - 'tart', 12:58:25 INFO - 'tscrollx', 12:58:25 INFO - 'cart', 12:58:25 INFO - 'tsvg_static']}, 12:58:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:58:25 INFO - 'tsvgr_opacity', 12:58:25 INFO - 'tart', 12:58:25 INFO - 'tscrollx', 12:58:25 INFO - 'cart', 12:58:25 INFO - 'tsvg_static']}, 12:58:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'talos_options': ['--disable-e10s'], 12:58:25 INFO - 'tests': ['tp5o']}, 12:58:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:58:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'talos_options': ['--disable-e10s', 12:58:25 INFO - '--xperf_path', 12:58:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:25 INFO - 'tests': ['tp5n']}, 12:58:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:58:25 INFO - 'talos_options': ['--xperf_path', 12:58:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:25 INFO - 'tests': ['tp5n']}}, 12:58:25 INFO - 'talos.zip': {'path': '', 12:58:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:25 INFO - Running post-action listener: _resource_record_post_action 12:58:25 INFO - [mozharness: 2017-03-30 19:58:25.760312Z] Finished populate-webroot step (success) 12:58:25 INFO - [mozharness: 2017-03-30 19:58:25.760402Z] Running create-virtualenv step. 12:58:25 INFO - Running pre-action listener: _resource_record_pre_action 12:58:25 INFO - Running main action method: create_virtualenv 12:58:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:58:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:58:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:58:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:25 INFO - Using real prefix '/usr' 12:58:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:58:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:29 INFO - Installing pip.................done. 12:58:29 INFO - Return code: 0 12:58:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:58:30 INFO - Reading from file tmpfile_stdout 12:58:30 INFO - Output received: 12:58:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:58:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 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 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:58:30 INFO - Using env: {'DISPLAY': ':0', 12:58:30 INFO - 'HOME': '/home/cltbld', 12:58:30 INFO - 'LANG': 'en_US.UTF-8', 12:58:30 INFO - 'LANGUAGE': 'en_US:en', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MAIL': '/var/mail/cltbld', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SHLVL': '1', 12:58:30 INFO - 'TERM': 'linux', 12:58:30 INFO - 'TMOUT': '86400', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - '_': '/tools/buildbot/bin/python'} 12:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:58:30 INFO - Cleaning up... 12:58:30 INFO - Return code: 0 12:58:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 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 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:58:30 INFO - Using env: {'DISPLAY': ':0', 12:58:30 INFO - 'HOME': '/home/cltbld', 12:58:30 INFO - 'LANG': 'en_US.UTF-8', 12:58:30 INFO - 'LANGUAGE': 'en_US:en', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MAIL': '/var/mail/cltbld', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SHLVL': '1', 12:58:30 INFO - 'TERM': 'linux', 12:58:30 INFO - 'TMOUT': '86400', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - '_': '/tools/buildbot/bin/python'} 12:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:31 INFO - Downloading/unpacking psutil>=3.1.1 12:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:33 INFO - Installing collected packages: psutil 12:58:33 INFO - Running setup.py install for psutil 12:58:33 INFO - building 'psutil._psutil_linux' extension 12:58:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:58:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:58:34 INFO - building 'psutil._psutil_posix' extension 12:58:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:58:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:58:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:34 INFO - Successfully installed psutil 12:58:34 INFO - Cleaning up... 12:58:35 INFO - Return code: 0 12:58:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:58:35 INFO - Using env: {'DISPLAY': ':0', 12:58:35 INFO - 'HOME': '/home/cltbld', 12:58:35 INFO - 'LANG': 'en_US.UTF-8', 12:58:35 INFO - 'LANGUAGE': 'en_US:en', 12:58:35 INFO - 'LOGNAME': 'cltbld', 12:58:35 INFO - 'MAIL': '/var/mail/cltbld', 12:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:35 INFO - 'MOZ_NO_REMOTE': '1', 12:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:35 INFO - 'NO_EM_RESTART': '1', 12:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:35 INFO - 'PWD': '/builds/slave/test', 12:58:35 INFO - 'SHELL': '/bin/bash', 12:58:35 INFO - 'SHLVL': '1', 12:58:35 INFO - 'TERM': 'linux', 12:58:35 INFO - 'TMOUT': '86400', 12:58:35 INFO - 'USER': 'cltbld', 12:58:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:35 INFO - '_': '/tools/buildbot/bin/python'} 12:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:58:37 INFO - Installing collected packages: mozsystemmonitor 12:58:37 INFO - Running setup.py install for mozsystemmonitor 12:58:37 INFO - Successfully installed mozsystemmonitor 12:58:37 INFO - Cleaning up... 12:58:37 INFO - Return code: 0 12:58:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:58:37 INFO - Using env: {'DISPLAY': ':0', 12:58:37 INFO - 'HOME': '/home/cltbld', 12:58:37 INFO - 'LANG': 'en_US.UTF-8', 12:58:37 INFO - 'LANGUAGE': 'en_US:en', 12:58:37 INFO - 'LOGNAME': 'cltbld', 12:58:37 INFO - 'MAIL': '/var/mail/cltbld', 12:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:37 INFO - 'MOZ_NO_REMOTE': '1', 12:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:37 INFO - 'NO_EM_RESTART': '1', 12:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:37 INFO - 'PWD': '/builds/slave/test', 12:58:37 INFO - 'SHELL': '/bin/bash', 12:58:37 INFO - 'SHLVL': '1', 12:58:37 INFO - 'TERM': 'linux', 12:58:37 INFO - 'TMOUT': '86400', 12:58:37 INFO - 'USER': 'cltbld', 12:58:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:37 INFO - '_': '/tools/buildbot/bin/python'} 12:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 12:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:58:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:39 INFO - Downloading functools32-3.2.3-2.tar.gz 12:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:58:39 INFO - warning: no files found matching '*.txt' 12:58:39 INFO - no previously-included directories found matching 'build' 12:58:39 INFO - no previously-included directories found matching 'dist' 12:58:39 INFO - no previously-included directories found matching '.git*' 12:58:40 INFO - Installing collected packages: jsonschema, functools32 12:58:40 INFO - Running setup.py install for functools32 12:58:40 INFO - warning: no files found matching '*.txt' 12:58:40 INFO - no previously-included directories found matching 'build' 12:58:40 INFO - no previously-included directories found matching 'dist' 12:58:40 INFO - no previously-included directories found matching '.git*' 12:58:40 INFO - Successfully installed jsonschema functools32 12:58:40 INFO - Cleaning up... 12:58:40 INFO - Return code: 0 12:58:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:58:40 INFO - Using env: {'DISPLAY': ':0', 12:58:40 INFO - 'HOME': '/home/cltbld', 12:58:40 INFO - 'LANG': 'en_US.UTF-8', 12:58:40 INFO - 'LANGUAGE': 'en_US:en', 12:58:40 INFO - 'LOGNAME': 'cltbld', 12:58:40 INFO - 'MAIL': '/var/mail/cltbld', 12:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:40 INFO - 'MOZ_NO_REMOTE': '1', 12:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:40 INFO - 'NO_EM_RESTART': '1', 12:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:40 INFO - 'PWD': '/builds/slave/test', 12:58:40 INFO - 'SHELL': '/bin/bash', 12:58:40 INFO - 'SHLVL': '1', 12:58:40 INFO - 'TERM': 'linux', 12:58:40 INFO - 'TMOUT': '86400', 12:58:40 INFO - 'USER': 'cltbld', 12:58:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:40 INFO - '_': '/tools/buildbot/bin/python'} 12:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:58:40 INFO - Cleaning up... 12:58:40 INFO - Return code: 0 12:58:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:58:40 INFO - Using env: {'DISPLAY': ':0', 12:58:40 INFO - 'HOME': '/home/cltbld', 12:58:40 INFO - 'LANG': 'en_US.UTF-8', 12:58:40 INFO - 'LANGUAGE': 'en_US:en', 12:58:40 INFO - 'LOGNAME': 'cltbld', 12:58:40 INFO - 'MAIL': '/var/mail/cltbld', 12:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:40 INFO - 'MOZ_NO_REMOTE': '1', 12:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:40 INFO - 'NO_EM_RESTART': '1', 12:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:40 INFO - 'PWD': '/builds/slave/test', 12:58:40 INFO - 'SHELL': '/bin/bash', 12:58:40 INFO - 'SHLVL': '1', 12:58:40 INFO - 'TERM': 'linux', 12:58:40 INFO - 'TMOUT': '86400', 12:58:40 INFO - 'USER': 'cltbld', 12:58:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:40 INFO - '_': '/tools/buildbot/bin/python'} 12:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:40 INFO - Downloading/unpacking blobuploader==1.2.4 12:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:42 INFO - Downloading blobuploader-1.2.4.tar.gz 12:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:58:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:58:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:43 INFO - Downloading docopt-0.6.1.tar.gz 12:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:58:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:58:43 INFO - Running setup.py install for blobuploader 12:58:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:58:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:58:43 INFO - Running setup.py install for requests 12:58:43 INFO - Running setup.py install for docopt 12:58:44 INFO - Successfully installed blobuploader requests docopt 12:58:44 INFO - Cleaning up... 12:58:44 INFO - Return code: 0 12:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:44 INFO - Using env: {'DISPLAY': ':0', 12:58:44 INFO - 'HOME': '/home/cltbld', 12:58:44 INFO - 'LANG': 'en_US.UTF-8', 12:58:44 INFO - 'LANGUAGE': 'en_US:en', 12:58:44 INFO - 'LOGNAME': 'cltbld', 12:58:44 INFO - 'MAIL': '/var/mail/cltbld', 12:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:44 INFO - 'MOZ_NO_REMOTE': '1', 12:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:44 INFO - 'NO_EM_RESTART': '1', 12:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:44 INFO - 'PWD': '/builds/slave/test', 12:58:44 INFO - 'SHELL': '/bin/bash', 12:58:44 INFO - 'SHLVL': '1', 12:58:44 INFO - 'TERM': 'linux', 12:58:44 INFO - 'TMOUT': '86400', 12:58:44 INFO - 'USER': 'cltbld', 12:58:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:44 INFO - '_': '/tools/buildbot/bin/python'} 12:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:44 INFO - Running setup.py (path:/tmp/pip-qNYdP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:44 INFO - Running setup.py (path:/tmp/pip-QwHOi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:44 INFO - Running setup.py (path:/tmp/pip-HTiIln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:44 INFO - Running setup.py (path:/tmp/pip-rT3YWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:44 INFO - Running setup.py (path:/tmp/pip-U70Swb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:44 INFO - Running setup.py (path:/tmp/pip-SknhH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:44 INFO - Running setup.py (path:/tmp/pip-1hUb4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:44 INFO - Running setup.py (path:/tmp/pip-oJPe0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:44 INFO - Running setup.py (path:/tmp/pip-f2MOe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:44 INFO - Running setup.py (path:/tmp/pip-f75pdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:45 INFO - Running setup.py (path:/tmp/pip-So8X6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:45 INFO - Running setup.py (path:/tmp/pip-_S9Fmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:45 INFO - Running setup.py (path:/tmp/pip-rUROgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:45 INFO - Running setup.py (path:/tmp/pip-nmcnR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:45 INFO - Running setup.py (path:/tmp/pip-Xkzzxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:45 INFO - Running setup.py (path:/tmp/pip-0nH6ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:45 INFO - Running setup.py (path:/tmp/pip-_23_5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:58:45 INFO - Running setup.py install for manifestparser 12:58:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:58:45 INFO - Running setup.py install for mozcrash 12:58:45 INFO - Running setup.py install for mozdebug 12:58:45 INFO - Running setup.py install for mozdevice 12:58:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:58:45 INFO - Running setup.py install for mozfile 12:58:46 INFO - Running setup.py install for mozhttpd 12:58:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for mozinfo 12:58:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for mozInstall 12:58:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for mozleak 12:58:46 INFO - Running setup.py install for mozlog 12:58:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for moznetwork 12:58:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for mozprocess 12:58:46 INFO - Running setup.py install for mozprofile 12:58:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:58:46 INFO - Running setup.py install for mozrunner 12:58:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:58:47 INFO - Running setup.py install for mozscreenshot 12:58:47 INFO - Running setup.py install for moztest 12:58:47 INFO - Running setup.py install for mozversion 12:58:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:58:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:58:47 INFO - Cleaning up... 12:58:47 INFO - Return code: 0 12:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:47 INFO - Using env: {'DISPLAY': ':0', 12:58:47 INFO - 'HOME': '/home/cltbld', 12:58:47 INFO - 'LANG': 'en_US.UTF-8', 12:58:47 INFO - 'LANGUAGE': 'en_US:en', 12:58:47 INFO - 'LOGNAME': 'cltbld', 12:58:47 INFO - 'MAIL': '/var/mail/cltbld', 12:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:47 INFO - 'MOZ_NO_REMOTE': '1', 12:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:47 INFO - 'NO_EM_RESTART': '1', 12:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:47 INFO - 'PWD': '/builds/slave/test', 12:58:47 INFO - 'SHELL': '/bin/bash', 12:58:47 INFO - 'SHLVL': '1', 12:58:47 INFO - 'TERM': 'linux', 12:58:47 INFO - 'TMOUT': '86400', 12:58:47 INFO - 'USER': 'cltbld', 12:58:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:47 INFO - '_': '/tools/buildbot/bin/python'} 12:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:47 INFO - Running setup.py (path:/tmp/pip-JELIHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:47 INFO - Running setup.py (path:/tmp/pip-DNtFLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:47 INFO - Running setup.py (path:/tmp/pip-5ZHRpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:47 INFO - Running setup.py (path:/tmp/pip-0NTDvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:47 INFO - Running setup.py (path:/tmp/pip-mhPe0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:47 INFO - Running setup.py (path:/tmp/pip-eJoguq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:48 INFO - Running setup.py (path:/tmp/pip-n2_5XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:48 INFO - Running setup.py (path:/tmp/pip-IbKF1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:48 INFO - Running setup.py (path:/tmp/pip-TVI_Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:48 INFO - Running setup.py (path:/tmp/pip-zmAXeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:48 INFO - Running setup.py (path:/tmp/pip-EQqKOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:48 INFO - Running setup.py (path:/tmp/pip-aNM7cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:48 INFO - Running setup.py (path:/tmp/pip-_GBWj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:48 INFO - Running setup.py (path:/tmp/pip-i672aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:48 INFO - Running setup.py (path:/tmp/pip-ziFK6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:48 INFO - Running setup.py (path:/tmp/pip-s4YU3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:48 INFO - Running setup.py (path:/tmp/pip-SMSKxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:58:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:50 INFO - Downloading blessings-1.6.tar.gz 12:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:58:50 INFO - Installing collected packages: blessings 12:58:50 INFO - Running setup.py install for blessings 12:58:51 INFO - Successfully installed blessings 12:58:51 INFO - Cleaning up... 12:58:51 INFO - Return code: 0 12:58:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:58:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:51 INFO - Reading from file tmpfile_stdout 12:58:51 INFO - Current package versions: 12:58:51 INFO - argparse == 1.2.1 12:58:51 INFO - blessings == 1.6 12:58:51 INFO - blobuploader == 1.2.4 12:58:51 INFO - docopt == 0.6.1 12:58:51 INFO - functools32 == 3.2.3-2 12:58:51 INFO - jsonschema == 2.5.1 12:58:51 INFO - manifestparser == 1.1 12:58:51 INFO - mozInstall == 1.12 12:58:51 INFO - mozcrash == 1.0 12:58:51 INFO - mozdebug == 0.1 12:58:51 INFO - mozdevice == 0.49 12:58:51 INFO - mozfile == 1.2 12:58:51 INFO - mozhttpd == 0.7 12:58:51 INFO - mozinfo == 0.9 12:58:51 INFO - mozleak == 0.1 12:58:51 INFO - mozlog == 3.4 12:58:51 INFO - moznetwork == 0.27 12:58:51 INFO - mozprocess == 0.25 12:58:51 INFO - mozprofile == 0.28 12:58:51 INFO - mozrunner == 6.13 12:58:51 INFO - mozscreenshot == 0.1 12:58:51 INFO - mozsystemmonitor == 0.3 12:58:51 INFO - moztest == 0.8 12:58:51 INFO - mozversion == 1.4 12:58:51 INFO - psutil == 3.1.1 12:58:51 INFO - requests == 1.2.3 12:58:51 INFO - wsgiref == 0.1.2 12:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:51 INFO - Using env: {'DISPLAY': ':0', 12:58:51 INFO - 'HOME': '/home/cltbld', 12:58:51 INFO - 'LANG': 'en_US.UTF-8', 12:58:51 INFO - 'LANGUAGE': 'en_US:en', 12:58:51 INFO - 'LOGNAME': 'cltbld', 12:58:51 INFO - 'MAIL': '/var/mail/cltbld', 12:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:51 INFO - 'MOZ_NO_REMOTE': '1', 12:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:51 INFO - 'NO_EM_RESTART': '1', 12:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:51 INFO - 'PWD': '/builds/slave/test', 12:58:51 INFO - 'SHELL': '/bin/bash', 12:58:51 INFO - 'SHLVL': '1', 12:58:51 INFO - 'TERM': 'linux', 12:58:51 INFO - 'TMOUT': '86400', 12:58:51 INFO - 'USER': 'cltbld', 12:58:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:51 INFO - '_': '/tools/buildbot/bin/python'} 12:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:58:51 INFO - Cleaning up... 12:58:51 INFO - Return code: 0 12:58:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, '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': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:58:51 INFO - Using env: {'DISPLAY': ':0', 12:58:51 INFO - 'HOME': '/home/cltbld', 12:58:51 INFO - 'LANG': 'en_US.UTF-8', 12:58:51 INFO - 'LANGUAGE': 'en_US:en', 12:58:51 INFO - 'LOGNAME': 'cltbld', 12:58:51 INFO - 'MAIL': '/var/mail/cltbld', 12:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:51 INFO - 'MOZ_NO_REMOTE': '1', 12:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:51 INFO - 'NO_EM_RESTART': '1', 12:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:51 INFO - 'PWD': '/builds/slave/test', 12:58:51 INFO - 'SHELL': '/bin/bash', 12:58:51 INFO - 'SHLVL': '1', 12:58:51 INFO - 'TERM': 'linux', 12:58:51 INFO - 'TMOUT': '86400', 12:58:51 INFO - 'USER': 'cltbld', 12:58:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:51 INFO - '_': '/tools/buildbot/bin/python'} 12:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:58:51 INFO - Cleaning up... 12:58:51 INFO - Return code: 0 12:58:51 INFO - Running post-action listener: _resource_record_post_action 12:58:51 INFO - Running post-action listener: _start_resource_monitoring 12:58:51 INFO - Starting resource monitoring. 12:58:51 INFO - [mozharness: 2017-03-30 19:58:51.854601Z] Finished create-virtualenv step (success) 12:58:51 INFO - [mozharness: 2017-03-30 19:58:51.855536Z] Running install step. 12:58:51 INFO - Running pre-action listener: _resource_record_pre_action 12:58:51 INFO - Running main action method: install 12:58:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:52 INFO - Reading from file tmpfile_stdout 12:58:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:58:52 INFO - Reading from file tmpfile_stdout 12:58:52 INFO - Output received: 12:58:52 INFO - Usage: mozinstall [options] installer 12:58:52 INFO - Options: 12:58:52 INFO - -h, --help show this help message and exit 12:58:52 INFO - -d DEST, --destination=DEST 12:58:52 INFO - Directory to install application into. [default: 12:58:52 INFO - "/builds/slave/test"] 12:58:52 INFO - --app=APP Application being installed. [default: firefox] 12:58:52 INFO - mkdir: /builds/slave/test/build/application 12:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:59:07 INFO - Reading from file tmpfile_stdout 12:59:07 INFO - Output received: 12:59:07 INFO - /builds/slave/test/build/application/firefox/firefox 12:59:07 INFO - Running post-action listener: _resource_record_post_action 12:59:07 INFO - [mozharness: 2017-03-30 19:59:07.835023Z] Finished install step (success) 12:59:07 INFO - [mozharness: 2017-03-30 19:59:07.835169Z] Running run-tests step. 12:59:07 INFO - Running pre-action listener: _resource_record_pre_action 12:59:07 INFO - Running main action method: run_tests 12:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:59:07 INFO - Python 2.7.3 12:59:07 INFO - Return code: 0 12:59:07 INFO - grabbing minidump binary from tooltool 12:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:07 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 0x287c290>, '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 0x287cb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287d040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:59:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:59:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:59:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:59:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:07 INFO - Return code: 0 12:59:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:59:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:59:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:59:07 INFO - ENV: RUST_BACKTRACE is now 1 12:59:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:59:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:59:07 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/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:59:07 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/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:59:07 INFO - Using env: {'DISPLAY': ':0', 12:59:07 INFO - 'HOME': '/home/cltbld', 12:59:07 INFO - 'LANG': 'en_US.UTF-8', 12:59:07 INFO - 'LANGUAGE': 'en_US:en', 12:59:07 INFO - 'LOGNAME': 'cltbld', 12:59:07 INFO - 'MAIL': '/var/mail/cltbld', 12:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:07 INFO - 'MOZ_NO_REMOTE': '1', 12:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:07 INFO - 'NO_EM_RESTART': '1', 12:59:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:07 INFO - 'PWD': '/builds/slave/test', 12:59:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:59:07 INFO - 'RUST_BACKTRACE': '1', 12:59:07 INFO - 'SHELL': '/bin/bash', 12:59:07 INFO - 'SHLVL': '1', 12:59:07 INFO - 'TERM': 'linux', 12:59:07 INFO - 'TMOUT': '86400', 12:59:07 INFO - 'USER': 'cltbld', 12:59:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816', 12:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:07 INFO - '_': '/tools/buildbot/bin/python'} 12:59:07 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/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:59:08 INFO - mozversion application_buildid: 20170330192027 12:59:08 INFO - mozversion application_changeset: 8df9fabf2587b7020889755acb9e75b664fe13cf 12:59:08 INFO - mozversion application_display_name: Nightly 12:59:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:08 INFO - mozversion application_name: Firefox 12:59:08 INFO - mozversion application_remotingname: firefox 12:59:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:59:08 INFO - mozversion application_vendor: Mozilla 12:59:08 INFO - mozversion application_version: 55.0a1 12:59:08 INFO - mozversion platform_buildid: 20170330192027 12:59:08 INFO - mozversion platform_changeset: 8df9fabf2587b7020889755acb9e75b664fe13cf 12:59:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:59:08 INFO - mozversion platform_version: 55.0a1 12:59:08 INFO - using testdate: 1490903948 12:59:08 INFO - actual date: 1490903948 12:59:08 INFO - starting webserver on 'localhost:52161' 12:59:08 INFO - SUITE-START | Running 2 tests 12:59:08 INFO - TEST-START | dromaeo_css 12:59:08 INFO - operating with platform_type : linux_ 12:59:08 INFO - Initialising browser for dromaeo_css test... 12:59:08 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVtkNi/profile http://localhost:52161/getInfo.html) 12:59:13 INFO - PID 3312 | __metrics Screen width/height:1600/1200 12:59:13 INFO - PID 3312 | colorDepth:24 12:59:13 INFO - PID 3312 | Browser inner width/height: 1024/697 12:59:13 INFO - PID 3312 | __metrics 12:59:14 ERROR - PID 3312 | 1490903954429 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 12:59:14 INFO - PID 3312 | 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" 12:59:14 INFO - PID 3312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:15 INFO - TEST-INFO | 3312: exit 0 12:59:15 INFO - Browser initialized. 12:59:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:15 INFO - TEST-INFO | started process 3405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVtkNi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:27 INFO - PID 3405 | RSS: Main: 149663744 12:59:27 INFO - PID 3405 | 13:02:33 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52161/tests/dromaeo/cssquery-ext.html) 13:02:36 INFO - PID 3405 | RSS: Main: 364027904 13:02:36 INFO - PID 3405 | 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | A coding exception was thrown and uncaught in a Task. 13:04:17 INFO - PID 3405 | 13:04:17 ERROR - PID 3405 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:17 INFO - PID 3405 | Full stack: 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | A coding exception was thrown and uncaught in a Task. 13:04:17 INFO - PID 3405 | 13:04:17 ERROR - PID 3405 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:17 INFO - PID 3405 | Full stack: 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | A coding exception was thrown and uncaught in a Task. 13:04:17 INFO - PID 3405 | 13:04:17 ERROR - PID 3405 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:17 INFO - PID 3405 | Full stack: 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | ************************* 13:04:17 INFO - PID 3405 | A coding exception was thrown and uncaught in a Task. 13:04:17 INFO - PID 3405 | 13:04:17 ERROR - PID 3405 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:17 INFO - PID 3405 | Full stack: 13:04:17 INFO - PID 3405 | ************************* 13:05:39 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-ext.html (next: http://localhost:52161/tests/dromaeo/cssquery-jquery.html) 13:05:39 INFO - PID 3405 | RSS: Main: 237993984 13:05:39 INFO - PID 3405 | 13:08:42 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52161/tests/dromaeo/cssquery-mootools.html) 13:08:42 INFO - PID 3405 | RSS: Main: 241954816 13:08:42 INFO - PID 3405 | 13:11:44 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52161/tests/dromaeo/cssquery-prototype.html) 13:11:45 INFO - PID 3405 | RSS: Main: 238985216 13:11:45 INFO - PID 3405 | 13:14:49 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52161/tests/dromaeo/cssquery-yui.html) 13:14:49 INFO - PID 3405 | RSS: Main: 186449920 13:14:49 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | Cycle 1(1): loaded http://localhost:52161/tests/dromaeo/cssquery-yui.html (next: http://localhost:52161/tests/dromaeo/cssquery-dojo.html) 13:17:52 INFO - PID 3405 | RSS: Main: 274587648 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | __start_tp_report 13:17:52 INFO - PID 3405 | _x_x_mozilla_page_load 13:17:52 INFO - PID 3405 | _x_x_mozilla_page_load_details 13:17:52 INFO - PID 3405 | |i|pagename|runs| 13:17:52 INFO - PID 3405 | |0;dojo.html;2681.5843544250642;2717.7961652876015;2753.187809596169;2753.352962053917;2755.311172206949;5033.54698077173;5125.718085505296;5187.6887386756825;5216.5565926896215;5262.842114736554;5133.743312834362;5202.92195617066;5203.4796520347945;5226.55574276187;5261.842144735654;4513.887152821173;4767.594754445876;4876.609871210295;4924.926126108094;4929.8028078876805;4833;4859.684120532172;4871.829485967992;4881.8779530511665;4904.730239836807;4695.741734204617;4755.381800365965;4759.50025247351;4803.543663351976;4805.231163013936;4736.692115012547;4744.430668319789;4751.786169622375;4752.667313288071;4753.120672675532;4702.106599746037;4712.5994290485005;4717.127331443659;4721.716696998157;4722.574968252839;5106.897862042775;5124.359455068116;5209.973950130263;5235.3717553893775;5241.79032838686;5571.331440227158;5580.107182850765;5580.358258800249;5588.441155884379;5622.8313150605545;5600.635958662674;5660.971695141539;5675.914861277043;5678.176664383641;5679.545636349082;5016.498350164954;5073.949260507421;5106.719130447861;5108.412532558803;5123.180291153398;5609.1305847593685;5662.915056274159;5677.489025987681;5677.914831277534;5682.829515114553;5419.972900135474;5423.620346575702;5452.372977107604;5539.944600553943;5540.36285827135;5573.916391254134;5582.413846546055;5584.664920104807;5586.16207568868;5634.915476267859;5515.944840551623;5516.531094856982;5525.889482210414;5527.364353099365;5531.225628412026;5379.435159308295;5388.299521062237;5441.700706461103;5468.343798744176;5569.275994120739;4673.883152921204;4679.99380133273;4690.671652984258;4722.952770472251;4725.905481890343;4010.7393019453643;4016.2770701274053;4023.3964905264443;4026.3960405938756;4055.0673345130785;4681.110588988081;4753.809847606126;4794.304825800239;4801.039792041536;4840.249761287007;5583.469570390806;5607.074832652648;5668.461496157858;5682.460166284196;5691.8861622768145;4763.618910487153;4768.070226305837;4768.57082862544;4770.76146192689;4810.302506136661;4974.925376119361;4984.451710311862;4990.051890140789;4994.32576602154;5011.523905228997;5159.664621799571;5217.0870097733505;5246.842594722164;5247.55395791362;5304.389995150453;5446;5567.5545956322585;5620.8875822482505;5659.660420374791;5682.659040457585;5180.507851754077;5234.345706786652;5243.68537887728;5248.8425347239645;5249.842504724865;5450.291462109901;5506.752196151263;5507.586930980113;5509.256250406143;5509.47659972302;5551.861203469945;5580.665160090408;5587.497125258747;5588.022096133079;5588.916166257591;5415.404305526467;5421.159720243369;5422.105352616774;5424.7558859850615;5425.647332923348;5363.758630861543;5365.812196573102;5370.113931201308;5397.8380648580605;5415.187721841755;5253.317068781187;5370.865728356823;5380.892382152413;5388.353397592157;5391.649542779707;5379.67721936685;5380.112281473513;5390.353157621111;5428.321459817523;5466.1527463243265;5359.464053594609;5359.758810853443;5363.731813409392;5377.784888604412;5401.4868587484125 13:17:52 INFO - PID 3405 | |1;ext.html;663.0485253660997;680.8570200257947;1040.3965699894063;1062.9521671524785;1064.1433645915035;32355.83822080889;33404.66595334049;33650.32699346012;33717.325653486914;33722.8313858431;35901.2819743605;36376.45435318466;36400.45399319006;36430;36473.63526364735;5658.179563963223;7499.812504687399;7651.349635281008;7659.387249020093;7660.885086723703;5759.4816466518005;7262;7437.293457121565;7439.516431431966;7452.329290363866;7519.962400187991;7547.05661792276;7551.848963020736;7571;7585.886211706828;7492.925070749277;7549.962250188769;7559.168491465907;7561.470697051209;7563.319301262913;7442.702291908317;7509.962450187769;7510.586917719524;7513.586752728598;7514.511556748794;33797.6620233797;33870.49194262088;33924.321513569594;34014.1496462588;34046.6595334046;2717.904873329444;2724.9046283380185;2726.2230264374557;2737.534619114755;2787.6376071110626;23020.76979230203;23148.65277020846;23344.64983025256;23564.882175589184;23568.410789730224;2778.833270003786;2852.9001484948135;2863.1696807925678;2881.4813333599946;2892.219100842761;150953.2452337742;152225;152940;152961.23519382442;153159;34431.48352774711;35034.29931401409;41644.583554164674;41837.37243941343;41955.7902210487;42482;43310;43417.78291108524;43476.3478547822;43503.78248108739;11412.714682133013;11526.250793698382;11528.077753779677;11534.596289130008;11535.192536522363;9002.909970900208;9006.054364291786;9007.864882026775;9011.23404510624;9028.052054534312;12687.429065692066;12740.55408060732;12744.745105097845;12815.551455699006;12846.779555942358;5165.535101840853;5210.426853046162;5213.2701421800975;5254.106801843695;5261.210818377274;863.447393668053;873.6767396063498;879.1735768377705;879.2394578689515;906.4833045164324;20211.696824547642;20680.379588612366;20792.89603552003;21101.261455848973;21109.155633774477;946.6118891254553;953.547065144051;960.9663661771805;968.3463662028103;968.7432830299977;10713.83929241062;10831.83752243717;10885.510152043176;10909.563617455213;10928.344299342065;204750;205342;205721;206122;206446;40151.59848401537;40222.396664050066;40272.395914061315;40280;40325.19349612991;1195.2410219510673;1227.6930767308172;1231.1135982092878;1233.0567116156326;1243.7139457924727;19458.902705486384;19659.803401965797;19922.90038549856;20164.495887602927;20375.083121259282;30654.846725766227;30725.692743072283;30774;30800.229994250323;30855.537166942064;208908;209468;209781;209885;209956;28614.57078143788;28938.710612893603;29172.416551669274;29597.5560366599;29607.85196074006;34046.48930266098;34448.82775586106;34482.482762758074;34595.48106778451;35338.46992295169;26543.601845971938;27064.458710825278;27094.864525677247;27586.72413275922;27854.582181267702;25604.487910241318;25860.612090818275;26207.34481637898;26667.466650667266;26751.331216719736;29764.702352976194;29854.402911941204;29899.402011960075;30167.245818854703;30288;25184.370390739645;25187;25311.240662780147;25584.744152558236;25847.483050339262;20425;21718.782812172307;21781.673274901204;21833.781662183173;21956.560868782854 13:17:52 INFO - PID 3405 | |2;jquery.html;385.4334128830618;411.78452438887433;432.6149726743197;436.37816112040343;439.7273690312007;14952.551423457286;18584.442466726003;19110.52223694408;19233.32683356083;19356.22575096998;17383.217755201014;17507.212175452103;17639.29442822289;17997.7300340495;18106.5473363166;5570.721463926808;5797.130430435426;5801.709914504279;5804.216430781854;5806.390329015456;3483.303339332131;3659.2864391443677;4925;6027.72875220614;6557.737690492375;6570.671466426659;6598.571092878948;6606.240282367541;6606.7026983785845;6609.074729537869;6332;6487.059376390421;6505.154329937078;6515.153030106103;6528.08606795049;6141.232345956755;6319.873602527924;6358.554901156921;6370.840728981766;6427.260865000538;23713.881430592737;23741.05035798566;24086.518269634686;24216.757832421627;24379.512409751882;1579.6761663858997;1584.7305957987055;1589.8569128778465;1605.1733357320988;1637.7461493468531;14074.507392241325;15086.773698394532;15192.316345764357;15428.534289242616;15565.844341556665;1733.7919449665994;1844.0779610194902;1857.8513718902454;1864.6643604151247;1879.229515898475;85403.57298213469;87900.12099879047;89456.552717236;90128.54935725345;92124.53937730269;14818.294017418608;17571;18144.364947226783;18390.63218735618;18560.721589176173;32115.839420802746;32295.51556726651;32614.67385326164;32641.34717305688;32751.18122046968;8332.16678332174;8695.173958473935;8751.808378946735;8798.648054077765;8908.821823563492;6844.4182244508775;6877.9656101720175;7042.6830792614455;7100.822479438056;7103.325184107502;9358.204552613104;9490.145886870216;9555.331126821056;9567.273327101742;9622.663206787729;3422.9144271393416;3860.343741563941;3862.787546684903;3864.381698928158;3881.3983832506005;831.4387788242911;847.7160151349367;857.0829212742306;863.7192912303526;889.9243564297108;16274.186290685418;16365.099919504304;16941.491755247363;17293.481195564153;17344;821.0393839208141;854.6837670062117;863.4732812984074;873.9475631462005;881.1584936385736;10349.9482502587;11577.277684147946;11596.536138554533;11729.589464368877;11738.882611173949;457639;465590;466293;467527;476621;89160;92582.53708731414;92667;92670;93057;1021.7139201023874;1063.5214153630743;1076.1498416251231;1102.1458369763498;1103.933763974164;16009;16550.66898662044;17154.571135721708;17365.913170434065;17555.12224388801;43578.38529688229;43869.34195986999;44088.338674920546;44650.330245047;44846.10307793761;54011.45988540064;54765.178522322996;54766.45233547773;54902.90194196014;55606;7922;8195.83608327842;8280.50316980983;8610.65557377698;8678.175573320525;12514.436850341574;12772.297523636289;12878.356082195665;13076.215427074407;13078.346082695636;10590.8940910593;10808.621698240524;10818.783624327627;10922.672319830417;10931.125509959344;10008.39949603026;10138.290319677551;10186.643467478603;10211.591536338463;10402.47987600632;10522.789544209227;10773.353598784099;10785.568577256821;10855.78288434211;11154;8009.679612815655;8098.149694282251;8204.63079161451;8231.300339471212;8255.752327429946;11089.611863584736;11125.499352529318;11128.777424451628;11230.101591872794;11513.827292590786 13:17:52 INFO - PID 3405 | |3;mootools.html;1204.825300331452;1295.6307452376075;1300.1419063418145;1305.8955283577316;1312.0815429199563;9288.164065234128;9690.563924623391;9699;9702.078302561264;9706.126448619623;9541.522923853814;9869.111779939803;9940.453275069869;9947.204223662107;9965.103140717334;2163.6646319820416;2200.0869639099756;2206.5145667953025;2207.459172502739;2209.5249521352907;1848.3900312896712;1910.5796724720608;2136.6260904341757;2187.1579441914896;2223.722034745657;2118.438613767345;2201.7027701260363;2202.8458007939453;2202.8458007939453;2204.7574766775724;2126.4683829042738;2161.9243326483574;2169.5227050048966;2174.0542863854193;2192.0464597899804;2168.479564904427;2174.9891250543806;2177.401214665964;2177.6842357858022;2181.6182168120517;9601.423914565148;9682.177014953737;9684.467354295512;9695.563699633534;9702.175315098226;5329;5518.19986102017;5531.3362396512275;5533;5533.944660553383;3112.9066128016198;3149.370125974814;3348.5479460272795;3391.186115332327;3407.1993081625797;971.9222462203007;979.0063085967678;1000.404759168301;1080.1412876762913;1092.633967620848;14556.927215363856;14745.189014604193;14935.701285974219;14947.850521494755;14960.476383326532;4749.498397867847;4875.878103047452;4947.5794557462295;4996.300517927493;5039.370078740158;10891.292066015683;10900.618478353379;10903.073238774634;10920.617778377718;10923.781524369468;5503.642263252876;5507.0637991541535;5512.173174023928;5514.338279406497;5518.227448157261;4785.760711964388;4791.808327666854;5010.073136469765;5038.546530812245;5057.31726216956;3690.1881586051563;3738.9439158412647;3779.829907654162;3841.519810023747;3865.7873816939777;1005.8290090684601;1152.2510368260698;1156.6183159557327;1163.1567113842395;1173.12015988009;597.4831770518471;684.8219462939572;708.6315116139579;719.9748008819666;741.9130973124398;5210.452902445189;5408.432114627986;5410.621256512085;5466.945330546644;5605.355384130796;800.771780042685;817.9345652347798;834.9980023971137;843.5992903370973;846.3779122345195;3336.8998930031653;3453.2920751245933;3937.114149316438;4144.046869220097;4164.104717485755;12679.112462127747;13133.540326088732;13133.60599182026;13140.737185256241;13154.276514791587;12466.937665311616;12986.675333116747;13046;13050.216986980811;13074.477020919057;9227.630894764268;9311.161995420445;9352.205062569758;9375.249980001583;9392.62429502826;6091.390860913873;6440.806775796734;6455.935440645533;6457.128287681103;6656.167979002625;11219.775604488028;11701.2979221247;11728.950472877284;11805.881941180478;11897.226680265756;11526;11549.711257218636;11572.537098515964;11668.824967625322;11694.4737486815;8092.514449133071;8342.83314333722;8366.456180348257;8379.622916968872;8387.748367548984;9048.864267035868;9049.638014479611;9151.816963660822;9155.587998539948;9205.217556507772;7477.588732619758;7549.584772837547;7595.620218988918;7708.691652333844;7886;7147.928520714726;7175.569465832067;7183.066201393785;7212.71149154028;7291.4166866649475;7178.318059784312;7184.712611495691;7200.855982880418;7224.060872086595;7237.565746055254;5132.902853216937;5263.367877198076;5291.708956007456;5411.648242864201;5447;5012.699238045729;5081.949180508148;5129.717865517283;5137.2037334213255;5181.740912954413 13:17:52 INFO - PID 3405 | |4;prototype.html;373.7234446509582;393.5081148564295;399.1537939568116;399.44078290393446;400.05786373091377;5354.812581559646;5359.89280214396;5391.865203369918;5403.7027963462;5406.459354064592;5042.268871013701;5184.7148406837605;5219.45195754446;5231.5814734821215;5293.311869456965;4127.958720412803;4128.855490057848;4133.0700592366775;4135.503739551243;4138.855140070098;4070.328395814687;4113.650339721127;4135.937960930589;4138.793060346986;4153.190127925056;3948.684105271586;4048.3725022621543;4071.1043570414463;4076.1440097579543;4084.7140700151003;4063.085805693725;4073.531543872463;4074.5331680594963;4076.857309994136;4082.4896887888867;3571.2143328467696;3585.713142948558;3592.317459682678;3592.8203589820405;3595.442706380515;4993.575546078588;5094.821681241176;5115;5130.692158470503;5134.897302053975;4647.883802904955;4663.60359369454;4677;4685.484596694361;4703.553162449562;5466.890662186774;5472.425395333473;5491.7254137292975;5492.752826122794;5493;3898.3567711327596;3907.2380885727293;3908.8241029153755;3915.9818447203934;3924.2151569685893;5535.335759708821;5580.242223699522;5639.574982757372;5675.602707810413;5847.649141051551;3983.721139520264;3994.2410941920944;4000.8599699010397;4012.257732319472;4018.1361007383553;4037.576054514234;4052.65552428041;4053.2096241233266;4058.0869304406865;4068.044009657728;4370.759608221515;4400.44994375703;4496.775161241925;4630.907381852344;4647.604953578983;5564.221009058735;5585;5588.91616625751;5591.7483713233005;5595.580331475156;1401.159304417362;1404.39610967283;1405;1408.7178770391827;1415.0377743134768;898.6315610599622;949.5489642419933;958.3387462650749;967.385710074108;967.7435479597913;4860.392450943632;4864;4868.756562171877;4878.317035615017;4899.58353539946;5712.143178523172;5713.514351280104;5723.828285151452;5733.082706766897;5746.655200687972;4669.369635099286;4873.537013983666;4882.316475693406;4884.609231261491;4897.755112244374;3035.969640303613;3045.1016949999803;3053.92365190872;3064.5249986252165;3073.7244043722053;5392.948375066902;5393;5393.5954803389905;5405.108157154104;5411.997560902491;5592.245046918695;5819.301683797887;5863.941360586425;5889.116632505158;5911.142884281755;5335.86660333487;5341.919871201935;5355.036093503207;5389.9191512127345;5439.5648348132845;5474.397816240131;5790.507806836466;5809;5811.79658711943;5827.5629327801435;5631.831045068655;5651.660900345993;5667.234923285304;5669.574781891292;5670.999999999835;5141.434442211428;5181.35233095863;5265;5363;5381.354237491526;4309.017851788212;4366.737995720267;4369.541198174273;4371.213181627338;4372.825086996484;5717.342505611908;5722.771089156554;5728.971355143198;5737.340205876378;5738.368779434176;5291.7618707159045;5523.613347065828;5531.502164805187;5553.111502159635;5553.334399488187;5495.873345964148;5520.309961254843;5530.308711411074;5533.253010843485;5536;5283.471652834686;5421.728913554385;5424.430434804446;5462.453754624506;5473.726313684379;5529.668219906818;5542.972285138549;5557.749901254372;5579.46995035471;5587.972060139673;5416.835380393077;5429.53848922846;5451.918221226605;5456;5456.809011684572 13:17:52 INFO - PID 3405 | |5;yui.html;621.4996927473385;636.2110982381846;639.4277121975829;649.0685865782602;660.2143449295338;12827.807582886253;13464.394102265396;14084.154950702965;15063;15063.77404338933;14903.92548037261;14920;14936.701265974674;15234.619134521643;15535.611609709764;922.557172557173;944.2021491839384;946.6450081219542;946.7822400847809;947.2564037230775;882.7528292078229;911.4531281231241;919.7884486568094;945.5319616789699;948.3172116076448;979.045430705064;981.9705408837747;982.1455333859517;982.6609819612222;982.7248370456284;973.9026097390275;975.11264749078;976.0824824664793;976.2287792643839;976.272676855747;721.9711211551531;722.3138018882083;722.8915662650592;723.1647447198494;723.8914162875558;13182.472701091945;13238.27189504577;13279.66800829987;13563.660908477268;14858.331375088146;12983.415746291439;13016.609501714964;13744.931275343659;13836.308184590831;13957.380674855838;9613.807723845553;9642.951785241099;9691.806163876683;9909.851352229722;10194.541245643964;2484.354067942348;2493.5386953413677;2519.848809071462;2525.6590360301307;2566.8844901979455;66099.33900660979;66200;66686.99999999952;67378.32621673819;67379.66310168417;10318.43248621318;10569.947150264354;10809.83785243222;10826.133909287239;11055.170862185369;19617.901910490356;20218.797812021985;20253.898730506255;20299.695504567444;20315.492112697004;6169.167162433104;6177.598456100339;6189.876202476015;6196.349383314777;6478.222613286342;3035.256362191233;3045.634523857151;3140.230643492359;3182.3158021025592;3203.7917535360125;3493.9650603494147;3538.469229615578;3562.821858907096;3564.6613571710645;3571.285742851388;644.5101722690695;647.9352064793577;648.9253735820347;656.6027553330262;663.9634820084942;481.2396413666399;494.35980405375125;497.2019908047604;502.65568085861304;510.68082448469704;7650.464467487333;7756.689732410753;7855.096663883726;7928.920710792933;7932.603369831485;484.3171128708504;488.6701476503346;496.2853490972987;501.04800878331463;505.9241113832881;3528.153243221608;3648.1609229877276;3652.7625704329134;3688.3360995021153;3825.311443940062;61919;62307.37692623107;62596;65304.34695652983;65871;54930;54988.72505637446;55202.72398638062;55521.72239138778;57835.42164578385;49787.502124979736;50160.74919625378;50378.74810625997;50716;51296.74351628218;7350.742724004848;7357.889631655423;7425.591592462466;7461.141968673672;7556.546607203585;26866.59700104539;26967.865160674857;27376.589351160146;27622.72377276282;27707;32222;32790.83604581962;32843.59976636556;33079.83460082684;33336.1665958353;8784;8799.12008799115;8815.250703690259;8888.200061994452;8888.511131887808;9012.774680633036;9036.79086640407;9258.444493330422;9298.72103836886;9401.10689484498;9073.274138068806;9223.354365194373;9529.14237718581;9775.413475191512;9845.310828241954;8869.423487473294;9020.774480638036;9168.679096231599;9200.26397888154;9579.042095790644;8625.741158242912;8942.597583108645;8954.776130596527;9053.909460905306;9056.746519603008;7256.310650488195;7361.484696071224;7507.662155203138;7510.420086145871;7521.962390188233;6935.514513983972;7332;7601.809954751176;7696.538207707556;7787.532748035136 13:17:52 INFO - PID 3405 | __end_tp_report 13:17:52 INFO - PID 3405 | __start_cc_report 13:17:52 INFO - PID 3405 | _x_x_mozilla_cycle_collect,2709 13:17:52 INFO - PID 3405 | __end_cc_report 13:17:52 INFO - PID 3405 | __startTimestamp1490905072716__endTimestamp 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | ------- Summary: start ------- 13:17:52 INFO - PID 3405 | Number of tests: 6 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#0] dojo.html Cycles:165 Average:5127.77 Median:5253.32 stddev:570.51 (10.9%) stddev-sans-first:539.02 13:17:52 INFO - PID 3405 | Values: 2681.6 2717.8 2753.2 2753.4 2755.3 5033.5 5125.7 5187.7 5216.6 5262.8 5133.7 5202.9 5203.5 5226.6 5261.8 4513.9 4767.6 4876.6 4924.9 4929.8 4833.0 4859.7 4871.8 4881.9 4904.7 4695.7 4755.4 4759.5 4803.5 4805.2 4736.7 4744.4 4751.8 4752.7 4753.1 4702.1 4712.6 4717.1 4721.7 4722.6 5106.9 5124.4 5210.0 5235.4 5241.8 5571.3 5580.1 5580.4 5588.4 5622.8 5600.6 5661.0 5675.9 5678.2 5679.5 5016.5 5073.9 5106.7 5108.4 5123.2 5609.1 5662.9 5677.5 5677.9 5682.8 5420.0 5423.6 5452.4 5539.9 5540.4 5573.9 5582.4 5584.7 5586.2 5634.9 5515.9 5516.5 5525.9 5527.4 5531.2 5379.4 5388.3 5441.7 5468.3 5569.3 4673.9 4680.0 4690.7 4723.0 4725.9 4010.7 4016.3 4023.4 4026.4 4055.1 4681.1 4753.8 4794.3 4801.0 4840.2 5583.5 5607.1 5668.5 5682.5 5691.9 4763.6 4768.1 4768.6 4770.8 4810.3 4974.9 4984.5 4990.1 4994.3 5011.5 5159.7 5217.1 5246.8 5247.6 5304.4 5446.0 5567.6 5620.9 5659.7 5682.7 5180.5 5234.3 5243.7 5248.8 5249.8 5450.3 5506.8 5507.6 5509.3 5509.5 5551.9 5580.7 5587.5 5588.0 5588.9 5415.4 5421.2 5422.1 5424.8 5425.6 5363.8 5365.8 5370.1 5397.8 5415.2 5253.3 5370.9 5380.9 5388.4 5391.6 5379.7 5380.1 5390.4 5428.3 5466.2 5359.5 5359.8 5363.7 5377.8 5401.5 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#1] ext.html Cycles:180 Average:32738.59 Median:30033.32 stddev:49612.52 (165.2%) stddev-sans-first:49693.24 13:17:52 INFO - PID 3405 | Values: 663.0 680.9 1040.4 1063.0 1064.1 32355.8 33404.7 33650.3 33717.3 33722.8 35901.3 36376.5 36400.5 36430.0 36473.6 5658.2 7499.8 7651.3 7659.4 7660.9 5759.5 7262.0 7437.3 7439.5 7452.3 7520.0 7547.1 7551.8 7571.0 7585.9 7492.9 7550.0 7559.2 7561.5 7563.3 7442.7 7510.0 7510.6 7513.6 7514.5 33797.7 33870.5 33924.3 34014.1 34046.7 2717.9 2724.9 2726.2 2737.5 2787.6 23020.8 23148.7 23344.6 23564.9 23568.4 2778.8 2852.9 2863.2 2881.5 2892.2 150953.2 152225.0 152940.0 152961.2 153159.0 34431.5 35034.3 41644.6 41837.4 41955.8 42482.0 43310.0 43417.8 43476.3 43503.8 11412.7 11526.3 11528.1 11534.6 11535.2 9002.9 9006.1 9007.9 9011.2 9028.1 12687.4 12740.6 12744.7 12815.6 12846.8 5165.5 5210.4 5213.3 5254.1 5261.2 863.4 873.7 879.2 879.2 906.5 20211.7 20680.4 20792.9 21101.3 21109.2 946.6 953.5 961.0 968.3 968.7 10713.8 10831.8 10885.5 10909.6 10928.3 204750.0 205342.0 205721.0 206122.0 206446.0 40151.6 40222.4 40272.4 40280.0 40325.2 1195.2 1227.7 1231.1 1233.1 1243.7 19458.9 19659.8 19922.9 20164.5 20375.1 30654.8 30725.7 30774.0 30800.2 30855.5 208908.0 209468.0 209781.0 209885.0 209956.0 28614.6 28938.7 29172.4 29597.6 29607.9 34046.5 34448.8 34482.5 34595.5 35338.5 26543.6 27064.5 27094.9 27586.7 27854.6 25604.5 25860.6 26207.3 26667.5 26751.3 29764.7 29854.4 29899.4 30167.2 30288.0 25184.4 25187.0 25311.2 25584.7 25847.5 20425.0 21718.8 21781.7 21833.8 21956.6 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#2] jquery.html Cycles:180 Average:29308.89 Median:3863.58 stddev:77137.42 (1996.5%) stddev-sans-first:77323.24 13:17:52 INFO - PID 3405 | Values: 385.4 411.8 432.6 436.4 439.7 14952.6 18584.4 19110.5 19233.3 19356.2 17383.2 17507.2 17639.3 17997.7 18106.5 5570.7 5797.1 5801.7 5804.2 5806.4 3483.3 3659.3 4925.0 6027.7 6557.7 6570.7 6598.6 6606.2 6606.7 6609.1 6332.0 6487.1 6505.2 6515.2 6528.1 6141.2 6319.9 6358.6 6370.8 6427.3 23713.9 23741.1 24086.5 24216.8 24379.5 1579.7 1584.7 1589.9 1605.2 1637.7 14074.5 15086.8 15192.3 15428.5 15565.8 1733.8 1844.1 1857.9 1864.7 1879.2 85403.6 87900.1 89456.6 90128.5 92124.5 14818.3 17571.0 18144.4 18390.6 18560.7 32115.8 32295.5 32614.7 32641.3 32751.2 8332.2 8695.2 8751.8 8798.6 8908.8 6844.4 6878.0 7042.7 7100.8 7103.3 9358.2 9490.1 9555.3 9567.3 9622.7 3422.9 3860.3 3862.8 3864.4 3881.4 831.4 847.7 857.1 863.7 889.9 16274.2 16365.1 16941.5 17293.5 17344.0 821.0 854.7 863.5 873.9 881.2 10349.9 11577.3 11596.5 11729.6 11738.9 457639.0 465590.0 466293.0 467527.0 476621.0 89160.0 92582.5 92667.0 92670.0 93057.0 1021.7 1063.5 1076.1 1102.1 1103.9 16009.0 16550.7 17154.6 17365.9 17555.1 43578.4 43869.3 44088.3 44650.3 44846.1 54011.5 54765.2 54766.5 54902.9 55606.0 7922.0 8195.8 8280.5 8610.7 8678.2 12514.4 12772.3 12878.4 13076.2 13078.3 10590.9 10808.6 10818.8 10922.7 10931.1 10008.4 10138.3 10186.6 10211.6 10402.5 10522.8 10773.4 10785.6 10855.8 11154.0 8009.7 8098.1 8204.6 8231.3 8255.8 11089.6 11125.5 11128.8 11230.1 11513.8 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#3] mootools.html Cycles:180 Average:6185.50 Median:5025.62 stddev:3944.17 (78.5%) stddev-sans-first:3937.48 13:17:52 INFO - PID 3405 | Values: 1204.8 1295.6 1300.1 1305.9 1312.1 9288.2 9690.6 9699.0 9702.1 9706.1 9541.5 9869.1 9940.5 9947.2 9965.1 2163.7 2200.1 2206.5 2207.5 2209.5 1848.4 1910.6 2136.6 2187.2 2223.7 2118.4 2201.7 2202.8 2202.8 2204.8 2126.5 2161.9 2169.5 2174.1 2192.0 2168.5 2175.0 2177.4 2177.7 2181.6 9601.4 9682.2 9684.5 9695.6 9702.2 5329.0 5518.2 5531.3 5533.0 5533.9 3112.9 3149.4 3348.5 3391.2 3407.2 971.9 979.0 1000.4 1080.1 1092.6 14556.9 14745.2 14935.7 14947.9 14960.5 4749.5 4875.9 4947.6 4996.3 5039.4 10891.3 10900.6 10903.1 10920.6 10923.8 5503.6 5507.1 5512.2 5514.3 5518.2 4785.8 4791.8 5010.1 5038.5 5057.3 3690.2 3738.9 3779.8 3841.5 3865.8 1005.8 1152.3 1156.6 1163.2 1173.1 597.5 684.8 708.6 720.0 741.9 5210.5 5408.4 5410.6 5466.9 5605.4 800.8 817.9 835.0 843.6 846.4 3336.9 3453.3 3937.1 4144.0 4164.1 12679.1 13133.5 13133.6 13140.7 13154.3 12466.9 12986.7 13046.0 13050.2 13074.5 9227.6 9311.2 9352.2 9375.2 9392.6 6091.4 6440.8 6455.9 6457.1 6656.2 11219.8 11701.3 11729.0 11805.9 11897.2 11526.0 11549.7 11572.5 11668.8 11694.5 8092.5 8342.8 8366.5 8379.6 8387.7 9048.9 9049.6 9151.8 9155.6 9205.2 7477.6 7549.6 7595.6 7708.7 7886.0 7147.9 7175.6 7183.1 7212.7 7291.4 7178.3 7184.7 7200.9 7224.1 7237.6 5132.9 5263.4 5291.7 5411.6 5447.0 5012.7 5081.9 5129.7 5137.2 5181.7 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#4] prototype.html Cycles:180 Average:4597.89 Median:5248.29 stddev:1329.21 (25.3%) stddev-sans-first:1294.57 13:17:52 INFO - PID 3405 | Values: 373.7 393.5 399.2 399.4 400.1 5354.8 5359.9 5391.9 5403.7 5406.5 5042.3 5184.7 5219.5 5231.6 5293.3 4128.0 4128.9 4133.1 4135.5 4138.9 4070.3 4113.7 4135.9 4138.8 4153.2 3948.7 4048.4 4071.1 4076.1 4084.7 4063.1 4073.5 4074.5 4076.9 4082.5 3571.2 3585.7 3592.3 3592.8 3595.4 4993.6 5094.8 5115.0 5130.7 5134.9 4647.9 4663.6 4677.0 4685.5 4703.6 5466.9 5472.4 5491.7 5492.8 5493.0 3898.4 3907.2 3908.8 3916.0 3924.2 5535.3 5580.2 5639.6 5675.6 5847.6 3983.7 3994.2 4000.9 4012.3 4018.1 4037.6 4052.7 4053.2 4058.1 4068.0 4370.8 4400.4 4496.8 4630.9 4647.6 5564.2 5585.0 5588.9 5591.7 5595.6 1401.2 1404.4 1405.0 1408.7 1415.0 898.6 949.5 958.3 967.4 967.7 4860.4 4864.0 4868.8 4878.3 4899.6 5712.1 5713.5 5723.8 5733.1 5746.7 4669.4 4873.5 4882.3 4884.6 4897.8 3036.0 3045.1 3053.9 3064.5 3073.7 5392.9 5393.0 5393.6 5405.1 5412.0 5592.2 5819.3 5863.9 5889.1 5911.1 5335.9 5341.9 5355.0 5389.9 5439.6 5474.4 5790.5 5809.0 5811.8 5827.6 5631.8 5651.7 5667.2 5669.6 5671.0 5141.4 5181.4 5265.0 5363.0 5381.4 4309.0 4366.7 4369.5 4371.2 4372.8 5717.3 5722.8 5729.0 5737.3 5738.4 5291.8 5523.6 5531.5 5553.1 5553.3 5495.9 5520.3 5530.3 5533.3 5536.0 5283.5 5421.7 5424.4 5462.5 5473.7 5529.7 5543.0 5557.7 5579.5 5588.0 5416.8 5429.5 5451.9 5456.0 5456.8 13:17:52 INFO - PID 3405 | 13:17:52 INFO - PID 3405 | [#5] yui.html Cycles:180 Average:13760.69 Median:641.97 stddev:17771.63 (2768.3%) stddev-sans-first:17794.09 13:17:52 INFO - PID 3405 | Values: 621.5 636.2 639.4 649.1 660.2 12827.8 13464.4 14084.2 15063.0 15063.8 14903.9 14920.0 14936.7 15234.6 15535.6 922.6 944.2 946.6 946.8 947.3 882.8 911.5 919.8 945.5 948.3 979.0 982.0 982.1 982.7 982.7 973.9 975.1 976.1 976.2 976.3 722.0 722.3 722.9 723.2 723.9 13182.5 13238.3 13279.7 13563.7 14858.3 12983.4 13016.6 13744.9 13836.3 13957.4 9613.8 9643.0 9691.8 9909.9 10194.5 2484.4 2493.5 2519.8 2525.7 2566.9 66099.3 66200.0 66687.0 67378.3 67379.7 10318.4 10569.9 10809.8 10826.1 11055.2 19617.9 20218.8 20253.9 20299.7 20315.5 6169.2 6177.6 6189.9 6196.3 6478.2 3035.3 3045.6 3140.2 3182.3 3203.8 3494.0 3538.5 3562.8 3564.7 3571.3 644.5 647.9 648.9 656.6 664.0 481.2 494.4 497.2 502.7 510.7 7650.5 7756.7 7855.1 7928.9 7932.6 484.3 488.7 496.3 501.0 505.9 3528.2 3648.2 3652.8 3688.3 3825.3 61919.0 62307.4 62596.0 65304.3 65871.0 54930.0 54988.7 55202.7 55521.7 57835.4 49787.5 50160.7 50378.7 50716.0 51296.7 7350.7 7357.9 7425.6 7461.1 7556.5 26866.6 26967.9 27376.6 27622.7 27707.0 32222.0 32790.8 32843.6 33079.8 33336.2 8784.0 8799.1 8815.3 8888.2 8888.5 9012.8 9036.8 9258.4 9298.7 9401.1 9073.3 9223.4 9529.1 9775.4 9845.3 8869.4 9020.8 9168.7 9200.3 9579.0 8625.7 8942.6 8954.8 9053.9 9056.7 7256.3 7361.5 7507.7 7510.4 7522.0 6935.5 7332.0 7601.8 7696.5 7787.5 13:17:52 INFO - PID 3405 | -------- Summary: end -------- 13:17:52 INFO - PID 3405 | 13:17:53 INFO - TEST-INFO | 3405: exit 0 13:17:53 INFO - TEST-OK | dromaeo_css | took 1125433ms 13:17:53 INFO - TEST-START | kraken 13:17:53 INFO - operating with platform_type : linux_ 13:17:53 INFO - Initialising browser for kraken test... 13:17:53 INFO - TEST-INFO | started process 3730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RLTTK/profile http://localhost:52161/getInfo.html) 13:17:57 INFO - PID 3730 | __metrics Screen width/height:1600/1200 13:17:57 INFO - PID 3730 | colorDepth:24 13:17:57 INFO - PID 3730 | Browser inner width/height: 1024/697 13:17:57 INFO - PID 3730 | __metrics 13:17:58 ERROR - PID 3730 | 1490905078467 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 13:17:58 INFO - PID 3730 | 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" 13:17:58 INFO - PID 3730 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:59 INFO - TEST-INFO | 3730: exit 0 13:17:59 INFO - Browser initialized. 13:17:59 INFO - Running cycle 1/1 for kraken test... 13:17:59 INFO - TEST-INFO | started process 3823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1RLTTK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:11 INFO - PID 3823 | RSS: Main: 148754432 13:18:11 INFO - PID 3823 | 13:18:14 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52161/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:15 INFO - PID 3823 | RSS: Main: 204566528 13:18:15 INFO - PID 3823 | 13:18:18 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52161/tests/kraken/driver.html?testName=audio-dft) 13:18:18 INFO - PID 3823 | RSS: Main: 183341056 13:18:18 INFO - PID 3823 | 13:18:21 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52161/tests/kraken/driver.html?testName=audio-fft) 13:18:22 INFO - PID 3823 | RSS: Main: 266788864 13:18:22 INFO - PID 3823 | 13:18:24 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52161/tests/kraken/driver.html?testName=audio-oscillator) 13:18:25 INFO - PID 3823 | RSS: Main: 177528832 13:18:25 INFO - PID 3823 | 13:18:27 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:28 INFO - PID 3823 | RSS: Main: 180695040 13:18:28 INFO - PID 3823 | 13:18:31 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52161/tests/kraken/driver.html?testName=imaging-darkroom) 13:18:32 INFO - PID 3823 | RSS: Main: 219635712 13:18:32 INFO - PID 3823 | 13:18:35 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52161/tests/kraken/driver.html?testName=imaging-desaturate) 13:18:36 INFO - PID 3823 | RSS: Main: 214683648 13:18:36 INFO - PID 3823 | 13:18:39 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52161/tests/kraken/driver.html?testName=json-parse-financial) 13:18:39 INFO - PID 3823 | RSS: Main: 216694784 13:18:39 INFO - PID 3823 | 13:18:41 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:18:42 INFO - PID 3823 | RSS: Main: 180019200 13:18:42 INFO - PID 3823 | 13:18:44 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:18:44 INFO - PID 3823 | RSS: Main: 186630144 13:18:44 INFO - PID 3823 | 13:18:46 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:18:47 INFO - PID 3823 | RSS: Main: 196558848 13:18:47 INFO - PID 3823 | 13:18:50 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:51 INFO - PID 3823 | RSS: Main: 204845056 13:18:51 INFO - PID 3823 | 13:18:54 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:55 INFO - PID 3823 | RSS: Main: 192864256 13:18:55 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:52161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52161/tests/kraken/driver.html?testName=ai-astar) 13:18:57 INFO - PID 3823 | RSS: Main: 266022912 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | __start_tp_report 13:18:57 INFO - PID 3823 | _x_x_mozilla_page_load 13:18:57 INFO - PID 3823 | _x_x_mozilla_page_load_details 13:18:57 INFO - PID 3823 | |i|pagename|runs| 13:18:57 INFO - PID 3823 | |0;ai-astar;104;112;112;111;113;112;111;113;111;111 13:18:57 INFO - PID 3823 | |1;audio-beat-detection;154;124;132;175;130;125;125;125;151;124 13:18:57 INFO - PID 3823 | |2;audio-dft;164;164;165;165;168;164;163;166;163;165 13:18:57 INFO - PID 3823 | |3;audio-fft;76;75;76;113;76;76;76;75;100;76 13:18:57 INFO - PID 3823 | |4;audio-oscillator;85;84;119;88;84;85;113;92;84;108 13:18:57 INFO - PID 3823 | |5;imaging-gaussian-blur;114;113;114;114;114;114;114;115;114;114 13:18:57 INFO - PID 3823 | |6;imaging-darkroom;150;149;149;151;150;149;150;150;149;149 13:18:57 INFO - PID 3823 | |7;imaging-desaturate;95;95;95;95;94;96;94;95;95;94 13:18:57 INFO - PID 3823 | |8;json-parse-financial;69;68;66;68;69;70;69;68;68;69 13:18:57 INFO - PID 3823 | |9;json-stringify-tinderbox;55;56;57;56;56;56;57;56;56;56 13:18:57 INFO - PID 3823 | |10;stanford-crypto-aes;85;83;84;84;85;85;83;85;84;87 13:18:57 INFO - PID 3823 | |11;stanford-crypto-ccm;153;147;135;145;147;152;146;135;186;156 13:18:57 INFO - PID 3823 | |12;stanford-crypto-pbkdf2;198;209;200;197;201;200;202;190;202;204 13:18:57 INFO - PID 3823 | |13;stanford-crypto-sha256-iterative;75;76;70;70;72;71;71;74;71;71 13:18:57 INFO - PID 3823 | __end_tp_report 13:18:57 INFO - PID 3823 | __start_cc_report 13:18:57 INFO - PID 3823 | _x_x_mozilla_cycle_collect,2022 13:18:57 INFO - PID 3823 | __end_cc_report 13:18:57 INFO - PID 3823 | __startTimestamp1490905137377__endTimestamp 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | ------- Summary: start ------- 13:18:57 INFO - PID 3823 | Number of tests: 14 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 13:18:57 INFO - PID 3823 | Values: 104.0 112.0 112.0 111.0 113.0 112.0 111.0 113.0 111.0 111.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:131.00 stddev:17.55 (13.4%) stddev-sans-first:17.43 13:18:57 INFO - PID 3823 | Values: 154.0 124.0 132.0 175.0 130.0 125.0 125.0 125.0 151.0 124.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 13:18:57 INFO - PID 3823 | Values: 164.0 164.0 165.0 165.0 168.0 164.0 163.0 166.0 163.0 165.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.33 (17.5%) stddev-sans-first:13.97 13:18:57 INFO - PID 3823 | Values: 76.0 75.0 76.0 113.0 76.0 76.0 76.0 75.0 100.0 76.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.50 stddev:13.68 (16.2%) stddev-sans-first:14.10 13:18:57 INFO - PID 3823 | Values: 85.0 84.0 119.0 88.0 84.0 85.0 113.0 92.0 84.0 108.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:18:57 INFO - PID 3823 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:18:57 INFO - PID 3823 | Values: 150.0 149.0 149.0 151.0 150.0 149.0 150.0 150.0 149.0 149.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:18:57 INFO - PID 3823 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 94.0 95.0 95.0 94.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 13:18:57 INFO - PID 3823 | Values: 69.0 68.0 66.0 68.0 69.0 70.0 69.0 68.0 68.0 69.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 13:18:57 INFO - PID 3823 | Values: 55.0 56.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 56.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 13:18:57 INFO - PID 3823 | Values: 85.0 83.0 84.0 84.0 85.0 85.0 83.0 85.0 84.0 87.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:149.50 stddev:14.35 (9.6%) stddev-sans-first:15.19 13:18:57 INFO - PID 3823 | Values: 153.0 147.0 135.0 145.0 147.0 152.0 146.0 135.0 186.0 156.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.30 Median:201.50 stddev:4.92 (2.4%) stddev-sans-first:5.15 13:18:57 INFO - PID 3823 | Values: 198.0 209.0 200.0 197.0 201.0 200.0 202.0 190.0 202.0 204.0 13:18:57 INFO - PID 3823 | 13:18:57 INFO - PID 3823 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.50 stddev:2.13 (3.0%) stddev-sans-first:1.99 13:18:57 INFO - PID 3823 | Values: 75.0 76.0 70.0 70.0 72.0 71.0 71.0 74.0 71.0 71.0 13:18:57 INFO - PID 3823 | -------- Summary: end -------- 13:18:57 INFO - PID 3823 | 13:18:58 INFO - TEST-INFO | 3823: exit 0 13:18:58 INFO - TEST-OK | kraken | took 64869ms 13:18:58 INFO - SUITE-END | took 1190s 13:18:58 INFO - Completed test suite (00:19:50) 13:18:58 INFO - javascript benchmark 13:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6618.1168916245515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.5843544250642, 2717.7961652876015, 2753.187809596169, 2753.352962053917, 2755.311172206949, 5033.54698077173, 5125.718085505296, 5187.6887386756825, 5216.5565926896215, 5262.842114736554, 5133.743312834362, 5202.92195617066, 5203.4796520347945, 5226.55574276187, 5261.842144735654, 4513.887152821173, 4767.594754445876, 4876.609871210295, 4924.926126108094, 4929.8028078876805, 4833.0, 4859.684120532172, 4871.829485967992, 4881.8779530511665, 4904.730239836807, 4695.741734204617, 4755.381800365965, 4759.50025247351, 4803.543663351976, 4805.231163013936, 4736.692115012547, 4744.430668319789, 4751.786169622375, 4752.667313288071, 4753.120672675532, 4702.106599746037, 4712.5994290485005, 4717.127331443659, 4721.716696998157, 4722.574968252839, 5106.897862042775, 5124.359455068116, 5209.973950130263, 5235.3717553893775, 5241.79032838686, 5571.331440227158, 5580.107182850765, 5580.358258800249, 5588.441155884379, 5622.8313150605545, 5600.635958662674, 5660.971695141539, 5675.914861277043, 5678.176664383641, 5679.545636349082, 5016.498350164954, 5073.949260507421, 5106.719130447861, 5108.412532558803, 5123.180291153398, 5609.1305847593685, 5662.915056274159, 5677.489025987681, 5677.914831277534, 5682.829515114553, 5419.972900135474, 5423.620346575702, 5452.372977107604, 5539.944600553943, 5540.36285827135, 5573.916391254134, 5582.413846546055, 5584.664920104807, 5586.16207568868, 5634.915476267859, 5515.944840551623, 5516.531094856982, 5525.889482210414, 5527.364353099365, 5531.225628412026, 5379.435159308295, 5388.299521062237, 5441.700706461103, 5468.343798744176, 5569.275994120739, 4673.883152921204, 4679.99380133273, 4690.671652984258, 4722.952770472251, 4725.905481890343, 4010.7393019453643, 4016.2770701274053, 4023.3964905264443, 4026.3960405938756, 4055.0673345130785, 4681.110588988081, 4753.809847606126, 4794.304825800239, 4801.039792041536, 4840.249761287007, 5583.469570390806, 5607.074832652648, 5668.461496157858, 5682.460166284196, 5691.8861622768145, 4763.618910487153, 4768.070226305837, 4768.57082862544, 4770.76146192689, 4810.302506136661, 4974.925376119361, 4984.451710311862, 4990.051890140789, 4994.32576602154, 5011.523905228997, 5159.664621799571, 5217.0870097733505, 5246.842594722164, 5247.55395791362, 5304.389995150453, 5446.0, 5567.5545956322585, 5620.8875822482505, 5659.660420374791, 5682.659040457585, 5180.507851754077, 5234.345706786652, 5243.68537887728, 5248.8425347239645, 5249.842504724865, 5450.291462109901, 5506.752196151263, 5507.586930980113, 5509.256250406143, 5509.47659972302, 5551.861203469945, 5580.665160090408, 5587.497125258747, 5588.022096133079, 5588.916166257591, 5415.404305526467, 5421.159720243369, 5422.105352616774, 5424.7558859850615, 5425.647332923348, 5363.758630861543, 5365.812196573102, 5370.113931201308, 5397.8380648580605, 5415.187721841755, 5253.317068781187, 5370.865728356823, 5380.892382152413, 5388.353397592157, 5391.649542779707, 5379.67721936685, 5380.112281473513, 5390.353157621111, 5428.321459817523, 5466.1527463243265, 5359.464053594609, 5359.758810853443, 5363.731813409392, 5377.784888604412, 5401.4868587484125], "value": 5087.953277445087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.0485253660997, 680.8570200257947, 1040.3965699894063, 1062.9521671524785, 1064.1433645915035, 32355.83822080889, 33404.66595334049, 33650.32699346012, 33717.325653486914, 33722.8313858431, 35901.2819743605, 36376.45435318466, 36400.45399319006, 36430.0, 36473.63526364735, 5658.179563963223, 7499.812504687399, 7651.349635281008, 7659.387249020093, 7660.885086723703, 5759.4816466518005, 7262.0, 7437.293457121565, 7439.516431431966, 7452.329290363866, 7519.962400187991, 7547.05661792276, 7551.848963020736, 7571.0, 7585.886211706828, 7492.925070749277, 7549.962250188769, 7559.168491465907, 7561.470697051209, 7563.319301262913, 7442.702291908317, 7509.962450187769, 7510.586917719524, 7513.586752728598, 7514.511556748794, 33797.6620233797, 33870.49194262088, 33924.321513569594, 34014.1496462588, 34046.6595334046, 2717.904873329444, 2724.9046283380185, 2726.2230264374557, 2737.534619114755, 2787.6376071110626, 23020.76979230203, 23148.65277020846, 23344.64983025256, 23564.882175589184, 23568.410789730224, 2778.833270003786, 2852.9001484948135, 2863.1696807925678, 2881.4813333599946, 2892.219100842761, 150953.2452337742, 152225.0, 152940.0, 152961.23519382442, 153159.0, 34431.48352774711, 35034.29931401409, 41644.583554164674, 41837.37243941343, 41955.7902210487, 42482.0, 43310.0, 43417.78291108524, 43476.3478547822, 43503.78248108739, 11412.714682133013, 11526.250793698382, 11528.077753779677, 11534.596289130008, 11535.192536522363, 9002.909970900208, 9006.054364291786, 9007.864882026775, 9011.23404510624, 9028.052054534312, 12687.429065692066, 12740.55408060732, 12744.745105097845, 12815.551455699006, 12846.779555942358, 5165.535101840853, 5210.426853046162, 5213.2701421800975, 5254.106801843695, 5261.210818377274, 863.447393668053, 873.6767396063498, 879.1735768377705, 879.2394578689515, 906.4833045164324, 20211.696824547642, 20680.379588612366, 20792.89603552003, 21101.261455848973, 21109.155633774477, 946.6118891254553, 953.547065144051, 960.9663661771805, 968.3463662028103, 968.7432830299977, 10713.83929241062, 10831.83752243717, 10885.510152043176, 10909.563617455213, 10928.344299342065, 204750.0, 205342.0, 205721.0, 206122.0, 206446.0, 40151.59848401537, 40222.396664050066, 40272.395914061315, 40280.0, 40325.19349612991, 1195.2410219510673, 1227.6930767308172, 1231.1135982092878, 1233.0567116156326, 1243.7139457924727, 19458.902705486384, 19659.803401965797, 19922.90038549856, 20164.495887602927, 20375.083121259282, 30654.846725766227, 30725.692743072283, 30774.0, 30800.229994250323, 30855.537166942064, 208908.0, 209468.0, 209781.0, 209885.0, 209956.0, 28614.57078143788, 28938.710612893603, 29172.416551669274, 29597.5560366599, 29607.85196074006, 34046.48930266098, 34448.82775586106, 34482.482762758074, 34595.48106778451, 35338.46992295169, 26543.601845971938, 27064.458710825278, 27094.864525677247, 27586.72413275922, 27854.582181267702, 25604.487910241318, 25860.612090818275, 26207.34481637898, 26667.466650667266, 26751.331216719736, 29764.702352976194, 29854.402911941204, 29899.402011960075, 30167.245818854703, 30288.0, 25184.370390739645, 25187.0, 25311.240662780147, 25584.744152558236, 25847.483050339262, 20425.0, 21718.782812172307, 21781.673274901204, 21833.781662183173, 21956.560868782854], "value": 14574.242407202706, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4334128830618, 411.78452438887433, 432.6149726743197, 436.37816112040343, 439.7273690312007, 14952.551423457286, 18584.442466726003, 19110.52223694408, 19233.32683356083, 19356.22575096998, 17383.217755201014, 17507.212175452103, 17639.29442822289, 17997.7300340495, 18106.5473363166, 5570.721463926808, 5797.130430435426, 5801.709914504279, 5804.216430781854, 5806.390329015456, 3483.303339332131, 3659.2864391443677, 4925.0, 6027.72875220614, 6557.737690492375, 6570.671466426659, 6598.571092878948, 6606.240282367541, 6606.7026983785845, 6609.074729537869, 6332.0, 6487.059376390421, 6505.154329937078, 6515.153030106103, 6528.08606795049, 6141.232345956755, 6319.873602527924, 6358.554901156921, 6370.840728981766, 6427.260865000538, 23713.881430592737, 23741.05035798566, 24086.518269634686, 24216.757832421627, 24379.512409751882, 1579.6761663858997, 1584.7305957987055, 1589.8569128778465, 1605.1733357320988, 1637.7461493468531, 14074.507392241325, 15086.773698394532, 15192.316345764357, 15428.534289242616, 15565.844341556665, 1733.7919449665994, 1844.0779610194902, 1857.8513718902454, 1864.6643604151247, 1879.229515898475, 85403.57298213469, 87900.12099879047, 89456.552717236, 90128.54935725345, 92124.53937730269, 14818.294017418608, 17571.0, 18144.364947226783, 18390.63218735618, 18560.721589176173, 32115.839420802746, 32295.51556726651, 32614.67385326164, 32641.34717305688, 32751.18122046968, 8332.16678332174, 8695.173958473935, 8751.808378946735, 8798.648054077765, 8908.821823563492, 6844.4182244508775, 6877.9656101720175, 7042.6830792614455, 7100.822479438056, 7103.325184107502, 9358.204552613104, 9490.145886870216, 9555.331126821056, 9567.273327101742, 9622.663206787729, 3422.9144271393416, 3860.343741563941, 3862.787546684903, 3864.381698928158, 3881.3983832506005, 831.4387788242911, 847.7160151349367, 857.0829212742306, 863.7192912303526, 889.9243564297108, 16274.186290685418, 16365.099919504304, 16941.491755247363, 17293.481195564153, 17344.0, 821.0393839208141, 854.6837670062117, 863.4732812984074, 873.9475631462005, 881.1584936385736, 10349.9482502587, 11577.277684147946, 11596.536138554533, 11729.589464368877, 11738.882611173949, 457639.0, 465590.0, 466293.0, 467527.0, 476621.0, 89160.0, 92582.53708731414, 92667.0, 92670.0, 93057.0, 1021.7139201023874, 1063.5214153630743, 1076.1498416251231, 1102.1458369763498, 1103.933763974164, 16009.0, 16550.66898662044, 17154.571135721708, 17365.913170434065, 17555.12224388801, 43578.38529688229, 43869.34195986999, 44088.338674920546, 44650.330245047, 44846.10307793761, 54011.45988540064, 54765.178522322996, 54766.45233547773, 54902.90194196014, 55606.0, 7922.0, 8195.83608327842, 8280.50316980983, 8610.65557377698, 8678.175573320525, 12514.436850341574, 12772.297523636289, 12878.356082195665, 13076.215427074407, 13078.346082695636, 10590.8940910593, 10808.621698240524, 10818.783624327627, 10922.672319830417, 10931.125509959344, 10008.39949603026, 10138.290319677551, 10186.643467478603, 10211.591536338463, 10402.47987600632, 10522.789544209227, 10773.353598784099, 10785.568577256821, 10855.78288434211, 11154.0, 8009.679612815655, 8098.149694282251, 8204.63079161451, 8231.300339471212, 8255.752327429946, 11089.611863584736, 11125.499352529318, 11128.777424451628, 11230.101591872794, 11513.827292590786], "value": 9739.765700398048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.825300331452, 1295.6307452376075, 1300.1419063418145, 1305.8955283577316, 1312.0815429199563, 9288.164065234128, 9690.563924623391, 9699.0, 9702.078302561264, 9706.126448619623, 9541.522923853814, 9869.111779939803, 9940.453275069869, 9947.204223662107, 9965.103140717334, 2163.6646319820416, 2200.0869639099756, 2206.5145667953025, 2207.459172502739, 2209.5249521352907, 1848.3900312896712, 1910.5796724720608, 2136.6260904341757, 2187.1579441914896, 2223.722034745657, 2118.438613767345, 2201.7027701260363, 2202.8458007939453, 2202.8458007939453, 2204.7574766775724, 2126.4683829042738, 2161.9243326483574, 2169.5227050048966, 2174.0542863854193, 2192.0464597899804, 2168.479564904427, 2174.9891250543806, 2177.401214665964, 2177.6842357858022, 2181.6182168120517, 9601.423914565148, 9682.177014953737, 9684.467354295512, 9695.563699633534, 9702.175315098226, 5329.0, 5518.19986102017, 5531.3362396512275, 5533.0, 5533.944660553383, 3112.9066128016198, 3149.370125974814, 3348.5479460272795, 3391.186115332327, 3407.1993081625797, 971.9222462203007, 979.0063085967678, 1000.404759168301, 1080.1412876762913, 1092.633967620848, 14556.927215363856, 14745.189014604193, 14935.701285974219, 14947.850521494755, 14960.476383326532, 4749.498397867847, 4875.878103047452, 4947.5794557462295, 4996.300517927493, 5039.370078740158, 10891.292066015683, 10900.618478353379, 10903.073238774634, 10920.617778377718, 10923.781524369468, 5503.642263252876, 5507.0637991541535, 5512.173174023928, 5514.338279406497, 5518.227448157261, 4785.760711964388, 4791.808327666854, 5010.073136469765, 5038.546530812245, 5057.31726216956, 3690.1881586051563, 3738.9439158412647, 3779.829907654162, 3841.519810023747, 3865.7873816939777, 1005.8290090684601, 1152.2510368260698, 1156.6183159557327, 1163.1567113842395, 1173.12015988009, 597.4831770518471, 684.8219462939572, 708.6315116139579, 719.9748008819666, 741.9130973124398, 5210.452902445189, 5408.432114627986, 5410.621256512085, 5466.945330546644, 5605.355384130796, 800.771780042685, 817.9345652347798, 834.9980023971137, 843.5992903370973, 846.3779122345195, 3336.8998930031653, 3453.2920751245933, 3937.114149316438, 4144.046869220097, 4164.104717485755, 12679.112462127747, 13133.540326088732, 13133.60599182026, 13140.737185256241, 13154.276514791587, 12466.937665311616, 12986.675333116747, 13046.0, 13050.216986980811, 13074.477020919057, 9227.630894764268, 9311.161995420445, 9352.205062569758, 9375.249980001583, 9392.62429502826, 6091.390860913873, 6440.806775796734, 6455.935440645533, 6457.128287681103, 6656.167979002625, 11219.775604488028, 11701.2979221247, 11728.950472877284, 11805.881941180478, 11897.226680265756, 11526.0, 11549.711257218636, 11572.537098515964, 11668.824967625322, 11694.4737486815, 8092.514449133071, 8342.83314333722, 8366.456180348257, 8379.622916968872, 8387.748367548984, 9048.864267035868, 9049.638014479611, 9151.816963660822, 9155.587998539948, 9205.217556507772, 7477.588732619758, 7549.584772837547, 7595.620218988918, 7708.691652333844, 7886.0, 7147.928520714726, 7175.569465832067, 7183.066201393785, 7212.71149154028, 7291.4166866649475, 7178.318059784312, 7184.712611495691, 7200.855982880418, 7224.060872086595, 7237.565746055254, 5132.902853216937, 5263.367877198076, 5291.708956007456, 5411.648242864201, 5447.0, 5012.699238045729, 5081.949180508148, 5129.717865517283, 5137.2037334213255, 5181.740912954413], "value": 4669.594019633258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7234446509582, 393.5081148564295, 399.1537939568116, 399.44078290393446, 400.05786373091377, 5354.812581559646, 5359.89280214396, 5391.865203369918, 5403.7027963462, 5406.459354064592, 5042.268871013701, 5184.7148406837605, 5219.45195754446, 5231.5814734821215, 5293.311869456965, 4127.958720412803, 4128.855490057848, 4133.0700592366775, 4135.503739551243, 4138.855140070098, 4070.328395814687, 4113.650339721127, 4135.937960930589, 4138.793060346986, 4153.190127925056, 3948.684105271586, 4048.3725022621543, 4071.1043570414463, 4076.1440097579543, 4084.7140700151003, 4063.085805693725, 4073.531543872463, 4074.5331680594963, 4076.857309994136, 4082.4896887888867, 3571.2143328467696, 3585.713142948558, 3592.317459682678, 3592.8203589820405, 3595.442706380515, 4993.575546078588, 5094.821681241176, 5115.0, 5130.692158470503, 5134.897302053975, 4647.883802904955, 4663.60359369454, 4677.0, 4685.484596694361, 4703.553162449562, 5466.890662186774, 5472.425395333473, 5491.7254137292975, 5492.752826122794, 5493.0, 3898.3567711327596, 3907.2380885727293, 3908.8241029153755, 3915.9818447203934, 3924.2151569685893, 5535.335759708821, 5580.242223699522, 5639.574982757372, 5675.602707810413, 5847.649141051551, 3983.721139520264, 3994.2410941920944, 4000.8599699010397, 4012.257732319472, 4018.1361007383553, 4037.576054514234, 4052.65552428041, 4053.2096241233266, 4058.0869304406865, 4068.044009657728, 4370.759608221515, 4400.44994375703, 4496.775161241925, 4630.907381852344, 4647.604953578983, 5564.221009058735, 5585.0, 5588.91616625751, 5591.7483713233005, 5595.580331475156, 1401.159304417362, 1404.39610967283, 1405.0, 1408.7178770391827, 1415.0377743134768, 898.6315610599622, 949.5489642419933, 958.3387462650749, 967.385710074108, 967.7435479597913, 4860.392450943632, 4864.0, 4868.756562171877, 4878.317035615017, 4899.58353539946, 5712.143178523172, 5713.514351280104, 5723.828285151452, 5733.082706766897, 5746.655200687972, 4669.369635099286, 4873.537013983666, 4882.316475693406, 4884.609231261491, 4897.755112244374, 3035.969640303613, 3045.1016949999803, 3053.92365190872, 3064.5249986252165, 3073.7244043722053, 5392.948375066902, 5393.0, 5393.5954803389905, 5405.108157154104, 5411.997560902491, 5592.245046918695, 5819.301683797887, 5863.941360586425, 5889.116632505158, 5911.142884281755, 5335.86660333487, 5341.919871201935, 5355.036093503207, 5389.9191512127345, 5439.5648348132845, 5474.397816240131, 5790.507806836466, 5809.0, 5811.79658711943, 5827.5629327801435, 5631.831045068655, 5651.660900345993, 5667.234923285304, 5669.574781891292, 5670.999999999835, 5141.434442211428, 5181.35233095863, 5265.0, 5363.0, 5381.354237491526, 4309.017851788212, 4366.737995720267, 4369.541198174273, 4371.213181627338, 4372.825086996484, 5717.342505611908, 5722.771089156554, 5728.971355143198, 5737.340205876378, 5738.368779434176, 5291.7618707159045, 5523.613347065828, 5531.502164805187, 5553.111502159635, 5553.334399488187, 5495.873345964148, 5520.309961254843, 5530.308711411074, 5533.253010843485, 5536.0, 5283.471652834686, 5421.728913554385, 5424.430434804446, 5462.453754624506, 5473.726313684379, 5529.668219906818, 5542.972285138549, 5557.749901254372, 5579.46995035471, 5587.972060139673, 5416.835380393077, 5429.53848922846, 5451.918221226605, 5456.0, 5456.809011684572], "value": 4193.345452259009, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.4996927473385, 636.2110982381846, 639.4277121975829, 649.0685865782602, 660.2143449295338, 12827.807582886253, 13464.394102265396, 14084.154950702965, 15063.0, 15063.77404338933, 14903.92548037261, 14920.0, 14936.701265974674, 15234.619134521643, 15535.611609709764, 922.557172557173, 944.2021491839384, 946.6450081219542, 946.7822400847809, 947.2564037230775, 882.7528292078229, 911.4531281231241, 919.7884486568094, 945.5319616789699, 948.3172116076448, 979.045430705064, 981.9705408837747, 982.1455333859517, 982.6609819612222, 982.7248370456284, 973.9026097390275, 975.11264749078, 976.0824824664793, 976.2287792643839, 976.272676855747, 721.9711211551531, 722.3138018882083, 722.8915662650592, 723.1647447198494, 723.8914162875558, 13182.472701091945, 13238.27189504577, 13279.66800829987, 13563.660908477268, 14858.331375088146, 12983.415746291439, 13016.609501714964, 13744.931275343659, 13836.308184590831, 13957.380674855838, 9613.807723845553, 9642.951785241099, 9691.806163876683, 9909.851352229722, 10194.541245643964, 2484.354067942348, 2493.5386953413677, 2519.848809071462, 2525.6590360301307, 2566.8844901979455, 66099.33900660979, 66200.0, 66686.99999999952, 67378.32621673819, 67379.66310168417, 10318.43248621318, 10569.947150264354, 10809.83785243222, 10826.133909287239, 11055.170862185369, 19617.901910490356, 20218.797812021985, 20253.898730506255, 20299.695504567444, 20315.492112697004, 6169.167162433104, 6177.598456100339, 6189.876202476015, 6196.349383314777, 6478.222613286342, 3035.256362191233, 3045.634523857151, 3140.230643492359, 3182.3158021025592, 3203.7917535360125, 3493.9650603494147, 3538.469229615578, 3562.821858907096, 3564.6613571710645, 3571.285742851388, 644.5101722690695, 647.9352064793577, 648.9253735820347, 656.6027553330262, 663.9634820084942, 481.2396413666399, 494.35980405375125, 497.2019908047604, 502.65568085861304, 510.68082448469704, 7650.464467487333, 7756.689732410753, 7855.096663883726, 7928.920710792933, 7932.603369831485, 484.3171128708504, 488.6701476503346, 496.2853490972987, 501.04800878331463, 505.9241113832881, 3528.153243221608, 3648.1609229877276, 3652.7625704329134, 3688.3360995021153, 3825.311443940062, 61919.0, 62307.37692623107, 62596.0, 65304.34695652983, 65871.0, 54930.0, 54988.72505637446, 55202.72398638062, 55521.72239138778, 57835.42164578385, 49787.502124979736, 50160.74919625378, 50378.74810625997, 50716.0, 51296.74351628218, 7350.742724004848, 7357.889631655423, 7425.591592462466, 7461.141968673672, 7556.546607203585, 26866.59700104539, 26967.865160674857, 27376.589351160146, 27622.72377276282, 27707.0, 32222.0, 32790.83604581962, 32843.59976636556, 33079.83460082684, 33336.1665958353, 8784.0, 8799.12008799115, 8815.250703690259, 8888.200061994452, 8888.511131887808, 9012.774680633036, 9036.79086640407, 9258.444493330422, 9298.72103836886, 9401.10689484498, 9073.274138068806, 9223.354365194373, 9529.14237718581, 9775.413475191512, 9845.310828241954, 8869.423487473294, 9020.774480638036, 9168.679096231599, 9200.26397888154, 9579.042095790644, 8625.741158242912, 8942.597583108645, 8954.776130596527, 9053.909460905306, 9056.746519603008, 7256.310650488195, 7361.484696071224, 7507.662155203138, 7510.420086145871, 7521.962390188233, 6935.514513983972, 7332.0, 7601.809954751176, 7696.538207707556, 7787.532748035136], "value": 5940.9178233897155, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 113.0, 112.0, 111.0, 113.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 132.0, 175.0, 130.0, 125.0, 125.0, 125.0, 151.0, 124.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 165.0, 168.0, 164.0, 163.0, 166.0, 163.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 113.0, 76.0, 76.0, 76.0, 75.0, 100.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 88.0, 84.0, 85.0, 113.0, 92.0, 84.0, 108.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 151.0, 150.0, 149.0, 150.0, 150.0, 149.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 85.0, 85.0, 83.0, 85.0, 84.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 135.0, 145.0, 147.0, 152.0, 146.0, 135.0, 186.0, 156.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 209.0, 200.0, 197.0, 201.0, 200.0, 202.0, 190.0, 202.0, 204.0], "value": 200.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 70.0, 70.0, 72.0, 71.0, 71.0, 74.0, 71.0, 71.0], "value": 72.1, "unit": "score"}]}]} 13:18:58 INFO - Return code: 0 13:18:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:18:58 ERROR - # TBPL SUCCESS # 13:18:58 INFO - Running post-action listener: _resource_record_post_action 13:18:58 INFO - [mozharness: 2017-03-30 20:18:58.683058Z] Finished run-tests step (success) 13:18:58 INFO - Running post-run listener: _resource_record_post_run 13:18:58 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 7352320; Write bytes: 372625408; Read time: 1176; Write time: 290312 13:18:58 INFO - TinderboxPrint: CPU usage
13.0% 13:18:58 INFO - TinderboxPrint: I/O read bytes / time
7,352,320 / 1,176 13:18:58 INFO - TinderboxPrint: I/O write bytes / time
372,625,408 / 290,312 13:18:58 INFO - TinderboxPrint: CPU idle
8,373.4 (87.0%) 13:18:58 INFO - TinderboxPrint: CPU user
1,202.7 (12.5%) 13:18:58 INFO - TinderboxPrint: Swap in / out
0 / 0 13:18:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113016832; Read time: 0; Write time: 107000 13:18:58 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 7352320; Write bytes: 259608576; Read time: 1176; Write time: 183312 13:18:59 INFO - Running post-run listener: _upload_blobber_files 13:18:59 INFO - Blob upload gear active. 13:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:18:59 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 13:18:59 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'] 13:18:59 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 13:18:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:03 INFO - (blobuploader) - INFO - Done attempting. 13:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:04 INFO - (blobuploader) - INFO - Done attempting. 13:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:05 INFO - (blobuploader) - INFO - Done attempting. 13:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:06 INFO - (blobuploader) - INFO - Done attempting. 13:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:19:06 INFO - Return code: 0 13:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:19:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ba5d969371c5de169f400bde733c7d72f78a8a5a8b81be2fc555eaa5cb1648f8c575601fa8c2cdf03d9d9c2c5121040756a507b1d422868265df1e5758cbe01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aeb6dd77a07008d157c4036e896476c5e798f4bcf3f85d22477f3909e4faee01117887b2ccc15f1006b23130a1178b9e2854c8cb9704f54b022432808578558", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bdb1f1e8cc27d276679a234ea81f1a03a48649f0a8803dd8298d24e34aac9c38e4f4713b25dbb04c1843f6c04ff25f94e34796144a332a4aac578ee22f6bd79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ade9ff0c25a7af0b2f2b87750b8eb25bd838c258d47276157219a59449b7494515fa6a1c45385faf81b3a7e6c8c728950e6a2f5d20abc9f8100adf7bc5e3339"} 13:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:19:06 INFO - Contents: 13:19:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ba5d969371c5de169f400bde733c7d72f78a8a5a8b81be2fc555eaa5cb1648f8c575601fa8c2cdf03d9d9c2c5121040756a507b1d422868265df1e5758cbe01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aeb6dd77a07008d157c4036e896476c5e798f4bcf3f85d22477f3909e4faee01117887b2ccc15f1006b23130a1178b9e2854c8cb9704f54b022432808578558", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bdb1f1e8cc27d276679a234ea81f1a03a48649f0a8803dd8298d24e34aac9c38e4f4713b25dbb04c1843f6c04ff25f94e34796144a332a4aac578ee22f6bd79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ade9ff0c25a7af0b2f2b87750b8eb25bd838c258d47276157219a59449b7494515fa6a1c45385faf81b3a7e6c8c728950e6a2f5d20abc9f8100adf7bc5e3339"} 13:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:19:06 INFO - Copying logs to upload dir... 13:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.085656 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-03-30 13:19:06.055464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:19:06.059463) ========= 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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ba5d969371c5de169f400bde733c7d72f78a8a5a8b81be2fc555eaa5cb1648f8c575601fa8c2cdf03d9d9c2c5121040756a507b1d422868265df1e5758cbe01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aeb6dd77a07008d157c4036e896476c5e798f4bcf3f85d22477f3909e4faee01117887b2ccc15f1006b23130a1178b9e2854c8cb9704f54b022432808578558", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bdb1f1e8cc27d276679a234ea81f1a03a48649f0a8803dd8298d24e34aac9c38e4f4713b25dbb04c1843f6c04ff25f94e34796144a332a4aac578ee22f6bd79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ade9ff0c25a7af0b2f2b87750b8eb25bd838c258d47276157219a59449b7494515fa6a1c45385faf81b3a7e6c8c728950e6a2f5d20abc9f8100adf7bc5e3339"} build_url:https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/OHYUZo6ZRJKukjfgIZUegQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ba5d969371c5de169f400bde733c7d72f78a8a5a8b81be2fc555eaa5cb1648f8c575601fa8c2cdf03d9d9c2c5121040756a507b1d422868265df1e5758cbe01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9aeb6dd77a07008d157c4036e896476c5e798f4bcf3f85d22477f3909e4faee01117887b2ccc15f1006b23130a1178b9e2854c8cb9704f54b022432808578558", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bdb1f1e8cc27d276679a234ea81f1a03a48649f0a8803dd8298d24e34aac9c38e4f4713b25dbb04c1843f6c04ff25f94e34796144a332a4aac578ee22f6bd79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ade9ff0c25a7af0b2f2b87750b8eb25bd838c258d47276157219a59449b7494515fa6a1c45385faf81b3a7e6c8c728950e6a2f5d20abc9f8100adf7bc5e3339"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 13:19:06.085457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:19:06.085777) ========= 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=20e666a3d4cfbb71505a330e000001b4-1490903875.89649-1254713816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004358 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 13:19:06.169403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:19:06.169925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 13:19:06.170660) ========= ========= Total master_lag: 0.03 =========