builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1494236361.82 results: success (0) revision: 81977c96c6ff49e4b70f88a55f38d47f5e54a08b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:21.819117) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:21.819612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:21.819921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:21.861517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:21.861835) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 02:39:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.7K=0.2s 2017-05-08 02:39:23 (64.7 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.300054 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.176484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.176804) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.226146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.226489) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 81977c96c6ff49e4b70f88a55f38d47f5e54a08b --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 81977c96c6ff49e4b70f88a55f38d47f5e54a08b --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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 02:39:23,639 truncating revision to first 12 chars 2017-05-08 02:39:23,639 Setting DEBUG logging. 2017-05-08 02:39:23,639 attempt 1/10 2017-05-08 02:39:23,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/81977c96c6ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 02:39:24,040 unpacking tar archive at: mozilla-central-81977c96c6ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.950303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.950634) ========= script_repo_revision: 81977c96c6ff49e4b70f88a55f38d47f5e54a08b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.951148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.951441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 02:39:22.961504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-08 02:39:22.961829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:39:24 INFO - MultiFileLogger online at 20170508 02:39:24 in /builds/slave/test 02:39:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:39:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:39:24 INFO - {'append_to_log': False, 02:39:24 INFO - 'base_work_dir': '/builds/slave/test', 02:39:24 INFO - 'blob_upload_branch': 'Firefox', 02:39:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:39:24 INFO - 'branch': 'Firefox', 02:39:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:39:24 INFO - 'config_files': ('talos/linux_config.py',), 02:39:24 INFO - 'default_actions': ('clobber', 02:39:24 INFO - 'read-buildbot-config', 02:39:24 INFO - 'download-and-extract', 02:39:24 INFO - 'populate-webroot', 02:39:24 INFO - 'create-virtualenv', 02:39:24 INFO - 'install', 02:39:24 INFO - 'run-tests'), 02:39:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:39:24 INFO - 'download_minidump_stackwalk': True, 02:39:24 INFO - 'download_symbols': 'ondemand', 02:39:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:39:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:39:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:39:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:39:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:39:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:39:24 INFO - 'gecko_profile': False, 02:39:24 INFO - 'gecko_profile_interval': 0, 02:39:24 INFO - 'installer_path': 'installer.exe', 02:39:24 INFO - 'log_level': 'info', 02:39:24 INFO - 'log_name': 'talos', 02:39:24 INFO - 'log_to_console': True, 02:39:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:39:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:39:24 INFO - 'opt_config_files': (), 02:39:24 INFO - 'pip_index': False, 02:39:24 INFO - 'suite': 'dromaeojs-e10s', 02:39:24 INFO - 'system_bits': '32', 02:39:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:39:24 INFO - 'title': 'talos-linux64-ix-051', 02:39:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:39:24 INFO - 'use_talos_json': True, 02:39:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:39:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:39:24 INFO - 'work_dir': 'build'} 02:39:24 INFO - [mozharness: 2017-05-08 09:39:24.472898Z] Running clobber step. 02:39:24 INFO - Running pre-action listener: _resource_record_pre_action 02:39:24 INFO - Running main action method: clobber 02:39:24 INFO - rmtree: /builds/slave/test/build 02:39:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:39:25 INFO - Running post-action listener: _resource_record_post_action 02:39:25 INFO - [mozharness: 2017-05-08 09:39:25.416826Z] Finished clobber step (success) 02:39:25 INFO - [mozharness: 2017-05-08 09:39:25.416927Z] Running read-buildbot-config step. 02:39:25 INFO - Running pre-action listener: _resource_record_pre_action 02:39:25 INFO - Running main action method: read_buildbot_config 02:39:25 INFO - Using buildbot properties: 02:39:25 INFO - { 02:39:25 INFO - "project": "", 02:39:25 INFO - "product": "firefox", 02:39:25 INFO - "who": "cbook@mozilla.com", 02:39:25 INFO - "installer_path": "public/build/target.tar.bz2", 02:39:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:39:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:39:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:39:25 INFO - "stage_platform": "linux64-stylo", 02:39:25 INFO - "basedir": "/builds/slave/test", 02:39:25 INFO - "buildnumber": 72, 02:39:25 INFO - "platform": "ubuntu64_hw_stylo", 02:39:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:39:25 INFO - "slavebuilddir": "test", 02:39:25 INFO - "taskId": "IG7DvXNiQrmdMfN_udOhOQ", 02:39:25 INFO - "branch": "mozilla-central", 02:39:25 INFO - "script_repo_revision": "production", 02:39:25 INFO - "revision": "81977c96c6ff49e4b70f88a55f38d47f5e54a08b", 02:39:25 INFO - "slavename": "talos-linux64-ix-051", 02:39:25 INFO - "repo_path": "mozilla-central" 02:39:25 INFO - } 02:39:25 INFO - Finding installer, test and symbols from parent task. 02:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IG7DvXNiQrmdMfN_udOhOQ'}, attempt #1 02:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IG7DvXNiQrmdMfN_udOhOQ'}, attempt #1 02:39:26 INFO - Task dependencies: M0oXlh3BTCyGwJ2sHClpwA 02:39:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA'}, attempt #1 02:39:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 02:39:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/test_packages.json 02:39:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.crashreporter-symbols.zip 02:39:26 INFO - Running post-action listener: _resource_record_post_action 02:39:26 INFO - [mozharness: 2017-05-08 09:39:26.775632Z] Finished read-buildbot-config step (success) 02:39:26 INFO - [mozharness: 2017-05-08 09:39:26.775847Z] Running download-and-extract step. 02:39:26 INFO - Running pre-action listener: _resource_record_pre_action 02:39:26 INFO - Running main action method: download_and_extract 02:39:26 INFO - mkdir: /builds/slave/test/build/tests 02:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:26 INFO - trying https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.test_packages.json 02:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:39:27 INFO - Downloaded 986 bytes. 02:39:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:39:27 INFO - Using the following test package requirements: 02:39:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:39:27 INFO - u'common': [u'target.common.tests.zip'], 02:39:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:39:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:39:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:39:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:39:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:39:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:39:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:39:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:39:27 INFO - u'target.web-platform.tests.zip'], 02:39:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:39:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:39:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip 02:39:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:39:27 INFO - Fetch https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip into memory 02:39:30 INFO - Content-Length response header: 58454060 02:39:30 INFO - Bytes received: 58454060 02:39:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:39:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip 02:39:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:39:40 INFO - Fetch https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.common.tests.zip into memory 02:39:41 INFO - Content-Length response header: 58454060 02:39:41 INFO - Bytes received: 58454060 02:39:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.talos.tests.zip 02:39:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:39:52 INFO - Fetch https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.talos.tests.zip into memory 02:39:54 INFO - Content-Length response header: 14409362 02:39:54 INFO - Bytes received: 14409362 02:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:54 INFO - trying https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 02:39:54 INFO - Downloading https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:39:56 INFO - Downloaded 60000907 bytes. 02:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 02:39:56 INFO - mkdir: /builds/slave/test/properties 02:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:56 INFO - Contents: 02:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 02:39:56 INFO - Running post-action listener: _resource_record_post_action 02:39:56 INFO - Running post-action listener: set_extra_try_arguments 02:39:56 INFO - [mozharness: 2017-05-08 09:39:56.405612Z] Finished download-and-extract step (success) 02:39:56 INFO - [mozharness: 2017-05-08 09:39:56.405709Z] Running populate-webroot step. 02:39:56 INFO - Running pre-action listener: _resource_record_pre_action 02:39:56 INFO - Running main action method: populate_webroot 02:39:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:56 INFO - '--tppagecycles', 02:39:56 INFO - '7'], 02:39:56 INFO - 'tests': ['tsvgm']}}, 02:39:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['damp', 'tps']}, 02:39:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'tests': ['damp', 'tps']}, 02:39:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['dromaeo_dom']}, 02:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:39:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['a11yr', 02:39:56 INFO - 'ts_paint', 02:39:56 INFO - 'tpaint', 02:39:56 INFO - 'sessionrestore', 02:39:56 INFO - 'sessionrestore_no_auto_restore', 02:39:56 INFO - 'tabpaint']}, 02:39:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:39:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:39:56 INFO - 'bloom_basic_ref']}, 02:39:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['tsvgx', 02:39:56 INFO - 'tsvgr_opacity', 02:39:56 INFO - 'tart', 02:39:56 INFO - 'tscrollx', 02:39:56 INFO - 'cart', 02:39:56 INFO - 'tsvg_static']}, 02:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:56 INFO - 'tsvgr_opacity', 02:39:56 INFO - 'tart', 02:39:56 INFO - 'tscrollx', 02:39:56 INFO - 'cart', 02:39:56 INFO - 'tsvg_static']}, 02:39:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'talos_options': ['--disable-e10s'], 02:39:56 INFO - 'tests': ['tp5o']}, 02:39:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:39:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'talos_options': ['--disable-e10s', 02:39:56 INFO - '--xperf_path', 02:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:56 INFO - 'tests': ['tp5n']}, 02:39:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:39:56 INFO - 'talos_options': ['--xperf_path', 02:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:56 INFO - 'tests': ['tp5n']}}, 02:39:56 INFO - 'talos.zip': {'path': '', 02:39:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:56 INFO - Running post-action listener: _resource_record_post_action 02:39:56 INFO - [mozharness: 2017-05-08 09:39:56.419277Z] Finished populate-webroot step (success) 02:39:56 INFO - [mozharness: 2017-05-08 09:39:56.419365Z] Running create-virtualenv step. 02:39:56 INFO - Running pre-action listener: _resource_record_pre_action 02:39:56 INFO - Running main action method: create_virtualenv 02:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:39:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:56 INFO - Using real prefix '/usr' 02:39:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:58 INFO - Installing pip.................done. 02:39:58 INFO - Return code: 0 02:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:39:59 INFO - Reading from file tmpfile_stdout 02:39:59 INFO - Output received: 02:39:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:39:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:59 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:39:59 INFO - Cleaning up... 02:39:59 INFO - Return code: 0 02:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:59 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Downloading/unpacking psutil>=3.1.1 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:00 INFO - Installing collected packages: psutil 02:40:00 INFO - Running setup.py install for psutil 02:40:00 INFO - building 'psutil._psutil_linux' extension 02:40:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:40:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:40:01 INFO - building 'psutil._psutil_posix' extension 02:40:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:40:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:40:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:40:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:40:01 INFO - Successfully installed psutil 02:40:01 INFO - Cleaning up... 02:40:01 INFO - Return code: 0 02:40:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:01 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:40:01 INFO - Using env: {'DISPLAY': ':0', 02:40:01 INFO - 'HOME': '/home/cltbld', 02:40:01 INFO - 'LANG': 'en_US.UTF-8', 02:40:01 INFO - 'LANGUAGE': 'en_US:en', 02:40:01 INFO - 'LOGNAME': 'cltbld', 02:40:01 INFO - 'MAIL': '/var/mail/cltbld', 02:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:01 INFO - 'MOZ_NO_REMOTE': '1', 02:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:01 INFO - 'NO_EM_RESTART': '1', 02:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:01 INFO - 'PWD': '/builds/slave/test', 02:40:01 INFO - 'SHELL': '/bin/bash', 02:40:01 INFO - 'SHLVL': '1', 02:40:01 INFO - 'TERM': 'linux', 02:40:01 INFO - 'TMOUT': '86400', 02:40:01 INFO - 'USER': 'cltbld', 02:40:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:01 INFO - '_': '/tools/buildbot/bin/python'} 02:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:40:02 INFO - Installing collected packages: mozsystemmonitor 02:40:02 INFO - Running setup.py install for mozsystemmonitor 02:40:02 INFO - Successfully installed mozsystemmonitor 02:40:02 INFO - Cleaning up... 02:40:02 INFO - Return code: 0 02:40:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:40:02 INFO - Using env: {'DISPLAY': ':0', 02:40:02 INFO - 'HOME': '/home/cltbld', 02:40:02 INFO - 'LANG': 'en_US.UTF-8', 02:40:02 INFO - 'LANGUAGE': 'en_US:en', 02:40:02 INFO - 'LOGNAME': 'cltbld', 02:40:02 INFO - 'MAIL': '/var/mail/cltbld', 02:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:02 INFO - 'MOZ_NO_REMOTE': '1', 02:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:02 INFO - 'NO_EM_RESTART': '1', 02:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:02 INFO - 'PWD': '/builds/slave/test', 02:40:02 INFO - 'SHELL': '/bin/bash', 02:40:02 INFO - 'SHLVL': '1', 02:40:02 INFO - 'TERM': 'linux', 02:40:02 INFO - 'TMOUT': '86400', 02:40:02 INFO - 'USER': 'cltbld', 02:40:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:02 INFO - '_': '/tools/buildbot/bin/python'} 02:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:04 INFO - warning: no files found matching '*.txt' 02:40:04 INFO - no previously-included directories found matching 'build' 02:40:04 INFO - no previously-included directories found matching 'dist' 02:40:04 INFO - no previously-included directories found matching '.git*' 02:40:04 INFO - Installing collected packages: jsonschema, functools32 02:40:04 INFO - Running setup.py install for functools32 02:40:04 INFO - warning: no files found matching '*.txt' 02:40:04 INFO - no previously-included directories found matching 'build' 02:40:04 INFO - no previously-included directories found matching 'dist' 02:40:04 INFO - no previously-included directories found matching '.git*' 02:40:04 INFO - Successfully installed jsonschema functools32 02:40:04 INFO - Cleaning up... 02:40:04 INFO - Return code: 0 02:40:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:04 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:40:04 INFO - Using env: {'DISPLAY': ':0', 02:40:04 INFO - 'HOME': '/home/cltbld', 02:40:04 INFO - 'LANG': 'en_US.UTF-8', 02:40:04 INFO - 'LANGUAGE': 'en_US:en', 02:40:04 INFO - 'LOGNAME': 'cltbld', 02:40:04 INFO - 'MAIL': '/var/mail/cltbld', 02:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:04 INFO - 'MOZ_NO_REMOTE': '1', 02:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:04 INFO - 'NO_EM_RESTART': '1', 02:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:04 INFO - 'PWD': '/builds/slave/test', 02:40:04 INFO - 'SHELL': '/bin/bash', 02:40:04 INFO - 'SHLVL': '1', 02:40:04 INFO - 'TERM': 'linux', 02:40:04 INFO - 'TMOUT': '86400', 02:40:04 INFO - 'USER': 'cltbld', 02:40:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:04 INFO - '_': '/tools/buildbot/bin/python'} 02:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:40:04 INFO - Cleaning up... 02:40:04 INFO - Return code: 0 02:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:04 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:40:04 INFO - Using env: {'DISPLAY': ':0', 02:40:04 INFO - 'HOME': '/home/cltbld', 02:40:04 INFO - 'LANG': 'en_US.UTF-8', 02:40:04 INFO - 'LANGUAGE': 'en_US:en', 02:40:04 INFO - 'LOGNAME': 'cltbld', 02:40:04 INFO - 'MAIL': '/var/mail/cltbld', 02:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:04 INFO - 'MOZ_NO_REMOTE': '1', 02:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:04 INFO - 'NO_EM_RESTART': '1', 02:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:04 INFO - 'PWD': '/builds/slave/test', 02:40:04 INFO - 'SHELL': '/bin/bash', 02:40:04 INFO - 'SHLVL': '1', 02:40:04 INFO - 'TERM': 'linux', 02:40:04 INFO - 'TMOUT': '86400', 02:40:04 INFO - 'USER': 'cltbld', 02:40:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:04 INFO - '_': '/tools/buildbot/bin/python'} 02:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:06 INFO - Downloading docopt-0.6.1.tar.gz 02:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:06 INFO - Running setup.py install for blobuploader 02:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:06 INFO - Running setup.py install for requests 02:40:07 INFO - Running setup.py install for docopt 02:40:07 INFO - Successfully installed blobuploader requests docopt 02:40:07 INFO - Cleaning up... 02:40:07 INFO - Return code: 0 02:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40: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')]} 02:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40: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')]} 02:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:07 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:07 INFO - Using env: {'DISPLAY': ':0', 02:40:07 INFO - 'HOME': '/home/cltbld', 02:40:07 INFO - 'LANG': 'en_US.UTF-8', 02:40:07 INFO - 'LANGUAGE': 'en_US:en', 02:40:07 INFO - 'LOGNAME': 'cltbld', 02:40:07 INFO - 'MAIL': '/var/mail/cltbld', 02:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:07 INFO - 'MOZ_NO_REMOTE': '1', 02:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:07 INFO - 'NO_EM_RESTART': '1', 02:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:07 INFO - 'PWD': '/builds/slave/test', 02:40:07 INFO - 'SHELL': '/bin/bash', 02:40:07 INFO - 'SHLVL': '1', 02:40:07 INFO - 'TERM': 'linux', 02:40:07 INFO - 'TMOUT': '86400', 02:40:07 INFO - 'USER': 'cltbld', 02:40:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:07 INFO - '_': '/tools/buildbot/bin/python'} 02:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:07 INFO - Running setup.py (path:/tmp/pip-BgsWfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:07 INFO - Running setup.py (path:/tmp/pip-oCNMsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:07 INFO - Running setup.py (path:/tmp/pip-wjnPNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:07 INFO - Running setup.py (path:/tmp/pip-zS23ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:07 INFO - Running setup.py (path:/tmp/pip-CSh6Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:07 INFO - Running setup.py (path:/tmp/pip-9LP6j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:07 INFO - Running setup.py (path:/tmp/pip-VgawYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:07 INFO - Running setup.py (path:/tmp/pip-pLR_Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:08 INFO - Running setup.py (path:/tmp/pip-8hUGFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:08 INFO - Running setup.py (path:/tmp/pip-Mm5Jko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:08 INFO - Running setup.py (path:/tmp/pip-Gdl2y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:08 INFO - Running setup.py (path:/tmp/pip-V9OYI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:08 INFO - Running setup.py (path:/tmp/pip-Dmpt6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:08 INFO - Running setup.py (path:/tmp/pip-rWlj8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:08 INFO - Running setup.py (path:/tmp/pip-XTiS9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:08 INFO - Running setup.py (path:/tmp/pip-0UvgOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:08 INFO - Running setup.py (path:/tmp/pip-toSFxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:08 INFO - Running setup.py install for manifestparser 02:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for mozcrash 02:40:08 INFO - Running setup.py install for mozdebug 02:40:09 INFO - Running setup.py install for mozdevice 02:40:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for mozfile 02:40:09 INFO - Running setup.py install for mozhttpd 02:40:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for mozinfo 02:40:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for mozInstall 02:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for mozleak 02:40:09 INFO - Running setup.py install for mozlog 02:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for moznetwork 02:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Running setup.py install for mozprocess 02:40:09 INFO - Running setup.py install for mozprofile 02:40:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:10 INFO - Running setup.py install for mozrunner 02:40:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:10 INFO - Running setup.py install for mozscreenshot 02:40:10 INFO - Running setup.py install for moztest 02:40:10 INFO - Running setup.py install for mozversion 02:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:10 INFO - Cleaning up... 02:40:10 INFO - Return code: 0 02:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:10 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:10 INFO - Using env: {'DISPLAY': ':0', 02:40:10 INFO - 'HOME': '/home/cltbld', 02:40:10 INFO - 'LANG': 'en_US.UTF-8', 02:40:10 INFO - 'LANGUAGE': 'en_US:en', 02:40:10 INFO - 'LOGNAME': 'cltbld', 02:40:10 INFO - 'MAIL': '/var/mail/cltbld', 02:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:10 INFO - 'MOZ_NO_REMOTE': '1', 02:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:10 INFO - 'NO_EM_RESTART': '1', 02:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:10 INFO - 'PWD': '/builds/slave/test', 02:40:10 INFO - 'SHELL': '/bin/bash', 02:40:10 INFO - 'SHLVL': '1', 02:40:10 INFO - 'TERM': 'linux', 02:40:10 INFO - 'TMOUT': '86400', 02:40:10 INFO - 'USER': 'cltbld', 02:40:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:10 INFO - '_': '/tools/buildbot/bin/python'} 02:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:10 INFO - Running setup.py (path:/tmp/pip-UfjsrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:10 INFO - Running setup.py (path:/tmp/pip-Q2G9i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:10 INFO - Running setup.py (path:/tmp/pip-bhmEEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:10 INFO - Running setup.py (path:/tmp/pip-03JG8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:11 INFO - Running setup.py (path:/tmp/pip-fLZYwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:11 INFO - Running setup.py (path:/tmp/pip-y8cwad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:11 INFO - Running setup.py (path:/tmp/pip-2gFtLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:11 INFO - Running setup.py (path:/tmp/pip-rra7Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:11 INFO - Running setup.py (path:/tmp/pip-iRI7WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:11 INFO - Running setup.py (path:/tmp/pip-9NRIe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:11 INFO - Running setup.py (path:/tmp/pip-ZI25zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:11 INFO - Running setup.py (path:/tmp/pip-fsg6r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:11 INFO - Running setup.py (path:/tmp/pip-IpSIrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:11 INFO - Running setup.py (path:/tmp/pip-ZmV3Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:11 INFO - Running setup.py (path:/tmp/pip-fVmeSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:11 INFO - Running setup.py (path:/tmp/pip-2h7H11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:11 INFO - Running setup.py (path:/tmp/pip-GzeUmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:40:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:13 INFO - Downloading blessings-1.6.tar.gz 02:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:13 INFO - Installing collected packages: blessings 02:40:13 INFO - Running setup.py install for blessings 02:40:13 INFO - Successfully installed blessings 02:40:13 INFO - Cleaning up... 02:40:13 INFO - Return code: 0 02:40:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Current package versions: 02:40:13 INFO - argparse == 1.2.1 02:40:13 INFO - blessings == 1.6 02:40:13 INFO - blobuploader == 1.2.4 02:40:13 INFO - docopt == 0.6.1 02:40:13 INFO - functools32 == 3.2.3-2 02:40:13 INFO - jsonschema == 2.5.1 02:40:13 INFO - manifestparser == 1.1 02:40:13 INFO - mozInstall == 1.12 02:40:13 INFO - mozcrash == 1.0 02:40:13 INFO - mozdebug == 0.1 02:40:13 INFO - mozdevice == 0.50 02:40:13 INFO - mozfile == 1.2 02:40:13 INFO - mozhttpd == 0.7 02:40:13 INFO - mozinfo == 0.9 02:40:13 INFO - mozleak == 0.1 02:40:13 INFO - mozlog == 3.4 02:40:13 INFO - moznetwork == 0.27 02:40:13 INFO - mozprocess == 0.25 02:40:13 INFO - mozprofile == 0.28 02:40:13 INFO - mozrunner == 6.13 02:40:13 INFO - mozscreenshot == 0.1 02:40:13 INFO - mozsystemmonitor == 0.3 02:40:13 INFO - moztest == 0.8 02:40:13 INFO - mozversion == 1.4 02:40:13 INFO - psutil == 3.1.1 02:40:13 INFO - requests == 1.2.3 02:40:13 INFO - wsgiref == 0.1.2 02:40:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:40:13 INFO - Using env: {'DISPLAY': ':0', 02:40:13 INFO - 'HOME': '/home/cltbld', 02:40:13 INFO - 'LANG': 'en_US.UTF-8', 02:40:13 INFO - 'LANGUAGE': 'en_US:en', 02:40:13 INFO - 'LOGNAME': 'cltbld', 02:40:13 INFO - 'MAIL': '/var/mail/cltbld', 02:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:13 INFO - 'MOZ_NO_REMOTE': '1', 02:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:13 INFO - 'NO_EM_RESTART': '1', 02:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:13 INFO - 'PWD': '/builds/slave/test', 02:40:13 INFO - 'SHELL': '/bin/bash', 02:40:13 INFO - 'SHLVL': '1', 02:40:13 INFO - 'TERM': 'linux', 02:40:13 INFO - 'TMOUT': '86400', 02:40:13 INFO - 'USER': 'cltbld', 02:40:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:13 INFO - '_': '/tools/buildbot/bin/python'} 02:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:40:13 INFO - Cleaning up... 02:40:13 INFO - Return code: 0 02:40:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1934a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ada770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:40:13 INFO - Using env: {'DISPLAY': ':0', 02:40:13 INFO - 'HOME': '/home/cltbld', 02:40:13 INFO - 'LANG': 'en_US.UTF-8', 02:40:13 INFO - 'LANGUAGE': 'en_US:en', 02:40:13 INFO - 'LOGNAME': 'cltbld', 02:40:13 INFO - 'MAIL': '/var/mail/cltbld', 02:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:13 INFO - 'MOZ_NO_REMOTE': '1', 02:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:13 INFO - 'NO_EM_RESTART': '1', 02:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:13 INFO - 'PWD': '/builds/slave/test', 02:40:13 INFO - 'SHELL': '/bin/bash', 02:40:13 INFO - 'SHLVL': '1', 02:40:13 INFO - 'TERM': 'linux', 02:40:13 INFO - 'TMOUT': '86400', 02:40:13 INFO - 'USER': 'cltbld', 02:40:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:13 INFO - '_': '/tools/buildbot/bin/python'} 02:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:40:13 INFO - Cleaning up... 02:40:13 INFO - Return code: 0 02:40:13 INFO - Running post-action listener: _resource_record_post_action 02:40:13 INFO - Running post-action listener: _start_resource_monitoring 02:40:14 INFO - Starting resource monitoring. 02:40:14 INFO - [mozharness: 2017-05-08 09:40:14.014728Z] Finished create-virtualenv step (success) 02:40:14 INFO - [mozharness: 2017-05-08 09:40:14.015201Z] Running install step. 02:40:14 INFO - Running pre-action listener: _resource_record_pre_action 02:40:14 INFO - Running main action method: install 02:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:14 INFO - Reading from file tmpfile_stdout 02:40:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:14 INFO - Reading from file tmpfile_stdout 02:40:14 INFO - Output received: 02:40:14 INFO - Usage: mozinstall [options] installer 02:40:14 INFO - Options: 02:40:14 INFO - -h, --help show this help message and exit 02:40:14 INFO - -d DEST, --destination=DEST 02:40:14 INFO - Directory to install application into. [default: 02:40:14 INFO - "/builds/slave/test"] 02:40:14 INFO - --app=APP Application being installed. [default: firefox] 02:40:14 INFO - mkdir: /builds/slave/test/build/application 02:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:40:29 INFO - Reading from file tmpfile_stdout 02:40:29 INFO - Output received: 02:40:29 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:29 INFO - Running post-action listener: _resource_record_post_action 02:40:29 INFO - [mozharness: 2017-05-08 09:40:29.631715Z] Finished install step (success) 02:40:29 INFO - [mozharness: 2017-05-08 09:40:29.631989Z] Running run-tests step. 02:40:29 INFO - Running pre-action listener: _resource_record_pre_action 02:40:29 INFO - Running main action method: run_tests 02:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:29 INFO - Python 2.7.3 02:40:29 INFO - Return code: 0 02:40:29 INFO - grabbing minidump binary from tooltool 02:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:40:29 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 0x1ad7a30>, '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 0x1ad87f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad8ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:40:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:40:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:29 INFO - Return code: 0 02:40:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:29 INFO - ENV: RUST_BACKTRACE is now 1 02:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:40:29 INFO - Using env: {'DISPLAY': ':0', 02:40:29 INFO - 'HOME': '/home/cltbld', 02:40:29 INFO - 'LANG': 'en_US.UTF-8', 02:40:29 INFO - 'LANGUAGE': 'en_US:en', 02:40:29 INFO - 'LOGNAME': 'cltbld', 02:40:29 INFO - 'MAIL': '/var/mail/cltbld', 02:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:29 INFO - 'MOZ_NO_REMOTE': '1', 02:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:29 INFO - 'NO_EM_RESTART': '1', 02:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:29 INFO - 'PWD': '/builds/slave/test', 02:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:29 INFO - 'RUST_BACKTRACE': '1', 02:40:29 INFO - 'SHELL': '/bin/bash', 02:40:29 INFO - 'SHLVL': '1', 02:40:29 INFO - 'TERM': 'linux', 02:40:29 INFO - 'TMOUT': '86400', 02:40:29 INFO - 'USER': 'cltbld', 02:40:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491', 02:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:29 INFO - '_': '/tools/buildbot/bin/python'} 02:40:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:40:29 INFO - mozversion application_buildid: 20170508080408 02:40:29 INFO - mozversion application_changeset: 81977c96c6ff49e4b70f88a55f38d47f5e54a08b 02:40:29 INFO - mozversion application_display_name: Nightly 02:40:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:29 INFO - mozversion application_name: Firefox 02:40:29 INFO - mozversion application_remotingname: firefox 02:40:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:40:29 INFO - mozversion application_vendor: Mozilla 02:40:29 INFO - mozversion application_version: 55.0a1 02:40:29 INFO - mozversion platform_buildid: 20170508080408 02:40:29 INFO - mozversion platform_changeset: 81977c96c6ff49e4b70f88a55f38d47f5e54a08b 02:40:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:40:29 INFO - mozversion platform_version: 55.0a1 02:40:29 INFO - using testdate: 1494236429 02:40:29 INFO - actual date: 1494236429 02:40:29 INFO - starting webserver on 'localhost:34728' 02:40:29 INFO - SUITE-START | Running 2 tests 02:40:29 INFO - TEST-START | dromaeo_css 02:40:29 INFO - operating with platform_type : linux_ 02:40:29 INFO - Initialising browser for dromaeo_css test... 02:40:29 INFO - TEST-INFO | started process 6332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2VzUd/profile http://localhost:34728/getInfo.html) 02:40:34 INFO - PID 6332 | __metrics Screen width/height:1600/1200 02:40:34 INFO - PID 6332 | colorDepth:24 02:40:34 INFO - PID 6332 | Browser inner width/height: 1024/695 02:40:34 INFO - PID 6332 | __metrics 02:40:36 INFO - TEST-INFO | 6332: exit 0 02:40:36 INFO - Browser initialized. 02:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:36 INFO - TEST-INFO | started process 6523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_2VzUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:48 INFO - PID 6523 | RSS: Main: 174026752 02:40:48 INFO - PID 6523 | 02:43:53 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34728/tests/dromaeo/cssquery-ext.html) 02:43:54 INFO - PID 6523 | RSS: Main: 181891072 02:43:54 INFO - PID 6523 | 02:46:57 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-ext.html (next: http://localhost:34728/tests/dromaeo/cssquery-jquery.html) 02:46:57 INFO - PID 6523 | RSS: Main: 179085312 02:46:57 INFO - PID 6523 | 02:49:59 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34728/tests/dromaeo/cssquery-mootools.html) 02:50:00 INFO - PID 6523 | RSS: Main: 188604416 02:50:00 INFO - PID 6523 | 02:53:02 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34728/tests/dromaeo/cssquery-prototype.html) 02:53:02 INFO - PID 6523 | RSS: Main: 180150272 02:53:02 INFO - PID 6523 | 02:56:05 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34728/tests/dromaeo/cssquery-yui.html) 02:56:06 INFO - PID 6523 | RSS: Main: 185872384 02:56:06 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | Cycle 1(1): loaded http://localhost:34728/tests/dromaeo/cssquery-yui.html (next: http://localhost:34728/tests/dromaeo/cssquery-dojo.html) 02:59:08 INFO - PID 6523 | RSS: Main: 190058496 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | __start_tp_report 02:59:08 INFO - PID 6523 | _x_x_mozilla_page_load 02:59:08 INFO - PID 6523 | _x_x_mozilla_page_load_details 02:59:08 INFO - PID 6523 | |i|pagename|runs| 02:59:08 INFO - PID 6523 | |0;dojo.html;2760.696323404425;2771.4180022195337;2790.079273839633;2806.887724491019;2813.366992426704;5267.367915850094;5348.331458567679;5378.462153784624;5399.946000539993;5406.053940560401;5347.893042139155;5350.973245133779;5363.570914326854;5437.619366644337;5475.370332411774;4450.198964186445;4765.928511072345;4780.259059845712;4790.520947905216;4797.736124513151;4812.374391329122;4863.756812159396;4881.560659540641;4883.389576302962;4922.138625740481;4654.767261636938;4732.2428411454;4769.308450274691;4786.95213047872;4791.904161916742;4790.616750659939;4798.856034318976;4817.349657796188;4837.443693975168;4864.756762161877;4712.481627021025;4753.191957367256;4759.214729569617;4768.856934291976;4784.784684689197;5098.719570423626;5160.922586161173;5240.633155679104;5269.420363759983;5281.102212623825;5709.77160913563;5731.971340143273;5747.166660834156;5834.824955251307;5853.50245229156;5903.380145084747;5914.733836977303;5915.497182739429;5922.526197904157;5940.435658612425;5414.998225328327;5419.701916394597;5420.945790542123;5425.945740542544;5436.646617969819;5918.496927761103;6010.368911264254;6012.218411606463;6031.909521357183;6035.909461358083;5482.862928426821;5581.995240856603;5637.633553818989;5729.312482502043;5736.340320863071;5803.88392232153;5816.505597024216;5834.212381328552;5850.473457388855;5873;5753.223314852525;5787.826365208966;5792.507636850914;5793.304803423616;5806.535477161817;5610.270664813548;5706.942930570641;5709.51469125129;5715.8571035724435;5784.537237021028;4782.450018247877;4792.856214313576;4795.112904112681;4798.904021919612;4807.351007613997;4114.773687447159;4156.127213285184;4163.75017498951;4171.436856024458;4213.157368526307;4923.556879880828;4935.037667654773;4950.628702847301;4952.479989601112;4967.776450059756;5804.2744656917885;5837.299524057055;5871.941280587225;5873.882522349529;5884.499817515559;4906.411230652345;4916.70499770015;4922.310876477296;4926.655134140576;4973.154563724175;5020.046191223656;5110.488951104934;5113.488651134857;5116.027954688598;5151.201563757623;5251.606129540376;5354.705491197944;5356.116240820221;5368.033753924331;5369.3019907413345;5912;5917.023691090922;5919.526437885045;5930.169776231245;5935.198748169115;5382;5414.783408663767;5419.620626556103;5421.213923980922;5457.017736807413;5715.714214289185;5763.452472015152;5765.91351129725;5769.59612827098;5771.913421298768;5693.459121383462;5700.429957004432;5810.767569297181;5837.766489340549;5853.473187413153;5634.6337488063145;5635.971820140873;5641.633293835887;5645.774169033357;5703.572232082527;5558.527525160407;5598.384177740364;5631.183478395692;5641.153826925994;5657.066584013756;5376.892462150657;5462.399136094947;5470.6991115487435;5563.638363506359;5576.0799468088935;5650.26546548946;5669.149627555899;5692.0608099663095;5722.17028530869;5759.193712880284;5507.889842203213;5522.6134170609275;5530.612857100125;5532.612717109763;5535.5848311376 02:59:08 INFO - PID 6523 | |1;ext.html;710.6340234779088;728.4354625165498;1048.5491238767327;1063.8457423673563;1147.5581900968125;32321;33273;33310.66689333106;33338.49992250112;33401.66598334016;30748.53877191844;30952.845235773788;31090.68909310912;31100.533491997638;31246;6377.107204991305;6391.872162556746;6481.31946145655;6504.739810407578;7079.504434689574;6819.283975182584;6841.281665425134;6877.724891004379;6893.931060689404;6903.861922761542;6859.622720750357;6909.896351554706;6922.996165555991;6926.37662610365;6934.895976560356;6878.209005964328;6895.862082758316;6897.862042759142;6902.309769023108;6908.827279318007;6961.930380696179;6991.82520436988;6992.3007699230175;6993.475489338269;7042.0493233413345;30245.697543024507;30459.543106853416;30497.23756906073;30682.693173068208;30724;3013.322002549409;3053.2366908272934;3055.6027716396948;3061.0204734484973;3065.249013991564;24526.264212073667;24579.262622121187;24612.384690382703;24732;24747.752522474726;2529.45616692412;2552.068494999312;2556.974430255711;2558.7569180927967;2560.8719564021726;149017;149083.25458372638;149098;149289;149441.30866259104;37723.62276377201;39828.20343593112;39974.20051598952;40373.798131009156;40542.79728601338;41344;41408.792956035024;41522.58477415248;41661;41699.1660166795;11230;11302.773944521228;11308.604198853001;11315.98156165949;11321.660350189508;8647.567621618893;8730.91269087301;8737.956310218407;8762.561871906379;8775.210231079234;12552.121351505308;12658.620241392773;12682.429290681941;12751.936240318739;12892.935535322264;5263.973680131651;5320.654157479751;5334.253204551366;5355.143177091647;5395.379531353945;878.7012415778665;902.9390466202186;914.5747227539226;917.3853518142861;939.6241503398559;20382.898085509772;20951.580968380546;21085.57828843445;21101.894490527757;21414;991.6281394477071;1004.2417974429259;1020.8009438159636;1023.534291897185;1024.257413375297;10900.291481053864;11164.720881978015;11251.324920504796;11322;11353.318800871974;183944;184446;184659;184731;184860;39169.6083039166;39249.41125883057;39535.813925582275;39604.20791584152;39764;1071.2608300272786;1115.5928086248462;1120.4621781544904;1124.8368986497076;1236.771197328497;18911.527211819815;19799.60400792005;20214.797852021293;20303.8984805075;20483.897580512003;28873.422531548833;28892.85553572219;28911.7108828909;28932.42135157327;29000.12999610015;151814;154022.22988884983;154135;154380.2280988588;154971;27881.860590696917;28039.158825235274;28629.570556442086;29239.561406578494;30009.249768755082;34641.13397165091;34924.47613285854;34949.60201591908;35161;35840.64159358373;26451.735482645698;26788.19635410941;26874.05940792141;27130.794726817374;27761.86119069392;26376.340591485365;26970.190894273204;27384.726152738218;27698.72301277042;27774.166774996782;28862.278443039093;29345.7065429343;29793.25516862096;30003.399932001674;30102.69897300999;25916;26204.475910481302;26875.86562067177;27332.043378481656;27356.316092097855;20567.09225247258;22271.665925010813;22346.66480002834;22441.551168976857;22521.774782251967 02:59:08 INFO - PID 6523 | |2;jquery.html;387.37245662027505;389.171065630208;422.39386480400617;423.0354791076345;430.9245881970654;12801.487940482393;16817;17107.973521588712;17534.649307013853;17541.473755787316;18125.637487250246;18537.629247415043;18674.439766807016;18685;18719.532011699714;5276.839095399026;5406.702631355274;5446.074167391553;5474.206240095184;5522.91715624266;5487.6433031853;5580.162975553659;5580.665160090408;5587.329520457551;5598.804041858536;5337.14605663094;5419.729013549327;5497.147942068986;5507.889842203153;5542.418046105161;5413.539849112791;5435.592330575203;5439.265699130626;5495.093309603911;5501.229827824108;4722.126406614787;4825.059113472874;4852.4662287148385;4856.878578035542;4870.172070747982;21110.26114086015;21167.576648467097;21462.356129316144;21482.677759833616;21661.35015949524;1606.9357225710958;1634.4442889417655;1664.3176297717998;1673.5230459319157;1674.815770265282;14174.858251417458;14265;14536.563903082924;14548.1998490083;14645;2033.2680235115347;2082.2191678120703;2083.749950005994;2086.478380404899;2091.1739862754125;87811;89600;90176.54911725465;91597.54201229019;93182.53408732981;10672;10731.89268107309;10890.61882834097;11025.83461248082;11138.832917506244;14046.789298160536;15084.773728394082;15271.334879628808;15272.694546109016;15321.923390382977;7484.989526413973;7690.307872291409;7796.376289896794;7824.061112666516;7827.921720782833;7024.683889224997;7081.539699919489;7135.714571417189;7309.378702810321;7315;6828.624425656637;6903.896441553381;6927.896081558781;6928.16861976566;6944.4097251734165;2008.7489063867017;2052.2817014044963;2062.742157230346;2070.7265032005507;2160.12514931453;861.7371701630938;903.114947351586;905.5472263868066;905.6332185464897;930.093159169804;16719.16404179786;16938.23777929996;17352.739708904122;17405.738913916302;17562.736558951627;903.1645727701849;907.3603109807569;915.9404638698463;919.632147141149;922.7416323429317;8850.291976641853;9152.8627070594;9477.099675530813;9541.570629321697;9714.077162669535;360266;363137;374494;377923;383142;74886.62556687182;78125.21874781293;79742;80453.59773201097;81086;1095.315427857589;1108.0581505720234;1153.4866984191954;1156.9363684997406;1157.3229660648446;16848.57878553046;17255.3960611378;17667.204975775865;17783.555411114827;17813.554661133574;37358.813205933795;38677.613223868524;39394.803025984686;39639.40540891947;39900.8004959985;44361.55638443703;44872.32691509695;44954.55045449635;46782.064358711956;49698;7848.960755196187;8011.759647210593;8163.510189388656;8259.297959673495;8377.204165604258;11526.711832204262;11551.653450396501;11851.111166662362;12036.277823330629;12090.516379344728;11004.339739615649;11066.39134847591;11073.612423565459;11321.094312455149;11552.306861588331;10107.949460252947;10769.9461502692;10931.617393391192;10962.671119866416;11225.831612525983;11151.219414641222;11264.943675281898;11515.884841151481;11661.883381166419;11726.88273117258;7821.217878212134;7834.0599128105;7890.723824666109;7893.921060789548;7903.802404939923;11094.778104437704;11183.72040698989;11343.489542970421;11542.902269694137;11647.76704465923 02:59:08 INFO - PID 6523 | |3;mootools.html;1256.6418570707347;1292.3393439430333;1301.7331447053355;1306.2423794199372;1306.9607911762644;9080.72757817265;9460.905390946089;9478;9478.431294122358;9719.222462203024;9406.811863762738;9580.80838383232;9588.760280992961;9608.231341492681;9621.422714637127;2176.2274392590602;2203.8457307988447;2217.6008318502663;2218.6006518826603;2219.8224142068675;1982.157583027215;2027.3613811649357;2029.5433527456278;2033.6237796007713;2034.5422279986958;2154.396768904709;2168.3928500019942;2178.4880553070016;2200.977990220101;2209.668549717547;2064.0505367530955;2098.3390232076845;2113.006886763219;2116.5661039486945;2125.415510734545;2032.9491762705902;2057.207974929648;2101.170037835062;2175.445261458318;2209.690643309938;9358.859617105749;9389.061093890625;9440.10319019692;9514.666986655504;9544.761380965461;5040.042391945555;5244.79020839166;5254.500822421864;5278.709670968095;5289.418164001957;2990.566367876646;3188.2188863728534;3207.96792032079;3237.919052023695;3250.2849373137874;1028.711960651019;1044.3211912257018;1059.327327147267;1072.2708558180434;1079.7246702090995;13513.527026554122;13726.519571815039;13789.241591712453;13802.930985345009;13842.861571384257;4598.977005114953;4605.93091103627;4832.758362081881;4859.805607775649;4870.707757534559;11535.596254131066;11572;11587.826182607268;11616.88383116175;11696.590619328283;5249.790008399621;5259.789608415621;5261.894762104736;5272.947270527322;5282.445343238905;4622.607078398374;4712.481627021025;4743.430788305356;4809.062232864558;4843.491433399513;4157.819804818985;4167.333226683716;4188.036751547162;4212.620864122244;4263.126059157865;1275.0628288208159;1303.7887326041487;1322.7156161425148;1324.1723922548408;1332.1740520877117;715.8103102677794;734.2253922112117;736.1276886889053;746.7573038762424;751.2825251884437;5372.113601255827;5410.431904650034;5460.34475862899;5503.642263252956;5544.584156188302;532.3026834846364;545.6780499505311;548.1886807524885;551.5918220516788;557.5336864047529;3375.696187343151;3386.7299762589028;3564.697000754913;3650.2152037311575;3664.0839790052487;11754;11865.228760130563;12169.574064907685;12232.633021009384;12301.815472767916;11437.71405714847;11784.88215117855;11818.763624727457;11915.642530724092;12126.090543209295;6635.900461493082;6707.128073350531;6798.320167983261;6800.251972283045;6823;5550.306211723535;5567.4432556744005;5677.148427735872;5804.361520232856;5810.1575271586225;10838.783224335626;10881.727956800827;11021.83467248008;11113.333200008025;11116.833247501456;11047.558097676003;11078.224524283223;11082.279651822606;11113.83329250078;11369.715757106138;7477.401807855467;7571;7581.431392645684;7596.582187979714;7601.695932162652;8733.606987685696;8777.868331975153;8856.690015849414;8940.374173807772;8953.104689530996;7609.467337286337;7632.961835190788;7712.190220026816;7718;7756.340711039625;7437.442191835526;7515.39876809843;7533.773986780406;7618.8095297618;7665.923340766521;6984.546004509691;7141.857162856818;7149.14210294768;7153.892691609526;7155.964220178866;4848.418189817245;4909.993451342395;4927.359443272351;4932.778024988956;5130.358705161855;4942.604591632589;5017.874553136201;5120.897582048264;5132.358455193101;5184.144616138446 02:59:08 INFO - PID 6523 | |4;prototype.html;360.78713559000204;372.0846717075993;379.684861564901;389.59482138575885;391.4109265555339;5477.424870388611;5507.779688812448;5563.749631266587;5573.275474188355;5622;5344.305240318763;5423.457654234575;5461.563074954004;5466.781328746845;5474.343078830546;4002.539707933581;4114.609112134357;4119.649829764474;4133.214689209056;4141.254574176647;4120.423140760296;4130.380442933554;4131.801777484541;4149.917001659965;4153.854615088472;4105.2405305018665;4106.733062350952;4109.568495307994;4130.442390277319;4142.2543942090415;4069.776162311072;4102.220578090183;4115.588441155861;4142.233686767958;4142.523609784883;3557.1462848916076;3582.874599389009;3587.4798154267746;3593.4070878305047;3605.603383627799;5199.024370739133;5213.4525874782985;5215.295935048758;5226.451222621646;5236.476352364771;4744.572988431023;4858.344123543312;4867.196912509432;4876.536729010773;4902.632302577285;5760.395158508338;5773.134029895507;5810.605454690886;5819.679917604572;5887.587868849182;4009.719319647626;4025.2754504189234;4025.4565633639377;4039.4748682671066;4042.9797851010558;6012.488938440238;6112.297085835142;6139.6009259398;6161.383861613847;6207.751689932397;4002.6197511236387;4058.2086493134148;4063.4920634920636;4063.553009168989;4077.8164982575854;4120.835166593302;4122.175564887035;4128.545859955462;4130.710850240454;4139.317012692872;4691.976540117277;4768.880777980509;4784.593309568656;4791.808327666924;4799.6400269979895;5841.474267315962;5842.766289348378;5843.2403787507355;5855.414458554111;5858.2677165354335;1429.6997630497713;1449.9855001450062;1450.311102226434;1455.7306898223862;1457.32962837094;907.7080372060468;945.8061097475002;970.4322971062007;975.7414285214423;980.1472718734603;5056.747162641853;5065.189569668835;5072.213806859942;5090.363704536933;5093.796248150106;6055.1522786809;6055.364186760415;6056.182415373956;6058.636481811105;6060.2424696912885;4829.541193586604;5020.648554601143;5030.396352437658;5037.622178336639;5050.3182070420025;3202.551642770014;3202.9679703203137;3204.295055087877;3229.3056992746674;3236.7086962173516;5434.673919564839;5590.524805391506;5594.440555944373;5594.86012849682;5605.691686957175;6008.579399442085;6117.541184411187;6183.805603293165;6192.721327540272;6210.254769427607;5600.663960162403;5612.719364031782;5620.269364982526;5624.7063175469875;5627.465390787868;6052.546059045677;6078.118672792332;6082.878342433038;6097.634141951497;6101.60339577926;5795.478406943395;5963.165156878127;5980.312264089685;6044.516438684983;6056.424639659225;5649;5666.263385759825;5675.886482270249;5677.914831277617;5690.71546422669;4054.9189016220103;4133.090720041586;4149.257311929057;4157.75053496779;4163.208990291956;6071.848203794763;6077.149199112217;6089.48239399656;6098.146259523759;6100.847478813065;5824.126381042877;5840.970795145997;5851.824445266649;5854.356020837619;5864.944310024237;5703.401142879938;5773.971130144322;5813.970930145322;5831.679257640871;5836.212111364912;5712.02895507773;5719.428057194247;5754.9424505754405;5766.192733017297;5773.769049237983;5786.42135786418;5845;5871.236739223874;5882.294124705063;5904.232449781673;5652.293463317085;5662.943370566241;5666.744996475086;5670.489655930986;5713.400247930586 02:59:08 INFO - PID 6523 | |5;yui.html;714.814148321437;747.7980945144811;748.397539980316;750.7147284032068;763.1490887660257;12929.288889111094;13123.409446574904;13439.992000599945;14174.929125354372;14189.92905035476;14882.925585372084;15507.534773956771;15517.612059698486;15542.067475951451;15798.368065277375;831.4055450352996;848.3086284677968;848.3976376772468;849.1890244816186;849.3884403229696;908.2915326045695;909.2998391238742;910.4264313482497;915.4324318922278;919.1497864475367;954.9236061115095;959.1176117971448;959.4818797849188;961.7932144588912;963.032152686549;942.9905700943006;944.0512285153445;947.1570302430807;950.8003319302954;951.457669128597;696.3384784454788;700.7652436433801;702.5293053654065;702.6346299924062;703.2299631903109;14155.150690958473;14229.78655320171;14417.71164576713;14453.638659033608;14537.491187808377;14849.777253341208;15153.772693409608;15209.163496007715;15332.463363782326;15459.304331305118;11905.821412678817;12071.336076515789;12111.636650900487;12163.695907602292;12199.390030498529;2798.9440211195865;2819.36564273039;2829.5614179802164;2832.433513297349;2840.1763488588285;65824;66437.33562664312;66526.3347366525;66991.66504167496;67626.66186669035;10662.200334974908;10808.513616887101;10866.728331791768;10883.18376121794;10920.235583509237;17266.827331726774;17354;17416.129193540273;17448.912755436395;17460.738088928676;5230.084735171406;5394.190871369326;5546.63946843462;5771.567132465082;5987.341392446828;2620.5283049050972;2663.8135330526675;2671.919842404731;2675;2688.180105067973;3381.408253555618;3476.0962149841225;3487.9651203487642;3513.8243087845503;3519.1026288296835;638.9872202555923;648.931862154467;649.9415052645285;650.7917466410703;650.9869802603921;607.6202373516552;609.7012463892661;614.2506142506136;614.7080136935009;631.5263552335748;8847.73456796297;9145.542722863831;9319.580618872167;9379.5310234488;9552.14030737223;589.8731772668897;600.2976517474565;600.5795942839942;605.5065121925617;610.3133974278936;4348.934765978513;4417.536158703354;4452.5992660660695;4499.280115181556;4604.079184163181;63443.6827815858;65113;65186;65706.34293657003;67217.66391168012;59346.10980835291;59388.40611593915;59962.700186499664;60170.39829601648;60614.696926515084;51423.20018799324;52496.47503524916;52687.73656131772;54127;54762.45237547573;9108.544572771203;9280.118388753057;9356.391834530734;9406.200472959876;9559;26673.19980400591;26788.732112678623;26863.731362686904;27120.508372038938;27123.457530849668;32741.672583273863;32768.1807954803;32901.50647740334;33085.33829323448;33491.66508334885;11440.141989350666;11605.419729013684;11883.58407455735;12009.939950300193;12075.215111017756;12911.870881291443;13138.868611313765;13184.208947463183;13249.072564920363;13431.529896453578;12182.573609923611;12420.192687475284;12471.625851224479;12635.494580217057;12829;11823.467943942715;11836.76326473483;11893.583724569598;11970.521179152736;12009.63971080869;11722.824157637471;11827.290362578273;11890.10824188172;12034.63896083119;12144.332061736335;8652.480851148952;8673.176048275403;8677.435966662148;8961.731148065568;8982.01197868247;9229;9876.851847222153;9880.160186384237;10034.749131271778;10058.044485774133 02:59:08 INFO - PID 6523 | __end_tp_report 02:59:08 INFO - PID 6523 | __start_cc_report 02:59:08 INFO - PID 6523 | _x_x_mozilla_cycle_collect,356 02:59:08 INFO - PID 6523 | __end_cc_report 02:59:08 INFO - PID 6523 | __startTimestamp1494237548443__endTimestamp 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | ------- Summary: start ------- 02:59:08 INFO - PID 6523 | Number of tests: 6 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#0] dojo.html Cycles:165 Average:5295.22 Median:5436.65 stddev:632.91 (11.6%) stddev-sans-first:602.81 02:59:08 INFO - PID 6523 | Values: 2760.7 2771.4 2790.1 2806.9 2813.4 5267.4 5348.3 5378.5 5399.9 5406.1 5347.9 5351.0 5363.6 5437.6 5475.4 4450.2 4765.9 4780.3 4790.5 4797.7 4812.4 4863.8 4881.6 4883.4 4922.1 4654.8 4732.2 4769.3 4787.0 4791.9 4790.6 4798.9 4817.3 4837.4 4864.8 4712.5 4753.2 4759.2 4768.9 4784.8 5098.7 5160.9 5240.6 5269.4 5281.1 5709.8 5732.0 5747.2 5834.8 5853.5 5903.4 5914.7 5915.5 5922.5 5940.4 5415.0 5419.7 5420.9 5425.9 5436.6 5918.5 6010.4 6012.2 6031.9 6035.9 5482.9 5582.0 5637.6 5729.3 5736.3 5803.9 5816.5 5834.2 5850.5 5873.0 5753.2 5787.8 5792.5 5793.3 5806.5 5610.3 5706.9 5709.5 5715.9 5784.5 4782.5 4792.9 4795.1 4798.9 4807.4 4114.8 4156.1 4163.8 4171.4 4213.2 4923.6 4935.0 4950.6 4952.5 4967.8 5804.3 5837.3 5871.9 5873.9 5884.5 4906.4 4916.7 4922.3 4926.7 4973.2 5020.0 5110.5 5113.5 5116.0 5151.2 5251.6 5354.7 5356.1 5368.0 5369.3 5912.0 5917.0 5919.5 5930.2 5935.2 5382.0 5414.8 5419.6 5421.2 5457.0 5715.7 5763.5 5765.9 5769.6 5771.9 5693.5 5700.4 5810.8 5837.8 5853.5 5634.6 5636.0 5641.6 5645.8 5703.6 5558.5 5598.4 5631.2 5641.2 5657.1 5376.9 5462.4 5470.7 5563.6 5576.1 5650.3 5669.1 5692.1 5722.2 5759.2 5507.9 5522.6 5530.6 5532.6 5535.6 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#1] ext.html Cycles:180 Average:30195.13 Median:29119.85 stddev:42174.26 (144.8%) stddev-sans-first:42234.46 02:59:08 INFO - PID 6523 | Values: 710.6 728.4 1048.5 1063.8 1147.6 32321.0 33273.0 33310.7 33338.5 33401.7 30748.5 30952.8 31090.7 31100.5 31246.0 6377.1 6391.9 6481.3 6504.7 7079.5 6819.3 6841.3 6877.7 6893.9 6903.9 6859.6 6909.9 6923.0 6926.4 6934.9 6878.2 6895.9 6897.9 6902.3 6908.8 6961.9 6991.8 6992.3 6993.5 7042.0 30245.7 30459.5 30497.2 30682.7 30724.0 3013.3 3053.2 3055.6 3061.0 3065.2 24526.3 24579.3 24612.4 24732.0 24747.8 2529.5 2552.1 2557.0 2558.8 2560.9 149017.0 149083.3 149098.0 149289.0 149441.3 37723.6 39828.2 39974.2 40373.8 40542.8 41344.0 41408.8 41522.6 41661.0 41699.2 11230.0 11302.8 11308.6 11316.0 11321.7 8647.6 8730.9 8738.0 8762.6 8775.2 12552.1 12658.6 12682.4 12751.9 12892.9 5264.0 5320.7 5334.3 5355.1 5395.4 878.7 902.9 914.6 917.4 939.6 20382.9 20951.6 21085.6 21101.9 21414.0 991.6 1004.2 1020.8 1023.5 1024.3 10900.3 11164.7 11251.3 11322.0 11353.3 183944.0 184446.0 184659.0 184731.0 184860.0 39169.6 39249.4 39535.8 39604.2 39764.0 1071.3 1115.6 1120.5 1124.8 1236.8 18911.5 19799.6 20214.8 20303.9 20483.9 28873.4 28892.9 28911.7 28932.4 29000.1 151814.0 154022.2 154135.0 154380.2 154971.0 27881.9 28039.2 28629.6 29239.6 30009.2 34641.1 34924.5 34949.6 35161.0 35840.6 26451.7 26788.2 26874.1 27130.8 27761.9 26376.3 26970.2 27384.7 27698.7 27774.2 28862.3 29345.7 29793.3 30003.4 30102.7 25916.0 26204.5 26875.9 27332.0 27356.3 20567.1 22271.7 22346.7 22441.6 22521.8 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#2] jquery.html Cycles:180 Average:24922.75 Median:210909.81 stddev:61953.95 (29.4%) stddev-sans-first:62100.36 02:59:08 INFO - PID 6523 | Values: 387.4 389.2 422.4 423.0 430.9 12801.5 16817.0 17108.0 17534.6 17541.5 18125.6 18537.6 18674.4 18685.0 18719.5 5276.8 5406.7 5446.1 5474.2 5522.9 5487.6 5580.2 5580.7 5587.3 5598.8 5337.1 5419.7 5497.1 5507.9 5542.4 5413.5 5435.6 5439.3 5495.1 5501.2 4722.1 4825.1 4852.5 4856.9 4870.2 21110.3 21167.6 21462.4 21482.7 21661.4 1606.9 1634.4 1664.3 1673.5 1674.8 14174.9 14265.0 14536.6 14548.2 14645.0 2033.3 2082.2 2083.7 2086.5 2091.2 87811.0 89600.0 90176.5 91597.5 93182.5 10672.0 10731.9 10890.6 11025.8 11138.8 14046.8 15084.8 15271.3 15272.7 15321.9 7485.0 7690.3 7796.4 7824.1 7827.9 7024.7 7081.5 7135.7 7309.4 7315.0 6828.6 6903.9 6927.9 6928.2 6944.4 2008.7 2052.3 2062.7 2070.7 2160.1 861.7 903.1 905.5 905.6 930.1 16719.2 16938.2 17352.7 17405.7 17562.7 903.2 907.4 915.9 919.6 922.7 8850.3 9152.9 9477.1 9541.6 9714.1 360266.0 363137.0 374494.0 377923.0 383142.0 74886.6 78125.2 79742.0 80453.6 81086.0 1095.3 1108.1 1153.5 1156.9 1157.3 16848.6 17255.4 17667.2 17783.6 17813.6 37358.8 38677.6 39394.8 39639.4 39900.8 44361.6 44872.3 44954.6 46782.1 49698.0 7849.0 8011.8 8163.5 8259.3 8377.2 11526.7 11551.7 11851.1 12036.3 12090.5 11004.3 11066.4 11073.6 11321.1 11552.3 10107.9 10769.9 10931.6 10962.7 11225.8 11151.2 11264.9 11515.9 11661.9 11726.9 7821.2 7834.1 7890.7 7893.9 7903.8 11094.8 11183.7 11343.5 11542.9 11647.8 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#3] mootools.html Cycles:180 Average:5915.70 Median:4820.91 stddev:3708.50 (76.9%) stddev-sans-first:3702.38 02:59:08 INFO - PID 6523 | Values: 1256.6 1292.3 1301.7 1306.2 1307.0 9080.7 9460.9 9478.0 9478.4 9719.2 9406.8 9580.8 9588.8 9608.2 9621.4 2176.2 2203.8 2217.6 2218.6 2219.8 1982.2 2027.4 2029.5 2033.6 2034.5 2154.4 2168.4 2178.5 2201.0 2209.7 2064.1 2098.3 2113.0 2116.6 2125.4 2032.9 2057.2 2101.2 2175.4 2209.7 9358.9 9389.1 9440.1 9514.7 9544.8 5040.0 5244.8 5254.5 5278.7 5289.4 2990.6 3188.2 3208.0 3237.9 3250.3 1028.7 1044.3 1059.3 1072.3 1079.7 13513.5 13726.5 13789.2 13802.9 13842.9 4599.0 4605.9 4832.8 4859.8 4870.7 11535.6 11572.0 11587.8 11616.9 11696.6 5249.8 5259.8 5261.9 5272.9 5282.4 4622.6 4712.5 4743.4 4809.1 4843.5 4157.8 4167.3 4188.0 4212.6 4263.1 1275.1 1303.8 1322.7 1324.2 1332.2 715.8 734.2 736.1 746.8 751.3 5372.1 5410.4 5460.3 5503.6 5544.6 532.3 545.7 548.2 551.6 557.5 3375.7 3386.7 3564.7 3650.2 3664.1 11754.0 11865.2 12169.6 12232.6 12301.8 11437.7 11784.9 11818.8 11915.6 12126.1 6635.9 6707.1 6798.3 6800.3 6823.0 5550.3 5567.4 5677.1 5804.4 5810.2 10838.8 10881.7 11021.8 11113.3 11116.8 11047.6 11078.2 11082.3 11113.8 11369.7 7477.4 7571.0 7581.4 7596.6 7601.7 8733.6 8777.9 8856.7 8940.4 8953.1 7609.5 7633.0 7712.2 7718.0 7756.3 7437.4 7515.4 7533.8 7618.8 7665.9 6984.5 7141.9 7149.1 7153.9 7156.0 4848.4 4910.0 4927.4 4932.8 5130.4 4942.6 5017.9 5120.9 5132.4 5184.1 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#4] prototype.html Cycles:180 Average:4782.71 Median:5475.88 stddev:1433.34 (26.2%) stddev-sans-first:1398.40 02:59:08 INFO - PID 6523 | Values: 360.8 372.1 379.7 389.6 391.4 5477.4 5507.8 5563.7 5573.3 5622.0 5344.3 5423.5 5461.6 5466.8 5474.3 4002.5 4114.6 4119.6 4133.2 4141.3 4120.4 4130.4 4131.8 4149.9 4153.9 4105.2 4106.7 4109.6 4130.4 4142.3 4069.8 4102.2 4115.6 4142.2 4142.5 3557.1 3582.9 3587.5 3593.4 3605.6 5199.0 5213.5 5215.3 5226.5 5236.5 4744.6 4858.3 4867.2 4876.5 4902.6 5760.4 5773.1 5810.6 5819.7 5887.6 4009.7 4025.3 4025.5 4039.5 4043.0 6012.5 6112.3 6139.6 6161.4 6207.8 4002.6 4058.2 4063.5 4063.6 4077.8 4120.8 4122.2 4128.5 4130.7 4139.3 4692.0 4768.9 4784.6 4791.8 4799.6 5841.5 5842.8 5843.2 5855.4 5858.3 1429.7 1450.0 1450.3 1455.7 1457.3 907.7 945.8 970.4 975.7 980.1 5056.7 5065.2 5072.2 5090.4 5093.8 6055.2 6055.4 6056.2 6058.6 6060.2 4829.5 5020.6 5030.4 5037.6 5050.3 3202.6 3203.0 3204.3 3229.3 3236.7 5434.7 5590.5 5594.4 5594.9 5605.7 6008.6 6117.5 6183.8 6192.7 6210.3 5600.7 5612.7 5620.3 5624.7 5627.5 6052.5 6078.1 6082.9 6097.6 6101.6 5795.5 5963.2 5980.3 6044.5 6056.4 5649.0 5666.3 5675.9 5677.9 5690.7 4054.9 4133.1 4149.3 4157.8 4163.2 6071.8 6077.1 6089.5 6098.1 6100.8 5824.1 5841.0 5851.8 5854.4 5864.9 5703.4 5774.0 5814.0 5831.7 5836.2 5712.0 5719.4 5754.9 5766.2 5773.8 5786.4 5845.0 5871.2 5882.3 5904.2 5652.3 5662.9 5666.7 5670.5 5713.4 02:59:08 INFO - PID 6523 | 02:59:08 INFO - PID 6523 | [#5] yui.html Cycles:180 Average:14675.58 Median:4551.68 stddev:18152.02 (398.8%) stddev-sans-first:18172.66 02:59:08 INFO - PID 6523 | Values: 714.8 747.8 748.4 750.7 763.1 12929.3 13123.4 13440.0 14174.9 14189.9 14882.9 15507.5 15517.6 15542.1 15798.4 831.4 848.3 848.4 849.2 849.4 908.3 909.3 910.4 915.4 919.1 954.9 959.1 959.5 961.8 963.0 943.0 944.1 947.2 950.8 951.5 696.3 700.8 702.5 702.6 703.2 14155.2 14229.8 14417.7 14453.6 14537.5 14849.8 15153.8 15209.2 15332.5 15459.3 11905.8 12071.3 12111.6 12163.7 12199.4 2798.9 2819.4 2829.6 2832.4 2840.2 65824.0 66437.3 66526.3 66991.7 67626.7 10662.2 10808.5 10866.7 10883.2 10920.2 17266.8 17354.0 17416.1 17448.9 17460.7 5230.1 5394.2 5546.6 5771.6 5987.3 2620.5 2663.8 2671.9 2675.0 2688.2 3381.4 3476.1 3488.0 3513.8 3519.1 639.0 648.9 649.9 650.8 651.0 607.6 609.7 614.3 614.7 631.5 8847.7 9145.5 9319.6 9379.5 9552.1 589.9 600.3 600.6 605.5 610.3 4348.9 4417.5 4452.6 4499.3 4604.1 63443.7 65113.0 65186.0 65706.3 67217.7 59346.1 59388.4 59962.7 60170.4 60614.7 51423.2 52496.5 52687.7 54127.0 54762.5 9108.5 9280.1 9356.4 9406.2 9559.0 26673.2 26788.7 26863.7 27120.5 27123.5 32741.7 32768.2 32901.5 33085.3 33491.7 11440.1 11605.4 11883.6 12009.9 12075.2 12911.9 13138.9 13184.2 13249.1 13431.5 12182.6 12420.2 12471.6 12635.5 12829.0 11823.5 11836.8 11893.6 11970.5 12009.6 11722.8 11827.3 11890.1 12034.6 12144.3 8652.5 8673.2 8677.4 8961.7 8982.0 9229.0 9876.9 9880.2 10034.7 10058.0 02:59:08 INFO - PID 6523 | -------- Summary: end -------- 02:59:08 INFO - PID 6523 | 02:59:09 INFO - TEST-INFO | 6523: exit 0 02:59:09 INFO - TEST-OK | dromaeo_css | took 1119387ms 02:59:09 INFO - TEST-START | kraken 02:59:09 INFO - operating with platform_type : linux_ 02:59:09 INFO - Initialising browser for kraken test... 02:59:09 INFO - TEST-INFO | started process 6958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI55nqV/profile http://localhost:34728/getInfo.html) 02:59:13 INFO - PID 6958 | __metrics Screen width/height:1600/1200 02:59:13 INFO - PID 6958 | colorDepth:24 02:59:13 INFO - PID 6958 | Browser inner width/height: 1024/695 02:59:13 INFO - PID 6958 | __metrics 02:59:15 INFO - TEST-INFO | 6958: exit 0 02:59:15 INFO - Browser initialized. 02:59:15 INFO - Running cycle 1/1 for kraken test... 02:59:15 INFO - TEST-INFO | started process 7147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI55nqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:27 INFO - PID 7147 | RSS: Main: 174370816 02:59:27 INFO - PID 7147 | 02:59:30 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34728/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:31 INFO - PID 7147 | RSS: Main: 183107584 02:59:31 INFO - PID 7147 | 02:59:33 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34728/tests/kraken/driver.html?testName=audio-dft) 02:59:34 INFO - PID 7147 | RSS: Main: 181059584 02:59:34 INFO - PID 7147 | 02:59:37 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34728/tests/kraken/driver.html?testName=audio-fft) 02:59:37 INFO - PID 7147 | RSS: Main: 177123328 02:59:37 INFO - PID 7147 | 02:59:40 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34728/tests/kraken/driver.html?testName=audio-oscillator) 02:59:40 INFO - PID 7147 | RSS: Main: 178847744 02:59:40 INFO - PID 7147 | 02:59:42 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:43 INFO - PID 7147 | RSS: Main: 179879936 02:59:43 INFO - PID 7147 | 02:59:46 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34728/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:47 INFO - PID 7147 | RSS: Main: 181915648 02:59:47 INFO - PID 7147 | 02:59:50 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34728/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:51 INFO - PID 7147 | RSS: Main: 181063680 02:59:51 INFO - PID 7147 | 02:59:54 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34728/tests/kraken/driver.html?testName=json-parse-financial) 02:59:54 INFO - PID 7147 | RSS: Main: 184193024 02:59:54 INFO - PID 7147 | 02:59:56 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:57 INFO - PID 7147 | RSS: Main: 184938496 02:59:57 INFO - PID 7147 | 02:59:59 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:59 INFO - PID 7147 | RSS: Main: 184512512 02:59:59 INFO - PID 7147 | 03:00:01 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:00:02 INFO - PID 7147 | RSS: Main: 185425920 03:00:02 INFO - PID 7147 | 03:00:05 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:00:05 INFO - PID 7147 | RSS: Main: 184225792 03:00:05 INFO - PID 7147 | 03:00:09 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:00:09 INFO - PID 7147 | RSS: Main: 184819712 03:00:09 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | Cycle 1(1): loaded http://localhost:34728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34728/tests/kraken/driver.html?testName=ai-astar) 03:00:11 INFO - PID 7147 | RSS: Main: 186703872 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | __start_tp_report 03:00:11 INFO - PID 7147 | _x_x_mozilla_page_load 03:00:11 INFO - PID 7147 | _x_x_mozilla_page_load_details 03:00:11 INFO - PID 7147 | |i|pagename|runs| 03:00:11 INFO - PID 7147 | |0;ai-astar;106;113;114;114;115;120;114;113;115;116 03:00:11 INFO - PID 7147 | |1;audio-beat-detection;150;127;123;163;125;123;125;123;146;122 03:00:11 INFO - PID 7147 | |2;audio-dft;167;165;164;166;170;169;170;165;167;165 03:00:11 INFO - PID 7147 | |3;audio-fft;74;76;75;113;77;74;75;76;93;75 03:00:11 INFO - PID 7147 | |4;audio-oscillator;83;84;104;85;83;84;97;83;83;110 03:00:11 INFO - PID 7147 | |5;imaging-gaussian-blur;114;114;114;113;114;114;116;116;114;119 03:00:11 INFO - PID 7147 | |6;imaging-darkroom;150;150;150;150;149;150;152;153;152;149 03:00:11 INFO - PID 7147 | |7;imaging-desaturate;94;95;95;95;94;95;94;94;94;95 03:00:11 INFO - PID 7147 | |8;json-parse-financial;55;54;54;55;56;56;56;53;56;54 03:00:11 INFO - PID 7147 | |9;json-stringify-tinderbox;56;55;55;55;56;56;55;56;56;55 03:00:11 INFO - PID 7147 | |10;stanford-crypto-aes;82;81;81;82;81;81;91;82;82;82 03:00:11 INFO - PID 7147 | |11;stanford-crypto-ccm;129;128;142;131;128;131;133;137;218;129 03:00:11 INFO - PID 7147 | |12;stanford-crypto-pbkdf2;186;198;194;185;196;189;187;191;189;193 03:00:11 INFO - PID 7147 | |13;stanford-crypto-sha256-iterative;72;71;75;74;73;70;73;72;76;71 03:00:11 INFO - PID 7147 | __end_tp_report 03:00:11 INFO - PID 7147 | __start_cc_report 03:00:11 INFO - PID 7147 | _x_x_mozilla_cycle_collect,839 03:00:11 INFO - PID 7147 | __end_cc_report 03:00:11 INFO - PID 7147 | __startTimestamp1494237611798__endTimestamp 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | ------- Summary: start ------- 03:00:11 INFO - PID 7147 | Number of tests: 14 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:3.46 (3.0%) stddev-sans-first:2.15 03:00:11 INFO - PID 7147 | Values: 106.0 113.0 114.0 114.0 115.0 120.0 114.0 113.0 115.0 116.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:126.00 stddev:14.69 (11.7%) stddev-sans-first:14.18 03:00:11 INFO - PID 7147 | Values: 150.0 127.0 123.0 163.0 125.0 123.0 125.0 123.0 146.0 122.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#2] audio-dft Cycles:10 Average:166.80 Median:167.00 stddev:2.20 (1.3%) stddev-sans-first:2.33 03:00:11 INFO - PID 7147 | Values: 167.0 165.0 164.0 166.0 170.0 169.0 170.0 165.0 167.0 165.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.65 (16.8%) stddev-sans-first:13.17 03:00:11 INFO - PID 7147 | Values: 74.0 76.0 75.0 113.0 77.0 74.0 75.0 76.0 93.0 75.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.50 stddev:10.20 (12.2%) stddev-sans-first:10.54 03:00:11 INFO - PID 7147 | Values: 83.0 84.0 104.0 85.0 83.0 84.0 97.0 83.0 83.0 110.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:1.75 (1.5%) stddev-sans-first:1.83 03:00:11 INFO - PID 7147 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 116.0 116.0 114.0 119.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 03:00:11 INFO - PID 7147 | Values: 150.0 150.0 150.0 150.0 149.0 150.0 152.0 153.0 152.0 149.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:00:11 INFO - PID 7147 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.10 (2.0%) stddev-sans-first:1.17 03:00:11 INFO - PID 7147 | Values: 55.0 54.0 54.0 55.0 56.0 56.0 56.0 53.0 56.0 54.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:00:11 INFO - PID 7147 | Values: 56.0 55.0 55.0 55.0 56.0 56.0 55.0 56.0 56.0 55.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:3.03 (3.7%) stddev-sans-first:3.21 03:00:11 INFO - PID 7147 | Values: 82.0 81.0 81.0 82.0 81.0 81.0 91.0 82.0 82.0 82.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:132.00 stddev:27.56 (20.9%) stddev-sans-first:28.91 03:00:11 INFO - PID 7147 | Values: 129.0 128.0 142.0 131.0 128.0 131.0 133.0 137.0 218.0 129.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:192.00 stddev:4.37 (2.3%) stddev-sans-first:4.27 03:00:11 INFO - PID 7147 | Values: 186.0 198.0 194.0 185.0 196.0 189.0 187.0 191.0 189.0 193.0 03:00:11 INFO - PID 7147 | 03:00:11 INFO - PID 7147 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.89 (2.6%) stddev-sans-first:1.99 03:00:11 INFO - PID 7147 | Values: 72.0 71.0 75.0 74.0 73.0 70.0 73.0 72.0 76.0 71.0 03:00:11 INFO - PID 7147 | -------- Summary: end -------- 03:00:11 INFO - PID 7147 | 03:00:13 INFO - TEST-INFO | 7147: exit 0 03:00:13 INFO - TEST-OK | kraken | took 63839ms 03:00:13 INFO - SUITE-END | took 1183s 03:00:13 INFO - Completed test suite (00:19:43) 03:00:13 INFO - javascript benchmark 03:00:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6602.562051930852, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2760.696323404425, 2771.4180022195337, 2790.079273839633, 2806.887724491019, 2813.366992426704, 5267.367915850094, 5348.331458567679, 5378.462153784624, 5399.946000539993, 5406.053940560401, 5347.893042139155, 5350.973245133779, 5363.570914326854, 5437.619366644337, 5475.370332411774, 4450.198964186445, 4765.928511072345, 4780.259059845712, 4790.520947905216, 4797.736124513151, 4812.374391329122, 4863.756812159396, 4881.560659540641, 4883.389576302962, 4922.138625740481, 4654.767261636938, 4732.2428411454, 4769.308450274691, 4786.95213047872, 4791.904161916742, 4790.616750659939, 4798.856034318976, 4817.349657796188, 4837.443693975168, 4864.756762161877, 4712.481627021025, 4753.191957367256, 4759.214729569617, 4768.856934291976, 4784.784684689197, 5098.719570423626, 5160.922586161173, 5240.633155679104, 5269.420363759983, 5281.102212623825, 5709.77160913563, 5731.971340143273, 5747.166660834156, 5834.824955251307, 5853.50245229156, 5903.380145084747, 5914.733836977303, 5915.497182739429, 5922.526197904157, 5940.435658612425, 5414.998225328327, 5419.701916394597, 5420.945790542123, 5425.945740542544, 5436.646617969819, 5918.496927761103, 6010.368911264254, 6012.218411606463, 6031.909521357183, 6035.909461358083, 5482.862928426821, 5581.995240856603, 5637.633553818989, 5729.312482502043, 5736.340320863071, 5803.88392232153, 5816.505597024216, 5834.212381328552, 5850.473457388855, 5873.0, 5753.223314852525, 5787.826365208966, 5792.507636850914, 5793.304803423616, 5806.535477161817, 5610.270664813548, 5706.942930570641, 5709.51469125129, 5715.8571035724435, 5784.537237021028, 4782.450018247877, 4792.856214313576, 4795.112904112681, 4798.904021919612, 4807.351007613997, 4114.773687447159, 4156.127213285184, 4163.75017498951, 4171.436856024458, 4213.157368526307, 4923.556879880828, 4935.037667654773, 4950.628702847301, 4952.479989601112, 4967.776450059756, 5804.2744656917885, 5837.299524057055, 5871.941280587225, 5873.882522349529, 5884.499817515559, 4906.411230652345, 4916.70499770015, 4922.310876477296, 4926.655134140576, 4973.154563724175, 5020.046191223656, 5110.488951104934, 5113.488651134857, 5116.027954688598, 5151.201563757623, 5251.606129540376, 5354.705491197944, 5356.116240820221, 5368.033753924331, 5369.3019907413345, 5912.0, 5917.023691090922, 5919.526437885045, 5930.169776231245, 5935.198748169115, 5382.0, 5414.783408663767, 5419.620626556103, 5421.213923980922, 5457.017736807413, 5715.714214289185, 5763.452472015152, 5765.91351129725, 5769.59612827098, 5771.913421298768, 5693.459121383462, 5700.429957004432, 5810.767569297181, 5837.766489340549, 5853.473187413153, 5634.6337488063145, 5635.971820140873, 5641.633293835887, 5645.774169033357, 5703.572232082527, 5558.527525160407, 5598.384177740364, 5631.183478395692, 5641.153826925994, 5657.066584013756, 5376.892462150657, 5462.399136094947, 5470.6991115487435, 5563.638363506359, 5576.0799468088935, 5650.26546548946, 5669.149627555899, 5692.0608099663095, 5722.17028530869, 5759.193712880284, 5507.889842203213, 5522.6134170609275, 5530.612857100125, 5532.612717109763, 5535.5848311376], "value": 5248.741651924372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.6340234779088, 728.4354625165498, 1048.5491238767327, 1063.8457423673563, 1147.5581900968125, 32321.0, 33273.0, 33310.66689333106, 33338.49992250112, 33401.66598334016, 30748.53877191844, 30952.845235773788, 31090.68909310912, 31100.533491997638, 31246.0, 6377.107204991305, 6391.872162556746, 6481.31946145655, 6504.739810407578, 7079.504434689574, 6819.283975182584, 6841.281665425134, 6877.724891004379, 6893.931060689404, 6903.861922761542, 6859.622720750357, 6909.896351554706, 6922.996165555991, 6926.37662610365, 6934.895976560356, 6878.209005964328, 6895.862082758316, 6897.862042759142, 6902.309769023108, 6908.827279318007, 6961.930380696179, 6991.82520436988, 6992.3007699230175, 6993.475489338269, 7042.0493233413345, 30245.697543024507, 30459.543106853416, 30497.23756906073, 30682.693173068208, 30724.0, 3013.322002549409, 3053.2366908272934, 3055.6027716396948, 3061.0204734484973, 3065.249013991564, 24526.264212073667, 24579.262622121187, 24612.384690382703, 24732.0, 24747.752522474726, 2529.45616692412, 2552.068494999312, 2556.974430255711, 2558.7569180927967, 2560.8719564021726, 149017.0, 149083.25458372638, 149098.0, 149289.0, 149441.30866259104, 37723.62276377201, 39828.20343593112, 39974.20051598952, 40373.798131009156, 40542.79728601338, 41344.0, 41408.792956035024, 41522.58477415248, 41661.0, 41699.1660166795, 11230.0, 11302.773944521228, 11308.604198853001, 11315.98156165949, 11321.660350189508, 8647.567621618893, 8730.91269087301, 8737.956310218407, 8762.561871906379, 8775.210231079234, 12552.121351505308, 12658.620241392773, 12682.429290681941, 12751.936240318739, 12892.935535322264, 5263.973680131651, 5320.654157479751, 5334.253204551366, 5355.143177091647, 5395.379531353945, 878.7012415778665, 902.9390466202186, 914.5747227539226, 917.3853518142861, 939.6241503398559, 20382.898085509772, 20951.580968380546, 21085.57828843445, 21101.894490527757, 21414.0, 991.6281394477071, 1004.2417974429259, 1020.8009438159636, 1023.534291897185, 1024.257413375297, 10900.291481053864, 11164.720881978015, 11251.324920504796, 11322.0, 11353.318800871974, 183944.0, 184446.0, 184659.0, 184731.0, 184860.0, 39169.6083039166, 39249.41125883057, 39535.813925582275, 39604.20791584152, 39764.0, 1071.2608300272786, 1115.5928086248462, 1120.4621781544904, 1124.8368986497076, 1236.771197328497, 18911.527211819815, 19799.60400792005, 20214.797852021293, 20303.8984805075, 20483.897580512003, 28873.422531548833, 28892.85553572219, 28911.7108828909, 28932.42135157327, 29000.12999610015, 151814.0, 154022.22988884983, 154135.0, 154380.2280988588, 154971.0, 27881.860590696917, 28039.158825235274, 28629.570556442086, 29239.561406578494, 30009.249768755082, 34641.13397165091, 34924.47613285854, 34949.60201591908, 35161.0, 35840.64159358373, 26451.735482645698, 26788.19635410941, 26874.05940792141, 27130.794726817374, 27761.86119069392, 26376.340591485365, 26970.190894273204, 27384.726152738218, 27698.72301277042, 27774.166774996782, 28862.278443039093, 29345.7065429343, 29793.25516862096, 30003.399932001674, 30102.69897300999, 25916.0, 26204.475910481302, 26875.86562067177, 27332.043378481656, 27356.316092097855, 20567.09225247258, 22271.665925010813, 22346.66480002834, 22441.551168976857, 22521.774782251967], "value": 14180.157129949099, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.37245662027505, 389.171065630208, 422.39386480400617, 423.0354791076345, 430.9245881970654, 12801.487940482393, 16817.0, 17107.973521588712, 17534.649307013853, 17541.473755787316, 18125.637487250246, 18537.629247415043, 18674.439766807016, 18685.0, 18719.532011699714, 5276.839095399026, 5406.702631355274, 5446.074167391553, 5474.206240095184, 5522.91715624266, 5487.6433031853, 5580.162975553659, 5580.665160090408, 5587.329520457551, 5598.804041858536, 5337.14605663094, 5419.729013549327, 5497.147942068986, 5507.889842203153, 5542.418046105161, 5413.539849112791, 5435.592330575203, 5439.265699130626, 5495.093309603911, 5501.229827824108, 4722.126406614787, 4825.059113472874, 4852.4662287148385, 4856.878578035542, 4870.172070747982, 21110.26114086015, 21167.576648467097, 21462.356129316144, 21482.677759833616, 21661.35015949524, 1606.9357225710958, 1634.4442889417655, 1664.3176297717998, 1673.5230459319157, 1674.815770265282, 14174.858251417458, 14265.0, 14536.563903082924, 14548.1998490083, 14645.0, 2033.2680235115347, 2082.2191678120703, 2083.749950005994, 2086.478380404899, 2091.1739862754125, 87811.0, 89600.0, 90176.54911725465, 91597.54201229019, 93182.53408732981, 10672.0, 10731.89268107309, 10890.61882834097, 11025.83461248082, 11138.832917506244, 14046.789298160536, 15084.773728394082, 15271.334879628808, 15272.694546109016, 15321.923390382977, 7484.989526413973, 7690.307872291409, 7796.376289896794, 7824.061112666516, 7827.921720782833, 7024.683889224997, 7081.539699919489, 7135.714571417189, 7309.378702810321, 7315.0, 6828.624425656637, 6903.896441553381, 6927.896081558781, 6928.16861976566, 6944.4097251734165, 2008.7489063867017, 2052.2817014044963, 2062.742157230346, 2070.7265032005507, 2160.12514931453, 861.7371701630938, 903.114947351586, 905.5472263868066, 905.6332185464897, 930.093159169804, 16719.16404179786, 16938.23777929996, 17352.739708904122, 17405.738913916302, 17562.736558951627, 903.1645727701849, 907.3603109807569, 915.9404638698463, 919.632147141149, 922.7416323429317, 8850.291976641853, 9152.8627070594, 9477.099675530813, 9541.570629321697, 9714.077162669535, 360266.0, 363137.0, 374494.0, 377923.0, 383142.0, 74886.62556687182, 78125.21874781293, 79742.0, 80453.59773201097, 81086.0, 1095.315427857589, 1108.0581505720234, 1153.4866984191954, 1156.9363684997406, 1157.3229660648446, 16848.57878553046, 17255.3960611378, 17667.204975775865, 17783.555411114827, 17813.554661133574, 37358.813205933795, 38677.613223868524, 39394.803025984686, 39639.40540891947, 39900.8004959985, 44361.55638443703, 44872.32691509695, 44954.55045449635, 46782.064358711956, 49698.0, 7848.960755196187, 8011.759647210593, 8163.510189388656, 8259.297959673495, 8377.204165604258, 11526.711832204262, 11551.653450396501, 11851.111166662362, 12036.277823330629, 12090.516379344728, 11004.339739615649, 11066.39134847591, 11073.612423565459, 11321.094312455149, 11552.306861588331, 10107.949460252947, 10769.9461502692, 10931.617393391192, 10962.671119866416, 11225.831612525983, 11151.219414641222, 11264.943675281898, 11515.884841151481, 11661.883381166419, 11726.88273117258, 7821.217878212134, 7834.0599128105, 7890.723824666109, 7893.921060789548, 7903.802404939923, 11094.778104437704, 11183.72040698989, 11343.489542970421, 11542.902269694137, 11647.76704465923], "value": 8824.946103188535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.6418570707347, 1292.3393439430333, 1301.7331447053355, 1306.2423794199372, 1306.9607911762644, 9080.72757817265, 9460.905390946089, 9478.0, 9478.431294122358, 9719.222462203024, 9406.811863762738, 9580.80838383232, 9588.760280992961, 9608.231341492681, 9621.422714637127, 2176.2274392590602, 2203.8457307988447, 2217.6008318502663, 2218.6006518826603, 2219.8224142068675, 1982.157583027215, 2027.3613811649357, 2029.5433527456278, 2033.6237796007713, 2034.5422279986958, 2154.396768904709, 2168.3928500019942, 2178.4880553070016, 2200.977990220101, 2209.668549717547, 2064.0505367530955, 2098.3390232076845, 2113.006886763219, 2116.5661039486945, 2125.415510734545, 2032.9491762705902, 2057.207974929648, 2101.170037835062, 2175.445261458318, 2209.690643309938, 9358.859617105749, 9389.061093890625, 9440.10319019692, 9514.666986655504, 9544.761380965461, 5040.042391945555, 5244.79020839166, 5254.500822421864, 5278.709670968095, 5289.418164001957, 2990.566367876646, 3188.2188863728534, 3207.96792032079, 3237.919052023695, 3250.2849373137874, 1028.711960651019, 1044.3211912257018, 1059.327327147267, 1072.2708558180434, 1079.7246702090995, 13513.527026554122, 13726.519571815039, 13789.241591712453, 13802.930985345009, 13842.861571384257, 4598.977005114953, 4605.93091103627, 4832.758362081881, 4859.805607775649, 4870.707757534559, 11535.596254131066, 11572.0, 11587.826182607268, 11616.88383116175, 11696.590619328283, 5249.790008399621, 5259.789608415621, 5261.894762104736, 5272.947270527322, 5282.445343238905, 4622.607078398374, 4712.481627021025, 4743.430788305356, 4809.062232864558, 4843.491433399513, 4157.819804818985, 4167.333226683716, 4188.036751547162, 4212.620864122244, 4263.126059157865, 1275.0628288208159, 1303.7887326041487, 1322.7156161425148, 1324.1723922548408, 1332.1740520877117, 715.8103102677794, 734.2253922112117, 736.1276886889053, 746.7573038762424, 751.2825251884437, 5372.113601255827, 5410.431904650034, 5460.34475862899, 5503.642263252956, 5544.584156188302, 532.3026834846364, 545.6780499505311, 548.1886807524885, 551.5918220516788, 557.5336864047529, 3375.696187343151, 3386.7299762589028, 3564.697000754913, 3650.2152037311575, 3664.0839790052487, 11754.0, 11865.228760130563, 12169.574064907685, 12232.633021009384, 12301.815472767916, 11437.71405714847, 11784.88215117855, 11818.763624727457, 11915.642530724092, 12126.090543209295, 6635.900461493082, 6707.128073350531, 6798.320167983261, 6800.251972283045, 6823.0, 5550.306211723535, 5567.4432556744005, 5677.148427735872, 5804.361520232856, 5810.1575271586225, 10838.783224335626, 10881.727956800827, 11021.83467248008, 11113.333200008025, 11116.833247501456, 11047.558097676003, 11078.224524283223, 11082.279651822606, 11113.83329250078, 11369.715757106138, 7477.401807855467, 7571.0, 7581.431392645684, 7596.582187979714, 7601.695932162652, 8733.606987685696, 8777.868331975153, 8856.690015849414, 8940.374173807772, 8953.104689530996, 7609.467337286337, 7632.961835190788, 7712.190220026816, 7718.0, 7756.340711039625, 7437.442191835526, 7515.39876809843, 7533.773986780406, 7618.8095297618, 7665.923340766521, 6984.546004509691, 7141.857162856818, 7149.14210294768, 7153.892691609526, 7155.964220178866, 4848.418189817245, 4909.993451342395, 4927.359443272351, 4932.778024988956, 5130.358705161855, 4942.604591632589, 5017.874553136201, 5120.897582048264, 5132.358455193101, 5184.144616138446], "value": 4495.81799229139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.78713559000204, 372.0846717075993, 379.684861564901, 389.59482138575885, 391.4109265555339, 5477.424870388611, 5507.779688812448, 5563.749631266587, 5573.275474188355, 5622.0, 5344.305240318763, 5423.457654234575, 5461.563074954004, 5466.781328746845, 5474.343078830546, 4002.539707933581, 4114.609112134357, 4119.649829764474, 4133.214689209056, 4141.254574176647, 4120.423140760296, 4130.380442933554, 4131.801777484541, 4149.917001659965, 4153.854615088472, 4105.2405305018665, 4106.733062350952, 4109.568495307994, 4130.442390277319, 4142.2543942090415, 4069.776162311072, 4102.220578090183, 4115.588441155861, 4142.233686767958, 4142.523609784883, 3557.1462848916076, 3582.874599389009, 3587.4798154267746, 3593.4070878305047, 3605.603383627799, 5199.024370739133, 5213.4525874782985, 5215.295935048758, 5226.451222621646, 5236.476352364771, 4744.572988431023, 4858.344123543312, 4867.196912509432, 4876.536729010773, 4902.632302577285, 5760.395158508338, 5773.134029895507, 5810.605454690886, 5819.679917604572, 5887.587868849182, 4009.719319647626, 4025.2754504189234, 4025.4565633639377, 4039.4748682671066, 4042.9797851010558, 6012.488938440238, 6112.297085835142, 6139.6009259398, 6161.383861613847, 6207.751689932397, 4002.6197511236387, 4058.2086493134148, 4063.4920634920636, 4063.553009168989, 4077.8164982575854, 4120.835166593302, 4122.175564887035, 4128.545859955462, 4130.710850240454, 4139.317012692872, 4691.976540117277, 4768.880777980509, 4784.593309568656, 4791.808327666924, 4799.6400269979895, 5841.474267315962, 5842.766289348378, 5843.2403787507355, 5855.414458554111, 5858.2677165354335, 1429.6997630497713, 1449.9855001450062, 1450.311102226434, 1455.7306898223862, 1457.32962837094, 907.7080372060468, 945.8061097475002, 970.4322971062007, 975.7414285214423, 980.1472718734603, 5056.747162641853, 5065.189569668835, 5072.213806859942, 5090.363704536933, 5093.796248150106, 6055.1522786809, 6055.364186760415, 6056.182415373956, 6058.636481811105, 6060.2424696912885, 4829.541193586604, 5020.648554601143, 5030.396352437658, 5037.622178336639, 5050.3182070420025, 3202.551642770014, 3202.9679703203137, 3204.295055087877, 3229.3056992746674, 3236.7086962173516, 5434.673919564839, 5590.524805391506, 5594.440555944373, 5594.86012849682, 5605.691686957175, 6008.579399442085, 6117.541184411187, 6183.805603293165, 6192.721327540272, 6210.254769427607, 5600.663960162403, 5612.719364031782, 5620.269364982526, 5624.7063175469875, 5627.465390787868, 6052.546059045677, 6078.118672792332, 6082.878342433038, 6097.634141951497, 6101.60339577926, 5795.478406943395, 5963.165156878127, 5980.312264089685, 6044.516438684983, 6056.424639659225, 5649.0, 5666.263385759825, 5675.886482270249, 5677.914831277617, 5690.71546422669, 4054.9189016220103, 4133.090720041586, 4149.257311929057, 4157.75053496779, 4163.208990291956, 6071.848203794763, 6077.149199112217, 6089.48239399656, 6098.146259523759, 6100.847478813065, 5824.126381042877, 5840.970795145997, 5851.824445266649, 5854.356020837619, 5864.944310024237, 5703.401142879938, 5773.971130144322, 5813.970930145322, 5831.679257640871, 5836.212111364912, 5712.02895507773, 5719.428057194247, 5754.9424505754405, 5766.192733017297, 5773.769049237983, 5786.42135786418, 5845.0, 5871.236739223874, 5882.294124705063, 5904.232449781673, 5652.293463317085, 5662.943370566241, 5666.744996475086, 5670.489655930986, 5713.400247930586], "value": 4338.36730059944, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.814148321437, 747.7980945144811, 748.397539980316, 750.7147284032068, 763.1490887660257, 12929.288889111094, 13123.409446574904, 13439.992000599945, 14174.929125354372, 14189.92905035476, 14882.925585372084, 15507.534773956771, 15517.612059698486, 15542.067475951451, 15798.368065277375, 831.4055450352996, 848.3086284677968, 848.3976376772468, 849.1890244816186, 849.3884403229696, 908.2915326045695, 909.2998391238742, 910.4264313482497, 915.4324318922278, 919.1497864475367, 954.9236061115095, 959.1176117971448, 959.4818797849188, 961.7932144588912, 963.032152686549, 942.9905700943006, 944.0512285153445, 947.1570302430807, 950.8003319302954, 951.457669128597, 696.3384784454788, 700.7652436433801, 702.5293053654065, 702.6346299924062, 703.2299631903109, 14155.150690958473, 14229.78655320171, 14417.71164576713, 14453.638659033608, 14537.491187808377, 14849.777253341208, 15153.772693409608, 15209.163496007715, 15332.463363782326, 15459.304331305118, 11905.821412678817, 12071.336076515789, 12111.636650900487, 12163.695907602292, 12199.390030498529, 2798.9440211195865, 2819.36564273039, 2829.5614179802164, 2832.433513297349, 2840.1763488588285, 65824.0, 66437.33562664312, 66526.3347366525, 66991.66504167496, 67626.66186669035, 10662.200334974908, 10808.513616887101, 10866.728331791768, 10883.18376121794, 10920.235583509237, 17266.827331726774, 17354.0, 17416.129193540273, 17448.912755436395, 17460.738088928676, 5230.084735171406, 5394.190871369326, 5546.63946843462, 5771.567132465082, 5987.341392446828, 2620.5283049050972, 2663.8135330526675, 2671.919842404731, 2675.0, 2688.180105067973, 3381.408253555618, 3476.0962149841225, 3487.9651203487642, 3513.8243087845503, 3519.1026288296835, 638.9872202555923, 648.931862154467, 649.9415052645285, 650.7917466410703, 650.9869802603921, 607.6202373516552, 609.7012463892661, 614.2506142506136, 614.7080136935009, 631.5263552335748, 8847.73456796297, 9145.542722863831, 9319.580618872167, 9379.5310234488, 9552.14030737223, 589.8731772668897, 600.2976517474565, 600.5795942839942, 605.5065121925617, 610.3133974278936, 4348.934765978513, 4417.536158703354, 4452.5992660660695, 4499.280115181556, 4604.079184163181, 63443.6827815858, 65113.0, 65186.0, 65706.34293657003, 67217.66391168012, 59346.10980835291, 59388.40611593915, 59962.700186499664, 60170.39829601648, 60614.696926515084, 51423.20018799324, 52496.47503524916, 52687.73656131772, 54127.0, 54762.45237547573, 9108.544572771203, 9280.118388753057, 9356.391834530734, 9406.200472959876, 9559.0, 26673.19980400591, 26788.732112678623, 26863.731362686904, 27120.508372038938, 27123.457530849668, 32741.672583273863, 32768.1807954803, 32901.50647740334, 33085.33829323448, 33491.66508334885, 11440.141989350666, 11605.419729013684, 11883.58407455735, 12009.939950300193, 12075.215111017756, 12911.870881291443, 13138.868611313765, 13184.208947463183, 13249.072564920363, 13431.529896453578, 12182.573609923611, 12420.192687475284, 12471.625851224479, 12635.494580217057, 12829.0, 11823.467943942715, 11836.76326473483, 11893.583724569598, 11970.521179152736, 12009.63971080869, 11722.824157637471, 11827.290362578273, 11890.10824188172, 12034.63896083119, 12144.332061736335, 8652.480851148952, 8673.176048275403, 8677.435966662148, 8961.731148065568, 8982.01197868247, 9229.0, 9876.851847222153, 9880.160186384237, 10034.749131271778, 10058.044485774133], "value": 6466.359238788046, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 114.0, 114.0, 115.0, 120.0, 114.0, 113.0, 115.0, 116.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 123.0, 163.0, 125.0, 123.0, 125.0, 123.0, 146.0, 122.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 166.0, 170.0, 169.0, 170.0, 165.0, 167.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 113.0, 77.0, 74.0, 75.0, 76.0, 93.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 104.0, 85.0, 83.0, 84.0, 97.0, 83.0, 83.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 116.0, 116.0, 114.0, 119.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 149.0, 150.0, 152.0, 153.0, 152.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 56.0, 56.0, 56.0, 53.0, 56.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 82.0, 81.0, 81.0, 91.0, 82.0, 82.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 142.0, 131.0, 128.0, 131.0, 133.0, 137.0, 218.0, 129.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 198.0, 194.0, 185.0, 196.0, 189.0, 187.0, 191.0, 189.0, 193.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 75.0, 74.0, 73.0, 70.0, 73.0, 72.0, 76.0, 71.0], "value": 72.7, "unit": "score"}]}]} 03:00:13 INFO - Return code: 0 03:00:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:00:13 INFO - # TBPL SUCCESS # 03:00:13 INFO - Running post-action listener: _resource_record_post_action 03:00:13 INFO - [mozharness: 2017-05-08 10:00:13.580641Z] Finished run-tests step (success) 03:00:13 INFO - Running post-run listener: _resource_record_post_run 03:00:13 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 366526464; Read time: 264; Write time: 202440 03:00:13 INFO - TinderboxPrint: CPU usage
13.3% 03:00:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 264 03:00:13 INFO - TinderboxPrint: I/O write bytes / time
366,526,464 / 202,440 03:00:13 INFO - TinderboxPrint: CPU idle
8,295.4 (86.7%) 03:00:13 INFO - TinderboxPrint: CPU user
1,217.6 (12.7%) 03:00:13 INFO - TinderboxPrint: Swap in / out
0 / 0 03:00:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103116800; Read time: 68; Write time: 71516 03:00:13 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263409664; Read time: 184; Write time: 130924 03:00:14 INFO - Running post-run listener: _upload_blobber_files 03:00:14 INFO - Blob upload gear active. 03:00:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:00:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:00:14 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:00:14 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:00:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:15 INFO - (blobuploader) - INFO - Done attempting. 03:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:16 INFO - (blobuploader) - INFO - Done attempting. 03:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:19 INFO - (blobuploader) - INFO - Done attempting. 03:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:20 INFO - (blobuploader) - INFO - Done attempting. 03:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:00:20 INFO - Return code: 0 03:00:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:00:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db11e98b9e1646c08f41520e87499e2a9e6e256528b6d1259ae398c5be3fe43fa0868e3e26006729628310b2c98f5828add203b7bab18f3a0b730572e56879c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f03f43fe4143eb6998d7f707dc46f71c380975f6f794bfe3ba943c951384acfcd77f41e38babedbdea0c52be5c5108dca25cb3c552749c5f12d13c560e3e465f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05a02743a8f0e1355d5af9979c41deecbcec5e0778196f0dd9c5a0442c93cd6d69896e9a73bef1b38dc625412abdbfecd40fc32acd29de9e949f670e6b56aaef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99f95d4f1e9d6d5065b27c8d4ad57d35cead77daede650cdb208cda8d4e0cfa489e8d79beda0c4a46cc1535dec639675358ae3aebe1c33dff48eb3852176a184"} 03:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:00:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:00:20 INFO - Contents: 03:00:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db11e98b9e1646c08f41520e87499e2a9e6e256528b6d1259ae398c5be3fe43fa0868e3e26006729628310b2c98f5828add203b7bab18f3a0b730572e56879c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f03f43fe4143eb6998d7f707dc46f71c380975f6f794bfe3ba943c951384acfcd77f41e38babedbdea0c52be5c5108dca25cb3c552749c5f12d13c560e3e465f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05a02743a8f0e1355d5af9979c41deecbcec5e0778196f0dd9c5a0442c93cd6d69896e9a73bef1b38dc625412abdbfecd40fc32acd29de9e949f670e6b56aaef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99f95d4f1e9d6d5065b27c8d4ad57d35cead77daede650cdb208cda8d4e0cfa489e8d79beda0c4a46cc1535dec639675358ae3aebe1c33dff48eb3852176a184"} 03:00:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:00:20 INFO - Copying logs to upload dir... 03:00:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:00:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.984430 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-08 03:00:18.952384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 03:00:18.955535) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 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/sha512/db11e98b9e1646c08f41520e87499e2a9e6e256528b6d1259ae398c5be3fe43fa0868e3e26006729628310b2c98f5828add203b7bab18f3a0b730572e56879c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f03f43fe4143eb6998d7f707dc46f71c380975f6f794bfe3ba943c951384acfcd77f41e38babedbdea0c52be5c5108dca25cb3c552749c5f12d13c560e3e465f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05a02743a8f0e1355d5af9979c41deecbcec5e0778196f0dd9c5a0442c93cd6d69896e9a73bef1b38dc625412abdbfecd40fc32acd29de9e949f670e6b56aaef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99f95d4f1e9d6d5065b27c8d4ad57d35cead77daede650cdb208cda8d4e0cfa489e8d79beda0c4a46cc1535dec639675358ae3aebe1c33dff48eb3852176a184"} build_url:https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/M0oXlh3BTCyGwJ2sHClpwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db11e98b9e1646c08f41520e87499e2a9e6e256528b6d1259ae398c5be3fe43fa0868e3e26006729628310b2c98f5828add203b7bab18f3a0b730572e56879c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f03f43fe4143eb6998d7f707dc46f71c380975f6f794bfe3ba943c951384acfcd77f41e38babedbdea0c52be5c5108dca25cb3c552749c5f12d13c560e3e465f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05a02743a8f0e1355d5af9979c41deecbcec5e0778196f0dd9c5a0442c93cd6d69896e9a73bef1b38dc625412abdbfecd40fc32acd29de9e949f670e6b56aaef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99f95d4f1e9d6d5065b27c8d4ad57d35cead77daede650cdb208cda8d4e0cfa489e8d79beda0c4a46cc1535dec639675358ae3aebe1c33dff48eb3852176a184"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 03:00:18.981206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 03:00:18.981520) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1494234496.81076-1014255491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 03:00:19.065941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 03:00:19.066282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 03:00:19.066642) ========= ========= Total master_lag: 0.16 =========