builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1499358780.62 results: success (0) revision: e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.619510) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.620216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.620523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.639858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.640268) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-06 09:33:00-- 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% 90.6K=0.1s 2017-07-06 09:33:00 (90.6 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.256943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.913109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.913500) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018085 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:00.966366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-06 09:33:00.966790) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 --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 e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 --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=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-06 09:33:01,094 truncating revision to first 12 chars 2017-07-06 09:33:01,094 Setting DEBUG logging. 2017-07-06 09:33:01,094 attempt 1/10 2017-07-06 09:33:01,094 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e23f55311ecb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-06 09:33:01,944 unpacking tar archive at: mozilla-central-e23f55311ecb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.204135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-06 09:33:02.186184) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:02.186576) ========= script_repo_revision: e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:02.187070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:02.187353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-06 09:33:02.196684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-06 09:33:02.197096) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:02 INFO - MultiFileLogger online at 20170706 09:33:02 in /builds/slave/test 09:33:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:33:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:02 INFO - {'append_to_log': False, 09:33:02 INFO - 'base_work_dir': '/builds/slave/test', 09:33:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:33:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:02 INFO - 'branch': 'Firefox-Non-PGO', 09:33:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:02 INFO - 'code_coverage': False, 09:33:02 INFO - 'config_files': ('talos/linux_config.py',), 09:33:02 INFO - 'default_actions': ('clobber', 09:33:02 INFO - 'read-buildbot-config', 09:33:02 INFO - 'download-and-extract', 09:33:02 INFO - 'populate-webroot', 09:33:02 INFO - 'create-virtualenv', 09:33:02 INFO - 'install', 09:33:02 INFO - 'setup-mitmproxy', 09:33:02 INFO - 'run-tests'), 09:33:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:02 INFO - 'disable_ccov_upload': False, 09:33:02 INFO - 'download_minidump_stackwalk': True, 09:33:02 INFO - 'download_symbols': 'ondemand', 09:33:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:02 INFO - 'gecko_profile': False, 09:33:02 INFO - 'gecko_profile_interval': 0, 09:33:02 INFO - 'installer_path': 'installer.exe', 09:33:02 INFO - 'log_level': 'info', 09:33:02 INFO - 'log_name': 'talos', 09:33:02 INFO - 'log_to_console': True, 09:33:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:02 INFO - 'opt_config_files': (), 09:33:02 INFO - 'pip_index': False, 09:33:02 INFO - 'suite': 'dromaeojs-e10s', 09:33:02 INFO - 'system_bits': '32', 09:33:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:02 INFO - 'title': 'talos-linux64-ix-019', 09:33:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:02 INFO - 'use_talos_json': True, 09:33:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:02 INFO - 'work_dir': 'build'} 09:33:02 INFO - [mozharness: 2017-07-06 16:33:02.430038Z] Running clobber step. 09:33:02 INFO - Running pre-action listener: _resource_record_pre_action 09:33:02 INFO - Running main action method: clobber 09:33:02 INFO - rmtree: /builds/slave/test/build 09:33:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:03 INFO - Running post-action listener: _resource_record_post_action 09:33:03 INFO - [mozharness: 2017-07-06 16:33:03.452636Z] Finished clobber step (success) 09:33:03 INFO - [mozharness: 2017-07-06 16:33:03.452738Z] Running read-buildbot-config step. 09:33:03 INFO - Running pre-action listener: _resource_record_pre_action 09:33:03 INFO - Running main action method: read_buildbot_config 09:33:03 INFO - Using buildbot properties: 09:33:03 INFO - { 09:33:03 INFO - "project": "", 09:33:03 INFO - "product": "firefox", 09:33:03 INFO - "who": "ffxbld@noreply.mozilla.org", 09:33:03 INFO - "installer_path": "public/build/target.tar.bz2", 09:33:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:33:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:33:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:33:03 INFO - "stage_platform": "linux64", 09:33:03 INFO - "basedir": "/builds/slave/test", 09:33:03 INFO - "buildnumber": 702, 09:33:03 INFO - "platform": "ubuntu64_hw", 09:33:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:03 INFO - "slavebuilddir": "test", 09:33:03 INFO - "taskId": "SlQaXAOXRsut5M86X2IuQA", 09:33:03 INFO - "branch": "mozilla-central", 09:33:03 INFO - "script_repo_revision": "production", 09:33:03 INFO - "revision": "e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0", 09:33:03 INFO - "slavename": "talos-linux64-ix-019", 09:33:03 INFO - "repo_path": "mozilla-central" 09:33:03 INFO - } 09:33:03 INFO - Finding installer, test and symbols from parent task. 09:33:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SlQaXAOXRsut5M86X2IuQA'}, attempt #1 09:33:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SlQaXAOXRsut5M86X2IuQA'}, attempt #1 09:33:04 INFO - Task dependencies: PAE4w3vZQ4G-WzPrDvdDSA 09:33:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA'}, attempt #1 09:33:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 09:33:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/test_packages.json 09:33:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.crashreporter-symbols.zip 09:33:04 INFO - Running post-action listener: _resource_record_post_action 09:33:04 INFO - [mozharness: 2017-07-06 16:33:04.811161Z] Finished read-buildbot-config step (success) 09:33:04 INFO - [mozharness: 2017-07-06 16:33:04.811382Z] Running download-and-extract step. 09:33:04 INFO - Running pre-action listener: _resource_record_pre_action 09:33:04 INFO - Running main action method: download_and_extract 09:33:04 INFO - mkdir: /builds/slave/test/build/tests 09:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:04 INFO - trying https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.test_packages.json 09:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:33:05 INFO - Downloaded 989 bytes. 09:33:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:33:05 INFO - Using the following test package requirements: 09:33:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:33:05 INFO - u'common': [u'target.common.tests.zip'], 09:33:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:33:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:33:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:33:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:33:05 INFO - u'mozbase': [u'target.common.tests.zip'], 09:33:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:33:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:33:05 INFO - u'web-platform': [u'target.common.tests.zip', 09:33:05 INFO - u'target.web-platform.tests.tar.gz'], 09:33:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:33:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip 09:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip into memory 09:33:06 INFO - Content-Length response header: 67420910 09:33:06 INFO - Bytes received: 67420910 09:33:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip 09:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.common.tests.zip into memory 09:33:18 INFO - Content-Length response header: 67420910 09:33:18 INFO - Bytes received: 67420910 09:33:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.talos.tests.zip 09:33:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:33:29 INFO - Fetch https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.talos.tests.zip into memory 09:33:30 INFO - Content-Length response header: 14472293 09:33:30 INFO - Bytes received: 14472293 09:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:30 INFO - trying https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 09:33:30 INFO - Downloading https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:33:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:33:31 INFO - Downloaded 62032333 bytes. 09:33:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 09:33:31 INFO - mkdir: /builds/slave/test/properties 09:33:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:31 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:31 INFO - Contents: 09:33:31 INFO - build_url:https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 09:33:31 INFO - Running post-action listener: _resource_record_post_action 09:33:31 INFO - Running post-action listener: set_extra_try_arguments 09:33:31 INFO - [mozharness: 2017-07-06 16:33:31.905572Z] Finished download-and-extract step (success) 09:33:31 INFO - [mozharness: 2017-07-06 16:33:31.905669Z] Running populate-webroot step. 09:33:31 INFO - Running pre-action listener: _resource_record_pre_action 09:33:31 INFO - Running main action method: populate_webroot 09:33:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:31 INFO - '--tppagecycles', 09:33:31 INFO - '7'], 09:33:31 INFO - 'tests': ['tsvgm']}}, 09:33:31 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['damp', 'tps']}, 09:33:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'tests': ['damp', 'tps']}, 09:33:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['dromaeo_dom']}, 09:33:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:33:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:33:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:33:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_many_windows', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_many_windows', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_many_windows', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['a11yr', 09:33:31 INFO - 'ts_paint', 09:33:31 INFO - 'tpaint', 09:33:31 INFO - 'sessionrestore', 09:33:31 INFO - 'sessionrestore_no_auto_restore', 09:33:31 INFO - 'tabpaint']}, 09:33:31 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 09:33:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:33:31 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:33:31 INFO - 'talos_options': ['--mitmproxy', 09:33:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:33:31 INFO - '--firstNonBlankPaint'], 09:33:31 INFO - 'tests': ['quantum_pageload_google', 09:33:31 INFO - 'quantum_pageload_youtube', 09:33:31 INFO - 'quantum_pageload_amazon', 09:33:31 INFO - 'quantum_pageload_facebook']}, 09:33:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['tsvgx', 09:33:31 INFO - 'tsvgr_opacity', 09:33:31 INFO - 'tart', 09:33:31 INFO - 'tscrollx', 09:33:31 INFO - 'cart', 09:33:31 INFO - 'tsvg_static']}, 09:33:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:31 INFO - 'tsvgr_opacity', 09:33:31 INFO - 'tart', 09:33:31 INFO - 'tscrollx', 09:33:31 INFO - 'cart', 09:33:31 INFO - 'tsvg_static']}, 09:33:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'talos_options': ['--disable-e10s'], 09:33:31 INFO - 'tests': ['tp5o']}, 09:33:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:33:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'talos_options': ['--disable-e10s', 09:33:31 INFO - '--xperf_path', 09:33:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:31 INFO - 'tests': ['tp5n']}, 09:33:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:33:31 INFO - 'talos_options': ['--xperf_path', 09:33:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:31 INFO - 'tests': ['tp5n']}}, 09:33:31 INFO - 'talos.zip': {'path': '', 09:33:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:31 INFO - Running post-action listener: _resource_record_post_action 09:33:31 INFO - [mozharness: 2017-07-06 16:33:31.920618Z] Finished populate-webroot step (success) 09:33:31 INFO - [mozharness: 2017-07-06 16:33:31.920708Z] Running create-virtualenv step. 09:33:31 INFO - Running pre-action listener: _resource_record_pre_action 09:33:31 INFO - Running main action method: create_virtualenv 09:33:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:31 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 09:33:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:33:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:32 INFO - Using real prefix '/usr' 09:33:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:32 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:34 INFO - Installing pip.................done. 09:33:34 INFO - Return code: 0 09:33:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:34 INFO - Reading from file tmpfile_stdout 09:33:34 INFO - Output received: 09:33:34 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) 09:33:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:34 INFO - Using env: {'DISPLAY': ':0', 09:33:34 INFO - 'HOME': '/home/cltbld', 09:33:34 INFO - 'LANG': 'en_US.UTF-8', 09:33:34 INFO - 'LANGUAGE': 'en_US:en', 09:33:34 INFO - 'LOGNAME': 'cltbld', 09:33:34 INFO - 'MAIL': '/var/mail/cltbld', 09:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:34 INFO - 'MOZ_NO_REMOTE': '1', 09:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:34 INFO - 'NO_EM_RESTART': '1', 09:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:34 INFO - 'PWD': '/builds/slave/test', 09:33:34 INFO - 'SHELL': '/bin/bash', 09:33:34 INFO - 'SHLVL': '1', 09:33:34 INFO - 'TERM': 'linux', 09:33:34 INFO - 'TMOUT': '86400', 09:33:34 INFO - 'USER': 'cltbld', 09:33:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:34 INFO - '_': '/tools/buildbot/bin/python'} 09:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:34 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 09:33:34 INFO - Cleaning up... 09:33:34 INFO - Return code: 0 09:33:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:33:34 INFO - Using env: {'DISPLAY': ':0', 09:33:34 INFO - 'HOME': '/home/cltbld', 09:33:34 INFO - 'LANG': 'en_US.UTF-8', 09:33:34 INFO - 'LANGUAGE': 'en_US:en', 09:33:34 INFO - 'LOGNAME': 'cltbld', 09:33:34 INFO - 'MAIL': '/var/mail/cltbld', 09:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:34 INFO - 'MOZ_NO_REMOTE': '1', 09:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:34 INFO - 'NO_EM_RESTART': '1', 09:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:34 INFO - 'PWD': '/builds/slave/test', 09:33:34 INFO - 'SHELL': '/bin/bash', 09:33:34 INFO - 'SHLVL': '1', 09:33:34 INFO - 'TERM': 'linux', 09:33:34 INFO - 'TMOUT': '86400', 09:33:34 INFO - 'USER': 'cltbld', 09:33:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:34 INFO - '_': '/tools/buildbot/bin/python'} 09:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:35 INFO - Downloading/unpacking psutil>=3.1.1 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:36 INFO - Installing collected packages: psutil 09:33:36 INFO - Running setup.py install for psutil 09:33:36 INFO - building 'psutil._psutil_linux' extension 09:33:36 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 09:33:36 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 09:33:36 INFO - building 'psutil._psutil_posix' extension 09:33:36 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 09:33:36 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 09:33:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:36 INFO - Successfully installed psutil 09:33:36 INFO - Cleaning up... 09:33:36 INFO - Return code: 0 09:33:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:36 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/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:33:36 INFO - Using env: {'DISPLAY': ':0', 09:33:36 INFO - 'HOME': '/home/cltbld', 09:33:36 INFO - 'LANG': 'en_US.UTF-8', 09:33:36 INFO - 'LANGUAGE': 'en_US:en', 09:33:36 INFO - 'LOGNAME': 'cltbld', 09:33:36 INFO - 'MAIL': '/var/mail/cltbld', 09:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:36 INFO - 'MOZ_NO_REMOTE': '1', 09:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:36 INFO - 'NO_EM_RESTART': '1', 09:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:36 INFO - 'PWD': '/builds/slave/test', 09:33:36 INFO - 'SHELL': '/bin/bash', 09:33:36 INFO - 'SHLVL': '1', 09:33:36 INFO - 'TERM': 'linux', 09:33:36 INFO - 'TMOUT': '86400', 09:33:36 INFO - 'USER': 'cltbld', 09:33:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:36 INFO - '_': '/tools/buildbot/bin/python'} 09:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:38 INFO - Installing collected packages: mozsystemmonitor 09:33:38 INFO - Running setup.py install for mozsystemmonitor 09:33:38 INFO - Successfully installed mozsystemmonitor 09:33:38 INFO - Cleaning up... 09:33:38 INFO - Return code: 0 09:33:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:38 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/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:33:38 INFO - Using env: {'DISPLAY': ':0', 09:33:38 INFO - 'HOME': '/home/cltbld', 09:33:38 INFO - 'LANG': 'en_US.UTF-8', 09:33:38 INFO - 'LANGUAGE': 'en_US:en', 09:33:38 INFO - 'LOGNAME': 'cltbld', 09:33:38 INFO - 'MAIL': '/var/mail/cltbld', 09:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:38 INFO - 'MOZ_NO_REMOTE': '1', 09:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:38 INFO - 'NO_EM_RESTART': '1', 09:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:38 INFO - 'PWD': '/builds/slave/test', 09:33:38 INFO - 'SHELL': '/bin/bash', 09:33:38 INFO - 'SHLVL': '1', 09:33:38 INFO - 'TERM': 'linux', 09:33:38 INFO - 'TMOUT': '86400', 09:33:38 INFO - 'USER': 'cltbld', 09:33:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:38 INFO - '_': '/tools/buildbot/bin/python'} 09:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:38 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:38 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 09:33:38 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 09:33:38 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 09:33:38 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 09:33:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:39 INFO - warning: no files found matching '*.txt' 09:33:39 INFO - no previously-included directories found matching 'build' 09:33:39 INFO - no previously-included directories found matching 'dist' 09:33:39 INFO - no previously-included directories found matching '.git*' 09:33:39 INFO - Installing collected packages: jsonschema, functools32 09:33:39 INFO - Running setup.py install for functools32 09:33:39 INFO - warning: no files found matching '*.txt' 09:33:39 INFO - no previously-included directories found matching 'build' 09:33:39 INFO - no previously-included directories found matching 'dist' 09:33:39 INFO - no previously-included directories found matching '.git*' 09:33:39 INFO - Successfully installed jsonschema functools32 09:33:39 INFO - Cleaning up... 09:33:40 INFO - Return code: 0 09:33:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:40 INFO - Using env: {'DISPLAY': ':0', 09:33:40 INFO - 'HOME': '/home/cltbld', 09:33:40 INFO - 'LANG': 'en_US.UTF-8', 09:33:40 INFO - 'LANGUAGE': 'en_US:en', 09:33:40 INFO - 'LOGNAME': 'cltbld', 09:33:40 INFO - 'MAIL': '/var/mail/cltbld', 09:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:40 INFO - 'MOZ_NO_REMOTE': '1', 09:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:40 INFO - 'NO_EM_RESTART': '1', 09:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:40 INFO - 'PWD': '/builds/slave/test', 09:33:40 INFO - 'SHELL': '/bin/bash', 09:33:40 INFO - 'SHLVL': '1', 09:33:40 INFO - 'TERM': 'linux', 09:33:40 INFO - 'TMOUT': '86400', 09:33:40 INFO - 'USER': 'cltbld', 09:33:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:40 INFO - '_': '/tools/buildbot/bin/python'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:40 INFO - Cleaning up... 09:33:40 INFO - Return code: 0 09:33:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 09:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:40 INFO - Using env: {'DISPLAY': ':0', 09:33:40 INFO - 'HOME': '/home/cltbld', 09:33:40 INFO - 'LANG': 'en_US.UTF-8', 09:33:40 INFO - 'LANGUAGE': 'en_US:en', 09:33:40 INFO - 'LOGNAME': 'cltbld', 09:33:40 INFO - 'MAIL': '/var/mail/cltbld', 09:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:40 INFO - 'MOZ_NO_REMOTE': '1', 09:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:40 INFO - 'NO_EM_RESTART': '1', 09:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:40 INFO - 'PWD': '/builds/slave/test', 09:33:40 INFO - 'SHELL': '/bin/bash', 09:33:40 INFO - 'SHLVL': '1', 09:33:40 INFO - 'TERM': 'linux', 09:33:40 INFO - 'TMOUT': '86400', 09:33:40 INFO - 'USER': 'cltbld', 09:33:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:40 INFO - '_': '/tools/buildbot/bin/python'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:42 INFO - Downloading docopt-0.6.1.tar.gz 09:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:42 INFO - Running setup.py install for blobuploader 09:33:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:42 INFO - Running setup.py install for requests 09:33:42 INFO - Running setup.py install for docopt 09:33:42 INFO - Successfully installed blobuploader requests docopt 09:33:42 INFO - Cleaning up... 09:33:42 INFO - Return code: 0 09:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:42 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/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:42 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:42 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:42 INFO - Using env: {'DISPLAY': ':0', 09:33:42 INFO - 'HOME': '/home/cltbld', 09:33:42 INFO - 'LANG': 'en_US.UTF-8', 09:33:42 INFO - 'LANGUAGE': 'en_US:en', 09:33:42 INFO - 'LOGNAME': 'cltbld', 09:33:42 INFO - 'MAIL': '/var/mail/cltbld', 09:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:42 INFO - 'MOZ_NO_REMOTE': '1', 09:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:42 INFO - 'NO_EM_RESTART': '1', 09:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:42 INFO - 'PWD': '/builds/slave/test', 09:33:42 INFO - 'SHELL': '/bin/bash', 09:33:42 INFO - 'SHLVL': '1', 09:33:42 INFO - 'TERM': 'linux', 09:33:42 INFO - 'TMOUT': '86400', 09:33:42 INFO - 'USER': 'cltbld', 09:33:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:42 INFO - '_': '/tools/buildbot/bin/python'} 09:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:42 INFO - Running setup.py (path:/tmp/pip-51O36H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:43 INFO - Running setup.py (path:/tmp/pip-h9jYK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:43 INFO - Running setup.py (path:/tmp/pip-gv9XY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:43 INFO - Running setup.py (path:/tmp/pip-IRap9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:43 INFO - Running setup.py (path:/tmp/pip-up5rrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:43 INFO - Running setup.py (path:/tmp/pip-fLBpoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:43 INFO - Running setup.py (path:/tmp/pip-waqo_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:43 INFO - Running setup.py (path:/tmp/pip-vgHCf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:43 INFO - Running setup.py (path:/tmp/pip-nJCF9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:43 INFO - Running setup.py (path:/tmp/pip-xZGNRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:43 INFO - Running setup.py (path:/tmp/pip-gt7Pvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:43 INFO - Running setup.py (path:/tmp/pip-QgKkaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:43 INFO - Running setup.py (path:/tmp/pip-mJoail-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:43 INFO - Running setup.py (path:/tmp/pip-V1Awdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:43 INFO - Running setup.py (path:/tmp/pip-X6EtTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:44 INFO - Running setup.py (path:/tmp/pip-qKcJ3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:44 INFO - Running setup.py (path:/tmp/pip-MmU3c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:44 INFO - Running setup.py install for manifestparser 09:33:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozcrash 09:33:44 INFO - Running setup.py install for mozdebug 09:33:44 INFO - Running setup.py install for mozdevice 09:33:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozfile 09:33:44 INFO - Running setup.py install for mozhttpd 09:33:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozinfo 09:33:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozInstall 09:33:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozleak 09:33:45 INFO - Running setup.py install for mozlog 09:33:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Running setup.py install for moznetwork 09:33:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Running setup.py install for mozprocess 09:33:45 INFO - Running setup.py install for mozprofile 09:33:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Running setup.py install for mozrunner 09:33:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Running setup.py install for mozscreenshot 09:33:45 INFO - Running setup.py install for moztest 09:33:45 INFO - Running setup.py install for mozversion 09:33:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:45 INFO - Cleaning up... 09:33:45 INFO - Return code: 0 09:33:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:45 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/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:45 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:33:45 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:45 INFO - Using env: {'DISPLAY': ':0', 09:33:45 INFO - 'HOME': '/home/cltbld', 09:33:45 INFO - 'LANG': 'en_US.UTF-8', 09:33:45 INFO - 'LANGUAGE': 'en_US:en', 09:33:45 INFO - 'LOGNAME': 'cltbld', 09:33:45 INFO - 'MAIL': '/var/mail/cltbld', 09:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:45 INFO - 'MOZ_NO_REMOTE': '1', 09:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:45 INFO - 'NO_EM_RESTART': '1', 09:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:45 INFO - 'PWD': '/builds/slave/test', 09:33:45 INFO - 'SHELL': '/bin/bash', 09:33:45 INFO - 'SHLVL': '1', 09:33:45 INFO - 'TERM': 'linux', 09:33:45 INFO - 'TMOUT': '86400', 09:33:45 INFO - 'USER': 'cltbld', 09:33:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:45 INFO - '_': '/tools/buildbot/bin/python'} 09:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:46 INFO - Running setup.py (path:/tmp/pip-D7rqm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:46 INFO - Running setup.py (path:/tmp/pip-MRG6xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:46 INFO - Running setup.py (path:/tmp/pip-14hTAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:46 INFO - Running setup.py (path:/tmp/pip-3aWwEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:46 INFO - Running setup.py (path:/tmp/pip-EQfU3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:46 INFO - Running setup.py (path:/tmp/pip-aNHaj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:46 INFO - Running setup.py (path:/tmp/pip-JpWnkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:46 INFO - Running setup.py (path:/tmp/pip-2EDH9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:46 INFO - Running setup.py (path:/tmp/pip-ChMDyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:46 INFO - Running setup.py (path:/tmp/pip-6pBnET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:46 INFO - Running setup.py (path:/tmp/pip-EL_oCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:46 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)) 09:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:47 INFO - Running setup.py (path:/tmp/pip-r0tm1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:47 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)) 09:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:47 INFO - Running setup.py (path:/tmp/pip-GzXibJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:47 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)) 09:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:47 INFO - Running setup.py (path:/tmp/pip-OyMBgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:47 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)) 09:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:47 INFO - Running setup.py (path:/tmp/pip-LyajON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:47 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)) 09:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:47 INFO - Running setup.py (path:/tmp/pip-EsheXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:47 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)) 09:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:47 INFO - Running setup.py (path:/tmp/pip-GKpvOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:47 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)) 09:33:47 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)) 09:33:47 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)) 09:33:47 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)) 09:33:47 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:47 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:47 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:33:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:47 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 09:33:47 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 09:33:47 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 09:33:47 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 09:33:48 INFO - Downloading blessings-1.6.tar.gz 09:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:48 INFO - Installing collected packages: blessings 09:33:48 INFO - Running setup.py install for blessings 09:33:48 INFO - Successfully installed blessings 09:33:48 INFO - Cleaning up... 09:33:48 INFO - Return code: 0 09:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:48 INFO - Reading from file tmpfile_stdout 09:33:48 INFO - Current package versions: 09:33:48 INFO - argparse == 1.2.1 09:33:48 INFO - blessings == 1.6 09:33:48 INFO - blobuploader == 1.2.4 09:33:48 INFO - docopt == 0.6.1 09:33:48 INFO - functools32 == 3.2.3-2 09:33:48 INFO - jsonschema == 2.5.1 09:33:48 INFO - manifestparser == 1.1 09:33:48 INFO - mozInstall == 1.13 09:33:48 INFO - mozcrash == 1.0 09:33:48 INFO - mozdebug == 0.1 09:33:48 INFO - mozdevice == 0.51 09:33:48 INFO - mozfile == 1.2 09:33:48 INFO - mozhttpd == 0.7 09:33:48 INFO - mozinfo == 0.10 09:33:48 INFO - mozleak == 0.1 09:33:48 INFO - mozlog == 3.5 09:33:48 INFO - moznetwork == 0.27 09:33:48 INFO - mozprocess == 0.25 09:33:48 INFO - mozprofile == 0.28 09:33:48 INFO - mozrunner == 6.13 09:33:48 INFO - mozscreenshot == 0.1 09:33:48 INFO - mozsystemmonitor == 0.3 09:33:48 INFO - moztest == 0.8 09:33:48 INFO - mozversion == 1.4 09:33:48 INFO - psutil == 3.1.1 09:33:48 INFO - requests == 1.2.3 09:33:48 INFO - wsgiref == 0.1.2 09:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:48 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/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:48 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:33:48 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:33:48 INFO - Using env: {'DISPLAY': ':0', 09:33:48 INFO - 'HOME': '/home/cltbld', 09:33:48 INFO - 'LANG': 'en_US.UTF-8', 09:33:48 INFO - 'LANGUAGE': 'en_US:en', 09:33:48 INFO - 'LOGNAME': 'cltbld', 09:33:48 INFO - 'MAIL': '/var/mail/cltbld', 09:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:48 INFO - 'MOZ_NO_REMOTE': '1', 09:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:48 INFO - 'NO_EM_RESTART': '1', 09:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:48 INFO - 'PWD': '/builds/slave/test', 09:33:48 INFO - 'SHELL': '/bin/bash', 09:33:48 INFO - 'SHLVL': '1', 09:33:48 INFO - 'TERM': 'linux', 09:33:48 INFO - 'TMOUT': '86400', 09:33:48 INFO - 'USER': 'cltbld', 09:33:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:48 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 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)) 09:33:49 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:50 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:33:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:33:50 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)) 09:33:50 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)) 09:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:33:50 INFO - Installing collected packages: marionette-driver, simplejson 09:33:50 INFO - Running setup.py install for marionette-driver 09:33:50 INFO - Running setup.py install for simplejson 09:33:51 INFO - building 'simplejson._speedups' extension 09:33:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 09:33:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 09:33:51 INFO - Successfully installed marionette-driver simplejson 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22931f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2461a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2604ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', '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 09:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:33:51 INFO - Using env: {'DISPLAY': ':0', 09:33:51 INFO - 'HOME': '/home/cltbld', 09:33:51 INFO - 'LANG': 'en_US.UTF-8', 09:33:51 INFO - 'LANGUAGE': 'en_US:en', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MAIL': '/var/mail/cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SHLVL': '1', 09:33:51 INFO - 'TERM': 'linux', 09:33:51 INFO - 'TMOUT': '86400', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - '_': '/tools/buildbot/bin/python'} 09:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:52 INFO - Cleaning up... 09:33:52 INFO - Return code: 0 09:33:52 INFO - Running post-action listener: _resource_record_post_action 09:33:52 INFO - Running post-action listener: _start_resource_monitoring 09:33:52 INFO - Starting resource monitoring. 09:33:52 INFO - [mozharness: 2017-07-06 16:33:52.233633Z] Finished create-virtualenv step (success) 09:33:52 INFO - [mozharness: 2017-07-06 16:33:52.234094Z] Running install step. 09:33:52 INFO - Running pre-action listener: _resource_record_pre_action 09:33:52 INFO - Running main action method: install 09:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:52 INFO - Reading from file tmpfile_stdout 09:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:52 INFO - Reading from file tmpfile_stdout 09:33:52 INFO - Output received: 09:33:52 INFO - Usage: mozinstall [options] installer 09:33:52 INFO - Options: 09:33:52 INFO - -h, --help show this help message and exit 09:33:52 INFO - -d DEST, --destination=DEST 09:33:52 INFO - Directory to install application into. [default: 09:33:52 INFO - "/builds/slave/test"] 09:33:52 INFO - --app=APP Application being installed. [default: firefox] 09:33:52 INFO - mkdir: /builds/slave/test/build/application 09:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:34:10 INFO - Reading from file tmpfile_stdout 09:34:10 INFO - Output received: 09:34:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:10 INFO - Running post-action listener: _resource_record_post_action 09:34:10 INFO - [mozharness: 2017-07-06 16:34:10.547776Z] Finished install step (success) 09:34:10 INFO - [mozharness: 2017-07-06 16:34:10.548013Z] Running setup-mitmproxy step. 09:34:10 INFO - Running pre-action listener: _resource_record_pre_action 09:34:10 INFO - Running main action method: setup_mitmproxy 09:34:10 INFO - Skipping: mitmproxy is not required 09:34:10 INFO - Running post-action listener: _resource_record_post_action 09:34:10 INFO - [mozharness: 2017-07-06 16:34:10.548539Z] Finished setup-mitmproxy step (success) 09:34:10 INFO - [mozharness: 2017-07-06 16:34:10.548648Z] Running run-tests step. 09:34:10 INFO - Running pre-action listener: _resource_record_pre_action 09:34:10 INFO - Running pre-action listener: _set_gcov_prefix 09:34:10 INFO - Running main action method: run_tests 09:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:10 INFO - Python 2.7.3 09:34:10 INFO - Return code: 0 09:34:10 INFO - grabbing minidump binary from tooltool 09:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 09:34:10 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 0x2601980>, '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 0x2602730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2602bc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:10 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 09:34:10 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 09:34:10 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 09:34:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:10 INFO - Return code: 0 09:34:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:10 INFO - ENV: RUST_BACKTRACE is now 1 09:34:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 09:34:10 INFO - Using env: {'DISPLAY': ':0', 09:34:10 INFO - 'HOME': '/home/cltbld', 09:34:10 INFO - 'LANG': 'en_US.UTF-8', 09:34:10 INFO - 'LANGUAGE': 'en_US:en', 09:34:10 INFO - 'LOGNAME': 'cltbld', 09:34:10 INFO - 'MAIL': '/var/mail/cltbld', 09:34:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:10 INFO - 'MOZ_NO_REMOTE': '1', 09:34:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:10 INFO - 'NO_EM_RESTART': '1', 09:34:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:10 INFO - 'PWD': '/builds/slave/test', 09:34:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:10 INFO - 'RUST_BACKTRACE': '1', 09:34:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:34:10 INFO - 'SHELL': '/bin/bash', 09:34:10 INFO - 'SHLVL': '1', 09:34:10 INFO - 'TERM': 'linux', 09:34:10 INFO - 'TMOUT': '86400', 09:34:10 INFO - 'USER': 'cltbld', 09:34:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080', 09:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:10 INFO - '_': '/tools/buildbot/bin/python'} 09:34:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:34:10 INFO - mozversion application_buildid: 20170706154856 09:34:10 INFO - mozversion application_changeset: e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 09:34:10 INFO - mozversion application_display_name: Nightly 09:34:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:10 INFO - mozversion application_name: Firefox 09:34:10 INFO - mozversion application_remotingname: firefox 09:34:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:34:10 INFO - mozversion application_vendor: Mozilla 09:34:10 INFO - mozversion application_version: 56.0a1 09:34:10 INFO - mozversion platform_buildid: 20170706154856 09:34:10 INFO - mozversion platform_changeset: e23f55311ecb5e0cd14c5010d1b40663b3a2e7d0 09:34:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:34:10 INFO - mozversion platform_version: 56.0a1 09:34:10 INFO - using testdate: 1499358850 09:34:10 INFO - actual date: 1499358850 09:34:10 INFO - starting webserver on 'localhost:59439' 09:34:10 INFO - SUITE-START | Running 2 tests 09:34:10 INFO - TEST-START | dromaeo_css 09:34:10 INFO - Initialising browser for dromaeo_css test... 09:34:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59439/getInfo.html -profile /tmp/tmpPfKszb/profile 09:34:10 INFO - TEST-INFO | started process 15474 (/builds/slave/test/build/application/firefox/firefox http://localhost:59439/getInfo.html) 09:34:17 INFO - TEST-INFO | 15474: exit 0 09:34:17 INFO - Browser initialized. 09:34:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:17 INFO - TEST-INFO | started process 15676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPfKszb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:28 INFO - PID 15676 | RSS: Main: 169783296 09:34:28 INFO - PID 15676 | 09:37:27 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59439/tests/dromaeo/cssquery-ext.html) 09:37:30 INFO - PID 15676 | RSS: Main: 177225728 09:37:30 INFO - PID 15676 | 09:40:32 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-ext.html (next: http://localhost:59439/tests/dromaeo/cssquery-jquery.html) 09:40:33 INFO - PID 15676 | RSS: Main: 173948928 09:40:33 INFO - PID 15676 | 09:43:34 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59439/tests/dromaeo/cssquery-mootools.html) 09:43:35 INFO - PID 15676 | RSS: Main: 177004544 09:43:35 INFO - PID 15676 | 09:46:37 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59439/tests/dromaeo/cssquery-prototype.html) 09:46:37 INFO - PID 15676 | RSS: Main: 175738880 09:46:37 INFO - PID 15676 | 09:49:40 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59439/tests/dromaeo/cssquery-yui.html) 09:49:41 INFO - PID 15676 | RSS: Main: 175394816 09:49:41 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | Cycle 1(1): loaded http://localhost:59439/tests/dromaeo/cssquery-yui.html (next: http://localhost:59439/tests/dromaeo/cssquery-dojo.html) 09:52:43 INFO - PID 15676 | RSS: Main: 178827264 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | __start_tp_report 09:52:43 INFO - PID 15676 | _x_x_mozilla_page_load 09:52:43 INFO - PID 15676 | _x_x_mozilla_page_load_details 09:52:43 INFO - PID 15676 | |i|pagename|runs| 09:52:43 INFO - PID 15676 | |0;dojo.html;3029.3941211757656;3079.2917628945356;3087.8147311161324;3104.8137111773294;3131.311111555457;5985;5998.4301491358365;6034.33622301547;6125.173101631284;6125.63246205228;6089.056196289582;6109.022556390978;6142.201513803199;6179.351168127349;6191.721372538235;5637.633553818989;5641.971790141064;5643.435656434365;5679.062954612484;5691.08942569189;5482.5613950883835;5554.638948468357;5634.12671035988;5637;5647.830565083054;5497.39528651848;5540.113581826909;5565.9443405566035;5567.832965011056;5568.16477528372;5541.33503979525;5551.8889622207325;5575.944240557583;5590.217369568264;5596.160575913605;5463.289772329572;5490.917636235459;5535.197396377543;5539.723013849291;5549.445055494459;5981.0729336952845;5990.9101363479585;5997.910031349533;5998.730057147439;6006.519478441714;6406.487481001509;6483;6485.805425837232;6486.124373209651;6495.7076931538195;6510.739570417178;6532;6551.574147680385;6562.573432726857;6566.63883486408;5970.522358211376;6049.697515124226;6053.455189032964;6058.848528786772;6059.363766804466;6700.731970721116;6713.12729345182;6778.051072849805;6785.491088168407;6795.694193761243;6252.249730032334;6359.459445947146;6381.425671689571;6384.553081284358;6399.680015999182;6328.873422531616;6352.078948552434;6390.584612000205;6391.840203994844;6412.5190610704385;4784.4497882743235;6384.48924086072;6420.6147631142285;6436.324185960407;6512.6092434454085;6318.083877837687;6424.775132870327;6433.517486188554;6479.22249330074;6496.350364963466;5132.5124113209185;5148.794048238028;5196.610254230948;5210;5210.47895210476;4408.360787685768;4464.553544645574;4465.732056076646;4473.642108631302;4501.48232953208;4681.573341185066;5585.944140558624;5603.467670571289;5650.152477128464;5651.434856514398;6455.289918109004;6529.7714579990425;6539.901901471481;6612.437942774822;6659.966700166468;5657.98156331856;5680.971595141998;5709.172170035322;5709.286339207599;5755.424457554295;5643.802466913638;5719.942800572025;5728.942710572841;5798.188253644493;5803.7968671096305;6352.460040896483;6364.872702545923;6365.2998170201245;6369.713362898588;6386.489080873519;6501.804945851632;6540.705668244846;6565.573237739532;6570.08018877348;6591.769288074895;6313.715882785377;6317.96841015792;6343.460805831556;6365.204349456318;6377.075324078076;6366.9044964326495;6368.745250189941;6409.71156297977;6419.582727122722;6442.35576442352;6521.217453905561;6524.510661700487;6533.67331633407;6620.569662971891;6633.70148343316;6291.119243306032;6303.6532990685955;6381.138546296191;6399.200099987502;6414.326495718069;6187.721552530057;6302.842428939313;6360.204974378203;6362.077498762561;6389.584676995981;6217.813465596039;6265.906011409924;6278.183836101278;6278.309385967448;6291.465225455888;6218.409251121137;6331.651759153291;6374.74501019954;6399.2640846303275;6399.8080057598345;6131.019036954066;6159.5688301818445;6161.260648722182;6164.907526387197;6172.969135154295 09:52:43 INFO - PID 15676 | |1;ext.html;725.5936675461742;793.1354823242665;823.411260948422;848.1942154952796;851.1786126388037;40011.59988400115;41331.17337653245;41331.79334103333;41396;41546.79226603867;37544.62455375445;37600.811995939985;37674.24651506968;37911.431328530096;38072.42891356625;6909.274526174755;6975.197852246981;6989.580625162506;7025;7078;6911.447084233249;7040.225575186751;7044.929550704479;7046.365827075562;7049.224585295613;6950.096487456623;7024.367806897379;7031.8945215821805;7038.436925045984;7053;6965.094537710116;6966.616836074014;6992.825179370506;7018.4385249180195;7021.403180729644;6253.843653908643;6297.370262973712;6298.401651843067;6344.619322840598;6377.139086223347;33765.831170844234;33786.662133378595;33835.15412114692;33927.830360848035;34050.31899361999;3417.333619944112;3426.623071462137;3455.7235421166497;3543.8759643412614;3639.217568222845;31907.84046079778;31941.923774954786;32073.358532829447;32198;32379.514307285408;4760.23836186212;4897.6326775491625;4971.627127965381;5040.7731652075745;5047.49525047496;196207;199319;200263;200466;202074;48762;49357.50642493601;49722.75693107701;49845;49915.75042124839;51597;51663.22505162351;51670.74164629153;52009.7399513;52013;16543.83456165423;16670.33318667264;16742.414015509643;16794.916025419796;16839.57901052459;13847.930760346133;14001.789973150411;14045.157290562598;14064.789028164585;14075.648108797363;14230;14257.643558910902;14428.062175958528;14524.49164279245;14673.559793206221;5633.887322253532;5717.799877004285;5800.361960184377;5855.853603659857;5871.853203669857;985.4678473624163;1009.2027298434155;1021.3922715983978;1031.9587216511256;1044.6343779677052;22706.318810435714;22807.543849123256;22896.542069158524;23165.420864478187;23726.88136559306;1109.6227282723912;1111.955521779136;1133.5919069135105;1136.7953768321615;1139.6011396011495;11863.88136118645;11893.345865977455;11973.580924667594;12121.69695757613;12181.208221465753;235666;235851;237466;239435;241626;54771.726141369836;55193.44806551963;55685.44314556884;55805;55849.44150558524;1479.0164540580392;1480.4226351723053;1483.6365090552667;1495.5887131038833;1508.4569554960206;27009.59485607757;27947.021854235005;28131.156065318075;28279.57580636251;28324.433511329247;37377.62622373742;37550.624493754716;37762;37953.4306985401;38128.428073579475;182647;182751;183933;184072;185188;31249.68750312468;34916.47625285674;35009.474857876645;35213;35299;41868.58131418647;44088.77955610202;44703.10593788041;44935.32597010982;45176;31481.8425907869;31957;32293;32335.67664323421;32430.83784581062;31640.683593164693;32061;32077.839610801795;32178;32415.351692965538;34433.31133377369;36021.81989090038;36083.81958090298;36091;36116.63883361133;30097.51287389062;30865.228369290948;31421.371572568878;31545.684543155192;31990.20024499313;23762.643560346954;25110.874445627654;25249.242522724348;25442.74557254478;25988 09:52:43 INFO - PID 15676 | |2;jquery.html;558.2407925221697;559.6558116758192;567.5317862763221;572.2789285500269;595.9880802383951;21248.15007399704;22283;22286.777132228694;22298.331050068482;22312.21907233247;25086.49827003459;25936.35159121023;27330.180094597195;27377.178684639493;27588.17235482939;6807;6981.895271570905;6986.301369863024;6990.6155161466095;6992.79021629352;6795.082663840392;6856.040154378366;6879.6216208108535;6880.862382752342;6885.3114688530995;6494.188226471691;6562.639054851981;6784.864302713942;6827.180738311409;6829.521933464659;6850.588964662112;6895.34494223048;6900.2064762551945;6906.06768086312;6934.167899851999;6755.2906944771075;6765.695543700545;6769.3907548320885;6774.220964589086;6789.456843452512;29014.27464313388;30644.233894152603;31123.688763112532;31177.8441107793;32064.35871282561;1994.7905469925595;2041.5814757974579;2042.0708577597306;2044.7444069491314;2050.4771283322807;19776.604467910704;20216.595668086702;20239;20282.594348112954;20404.897975510175;2421.9515609687883;2427.9514409711883;2532.341591186305;2532.9493410131877;2534.5437821192177;125477.37261313727;125654;127816;128499;129695;19480.8051919479;21156.259530916344;21219.99740085768;21240;22378.842329297768;43332.350014749805;43681.56318436839;43718.344224836655;44030.779846100566;44137.33793993093;11693.590724324607;11760.411979400995;11886.40567971598;12001.699957501132;12102.213356131822;9933.304668673123;9954.153896918842;10012;10019.348742331726;10134.797304053878;10748.301360411548;10971.396573188551;11053.834192487118;11151.944240278746;11383.772324553629;3459.8962031138603;3592.7485076044427;3611.115276757211;4244.830206791756;4411.250087485071;948.4498990585444;977.1254727019278;989.3371441134457;998.5805961496189;1000.5797565022708;19353.4193974181;20239.291624793063;20278.493037674176;20828.895855520626;20846.583068338547;1039.4958445154093;1069.6256310291335;1077.7467295185625;1088.4612117002134;1090.1170052257696;10898.482963939836;11104.944475277573;11119.72200694989;11273.887261127284;11439.199256052163;513603;539381;549971;553323;565066;102072.48963755133;105154;105949;106436.99999999846;106528;1188.7432111542548;1212.6483319837148;1230.993845030769;1232.8643849176583;1242.2049888071642;16446.424375146813;17856.642867142844;17925.551861203574;18008.459746207634;18071.554275658178;50091;50779.492205078954;52154.478455214965;52485;54180.18729718978;64117.358826413;64156;64466.67766661324;65001;70126;12913.935430323165;13067.607971760863;13118.540851070167;13140.408681609542;13218.801717974045;15326.540203793904;16936;19526.90236548808;19607.117679704163;19653.31213407524;15877;15978.760318595463;16047.839521605101;16096.356145754038;16270.593235168742;13663.453461861813;14173.22047287409;14405.92797036008;14948.476803311833;15039.699206016037;15379.38482460689;15402.691946161238;15585.532434026998;15790.76313855316;16910.154492275582;12941.029422793139;13191.604251872459;13216.537421190213;13284.136531125447;13309.933450333074;15120.54638360851;16142.435014774426;16156.919215404318;16161.111138887474;16241.187940602686 09:52:43 INFO - PID 15676 | |3;mootools.html;1308.9803652945204;1405.5221224783572;1406.7678832992556;1416.5608661314993;1420.431827269093;13477.39351729172;14044.368003439844;14059.22674252917;14103.15381077136;14114.929425352884;13578.864211357883;14086.718265634681;14492.492762753305;14508.347124379401;14527.709445811077;2625.973740262597;2682.986585067072;2683.798715096366;2686.476137153256;2690.1391554702504;2622.1084831157405;2652.4562464694786;2657.548216803148;2659.3484596273843;2665.147152911069;2582.2382397192873;2607.7131515533274;2614.372550587864;2623.8032147589006;2625.5274050670873;2555.1312553731727;2649.682038155424;2723.482538317733;2729.3623825704617;2731.8497482638445;2661.680598328213;2668.212877201211;2679.1560658392546;2689.031948498539;2698.3793727442603;13792.724145517133;13981.650458738512;14057.367418466194;14062.648433789238;14063.226522541256;7456.478046536745;7796.883046754303;7807.492512986638;7831.099423566306;7837.6864925402915;4641.651876109306;4806.591439727627;4842.249451335048;4850.5877000455;4868.172410690191;1846.8245516675895;1869.3831035758167;1888.7733471983313;1893.715942608606;1952.6778081616517;22712;22930.656040159578;22975.88512057429;22978.425539361484;23047.654285185734;6347.143135676717;6374;6383.138276332728;6515.7719479818925;6547.148870646785;15575.065496070272;15599.922000390152;15613.765793513106;15634.296456659478;15657;7202.71189152428;7417.777466676009;7423.62881855905;7429.777106686808;7443.85112297751;6760.492963027793;6795.830104247335;6812.965935170391;6916.3429474199875;6973.686184121727;4549.385832912514;4585.312203169551;4693.906121877611;4710.599599034052;4727;1340.1891855427325;1341.7987301904598;1344.7108871592654;1352.5198554513204;1358.0357945858354;870.3863776037878;871.3464901324007;895.6865097215922;915.9679411220575;916.8578870275118;7258.383037441877;7276.345128938315;7282.053333066668;7318.524295920748;7339.7064117435775;691.4572060932144;707.1832034000737;980.3333733061444;1012.731626119079;1032.695354870315;4688.109259240801;4898.289747986593;4986.252062190628;5103.2855400244;5155.304033955368;17338.91330543339;18708.438746837615;18858;18923.24307027731;19192.424227273204;17950.730739038925;18218.362357317696;18414.907925460288;18500.444986650422;18787.530311742317;10089.192864570818;10342.37945723259;10446.791064178673;10452.843207351896;10510.421926793946;7716.5755883426955;8087.757367278991;8191.549464779256;8310.83378332442;8489.575521224038;15942.920285398499;15959.361625534848;16256.268467918735;16569.25438355253;16632.916835415745;16020.27908744086;16577;16872.735236729666;17150.142492875057;17417.82582174162;10371.896281037092;10693.9465302673;10699.144068474348;10701.090407315465;10705.678829635124;12985.805212921625;13183.945284377418;13188.472461101448;13218.933905330412;13245;10576.418296993432;10674.62638807638;10710.410927398756;10718.624848130277;10943.398113103856;10142.847857281999;10467.685969420625;10607.522661480407;10613.257072005194;10724.678259652223;9397.107274808883;9534.427934323685;9547.952260238655;9548.331616787036;9554.52227388614;6802.897956530557;6892.758753443806;6965.860682786417;6994.311014494183;7103.786886393416;7056.188538317954;7079.716811327489;7278.199398066103;7302.233265507045;7410.184879663125 09:52:43 INFO - PID 15676 | |4;prototype.html;479.7888928871294;505.15891041416046;506.7440942324126;510.5481648740863;512.5771238728049;5998.850028749283;6094.695265236737;6135.938640613604;6142.815715528542;6179;5871.823845284637;5905.616134951225;5914.940850591493;5956.702164891749;6074.754675291566;4864.586510146642;4877.463479017305;4926.187179115442;4930.161872481678;4944.480829512903;4868.780904859272;4933.80264789408;4934.679245849008;4943.4067911850625;4944.826931057413;4572.062727140945;4758.857234282977;4802.855914322576;4824.951750482485;4833.975830120862;4751.833685820997;4805.711657300556;4842.370491836074;4842.685225460334;4853.805847766085;4332.740035597874;4340.52254252032;4365.672574556921;4366.3013917773005;4370.847020354272;5829.970850145722;5837.854053648693;5842.152887831283;5864.912026319608;5888.617239879394;5493.752781124859;5536.307961504812;5552.416996215379;5553.945040335102;5558.499735023867;6261.8747625047245;6352.682365881734;6375.45808606269;6390.7763228286785;6399.424051835311;4779.856604301876;4781.402324709411;4790.209615413452;4790.4969978152485;4807.326974223612;6716.46268298535;6760.32396760325;6776;6787.117674702257;6800.421964133055;4944.25836124577;4950.292149208517;4954.876128096755;4973.204287314013;4976.303317535548;4937.308776771255;4968.962725282617;4996.4254110777;5012.674176178537;5014.473480284518;5484.862878427992;5524.116141417434;5537.501624853782;5538.252335934597;5590.636608620427;6258.028720952885;6288.836565235446;6298.716557754912;6336.271328797156;6465.838354041092;1698.312183565658;1738.7828520035773;1738.817424170444;1748.2133040131991;1751.351999760097;1081.5511562701547;1197.2038594334845;1198.8381568488142;1203.867574566797;1207.7403358278013;5440.591955603346;5518.91721624176;5553.361363443256;5622.823104945693;5649.406812284733;6497.252815926229;6509.2839787623325;6562.606243625398;6591.439727623206;6719.992001199859;5626.1842032905;5675.460831221028;5698.0598201296325;5726.5418766499415;5760.3951585083805;3440.449528075546;3503.054175372635;3506.8772592959126;3533.169705119295;3560.732945029133;6300.621962682254;6312.810615681445;6363.840903977438;6403.551751377358;6464.319276988017;6755.973208037569;6779.847370972521;6829.590224586442;6839.2818754031105;6859.5541289816;6431.389018043278;6453.774117905851;6460.806175814733;6475.838104047531;6501.317361676955;6547.607143571401;6566.704498297492;6581.407673309425;6613.470922326299;6645.305447111149;6522.641254731036;6567.665340875;6599;6608.173978252718;6633.933660663524;6385.776497822554;6386.361363863763;6426.550141490051;6436.806895793134;6437.452816510462;4807;4831.637627177905;4881.463039065771;4918.92621610669;4958.355413796184;6602.40578347951;6621.470282377494;6635.170603674541;6649.767258145942;6662.167229096363;6340.4293613575;6388.680565971776;6398.648074355955;6423.357664233727;6437.678116094083;6425.453836423956;6427.967860160669;6460.030995350735;6464.191976003;6471.449926756279;6362.6818659067785;6390.265119511316;6395.392437718409;6396.456301214449;6398.168238129014;5808;6370.840728981627;6374.458171055512;6447.387498187664;6477.902831457626;6138.693065346625;6188.876222475616;6251.593646412968;6264.373562643699;6281.72335238402 09:52:43 INFO - PID 15676 | |5;yui.html;940.6613619097124;946.1549977543789;960.9087136722009;968.6077138758806;973.5716284834672;18167.091645417724;18468.90765546172;18601.7209741854;18870.433886983377;18889.905550472264;19050.618987620273;19884.701729474033;20669.379918602466;20850.374488765323;20908.05913733882;1030.114101872391;1062.6121465665053;1064.302881612545;1064.675274041417;1064.7338165458636;1054.741588310865;1063.016709543669;1063.8138325792993;1066.8239740442818;1067.898549637787;1016.9542370593341;1118.6420345489446;1119.0599896087285;1122.5622007417114;1122.9893096213432;1079.3416016230133;1089.7112265249716;1091.8635170603675;1094.6332978452228;1098.780243951209;800.5836964778283;805.0942689474341;805.6455159729759;808;808.0989696488373;16300.836991630169;17665.028423436706;18923.24307027717;19214.13536390866;19263.614727705506;19928.402147935583;20172.39482815518;20401.285954991505;20445.079971401174;20499.975001249877;14958.027728197632;15235.847641523555;15340.309686064042;15499.070055796688;15517.922410387988;3486.477028445728;3565.625609311037;3587.3901436755814;3588.4796704477967;3601.099725068733;105933.47033264785;108871;110008;111087;114246;16240.51278461648;16602;16663.83336166647;16668.249928753234;16710.498685039467;27741.58387624187;29171.562426563618;29428.705712942596;29497.705022949925;29787.55318670222;9183.632654693738;9252.444853308823;9254.629814807467;9276.62893484253;9280.303977201602;4120.299549076664;4249;4266.8293268269545;4282.464691913511;4296.484421869396;4902.41171059468;5003.074431230234;5004.499550044967;5035.521625445577;5038.143515602356;931.38993958957;961.8701475300885;1036.3212096077082;1059.7297689089387;1061.490484567412;693.2582137113341;719.8092505486051;725.147951157388;732.9670164842595;742.9814254643677;11810.324177579068;12242.551489701917;12675.809862852064;12738.490460381667;12760.872391275969;701.9646022117438;704.7639040921247;711.1750369571273;724.7282269149069;740.8592367450167;5429.348478182644;5499.917501237484;5585;5627.634203776742;5796.043652797325;93210.53394732982;93474.53262733779;97636.51181744046;99406.5029674847;101771.49114254382;86035.56982215049;88529;89443.55278223567;90183.54908225549;93257.0674293262;71699.64150179215;72728.63635681788;73560.63219683868;73823.63088184631;74901.25098748943;10297.50686150489;10314.845277320695;10354;10452.32059916103;10675.572977081141;35833.28333433369;36473.27053458863;36936.63063369332;37455.81272093622;37656.623433765315;42811.35782963196;43706.12587748291;44768;44786.776066120765;45896.770516147204;14462.349194286493;14470.059446135967;14551.199684017058;14561.053531520418;14564.708705825613;16094.517164485083;16625.750613741046;17181.82818171802;17213.56966075808;17237.65524689474;15704.764428533352;16163.191840407697;18023.63952720912;18974.24103035863;19173.32893348726;17658.470245892644;18090.27638894482;18365.173567189777;18439.631207376045;18806.6238675223;18329.90835045816;18456.446306610822;18556.536086597942;18834.434966950466;18957.43127706171;12847;13715.177089374669;14057.718845623234;14093.718125637635;14109.506167284097;13364;13381.866181338451;14023.649408764863;14274.785878211627;14395.568132956028 09:52:43 INFO - PID 15676 | __end_tp_report 09:52:43 INFO - PID 15676 | __start_cc_report 09:52:43 INFO - PID 15676 | _x_x_mozilla_cycle_collect,340 09:52:43 INFO - PID 15676 | __end_cc_report 09:52:43 INFO - PID 15676 | __startTimestamp1499359963354__endTimestamp 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | ------- Summary: start ------- 09:52:43 INFO - PID 15676 | Number of tests: 6 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#0] dojo.html Cycles:165 Average:5969.66 Median:6217.81 stddev:717.63 (11.5%) stddev-sans-first:681.75 09:52:43 INFO - PID 15676 | Values: 3029.4 3079.3 3087.8 3104.8 3131.3 5985.0 5998.4 6034.3 6125.2 6125.6 6089.1 6109.0 6142.2 6179.4 6191.7 5637.6 5642.0 5643.4 5679.1 5691.1 5482.6 5554.6 5634.1 5637.0 5647.8 5497.4 5540.1 5565.9 5567.8 5568.2 5541.3 5551.9 5575.9 5590.2 5596.2 5463.3 5490.9 5535.2 5539.7 5549.4 5981.1 5990.9 5997.9 5998.7 6006.5 6406.5 6483.0 6485.8 6486.1 6495.7 6510.7 6532.0 6551.6 6562.6 6566.6 5970.5 6049.7 6053.5 6058.8 6059.4 6700.7 6713.1 6778.1 6785.5 6795.7 6252.2 6359.5 6381.4 6384.6 6399.7 6328.9 6352.1 6390.6 6391.8 6412.5 4784.4 6384.5 6420.6 6436.3 6512.6 6318.1 6424.8 6433.5 6479.2 6496.4 5132.5 5148.8 5196.6 5210.0 5210.5 4408.4 4464.6 4465.7 4473.6 4501.5 4681.6 5585.9 5603.5 5650.2 5651.4 6455.3 6529.8 6539.9 6612.4 6660.0 5658.0 5681.0 5709.2 5709.3 5755.4 5643.8 5719.9 5728.9 5798.2 5803.8 6352.5 6364.9 6365.3 6369.7 6386.5 6501.8 6540.7 6565.6 6570.1 6591.8 6313.7 6318.0 6343.5 6365.2 6377.1 6366.9 6368.7 6409.7 6419.6 6442.4 6521.2 6524.5 6533.7 6620.6 6633.7 6291.1 6303.7 6381.1 6399.2 6414.3 6187.7 6302.8 6360.2 6362.1 6389.6 6217.8 6265.9 6278.2 6278.3 6291.5 6218.4 6331.7 6374.7 6399.3 6399.8 6131.0 6159.6 6161.3 6164.9 6173.0 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#1] ext.html Cycles:180 Average:37684.45 Median:3421.98 stddev:54056.28 (1579.7%) stddev-sans-first:54136.68 09:52:43 INFO - PID 15676 | Values: 725.6 793.1 823.4 848.2 851.2 40011.6 41331.2 41331.8 41396.0 41546.8 37544.6 37600.8 37674.2 37911.4 38072.4 6909.3 6975.2 6989.6 7025.0 7078.0 6911.4 7040.2 7044.9 7046.4 7049.2 6950.1 7024.4 7031.9 7038.4 7053.0 6965.1 6966.6 6992.8 7018.4 7021.4 6253.8 6297.4 6298.4 6344.6 6377.1 33765.8 33786.7 33835.2 33927.8 34050.3 3417.3 3426.6 3455.7 3543.9 3639.2 31907.8 31941.9 32073.4 32198.0 32379.5 4760.2 4897.6 4971.6 5040.8 5047.5 196207.0 199319.0 200263.0 200466.0 202074.0 48762.0 49357.5 49722.8 49845.0 49915.8 51597.0 51663.2 51670.7 52009.7 52013.0 16543.8 16670.3 16742.4 16794.9 16839.6 13847.9 14001.8 14045.2 14064.8 14075.6 14230.0 14257.6 14428.1 14524.5 14673.6 5633.9 5717.8 5800.4 5855.9 5871.9 985.5 1009.2 1021.4 1032.0 1044.6 22706.3 22807.5 22896.5 23165.4 23726.9 1109.6 1112.0 1133.6 1136.8 1139.6 11863.9 11893.3 11973.6 12121.7 12181.2 235666.0 235851.0 237466.0 239435.0 241626.0 54771.7 55193.4 55685.4 55805.0 55849.4 1479.0 1480.4 1483.6 1495.6 1508.5 27009.6 27947.0 28131.2 28279.6 28324.4 37377.6 37550.6 37762.0 37953.4 38128.4 182647.0 182751.0 183933.0 184072.0 185188.0 31249.7 34916.5 35009.5 35213.0 35299.0 41868.6 44088.8 44703.1 44935.3 45176.0 31481.8 31957.0 32293.0 32335.7 32430.8 31640.7 32061.0 32077.8 32178.0 32415.4 34433.3 36021.8 36083.8 36091.0 36116.6 30097.5 30865.2 31421.4 31545.7 31990.2 23762.6 25110.9 25249.2 25442.7 25988.0 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#2] jquery.html Cycles:180 Average:35953.73 Median:2043.41 stddev:90369.31 (4422.5%) stddev-sans-first:90583.74 09:52:43 INFO - PID 15676 | Values: 558.2 559.7 567.5 572.3 596.0 21248.2 22283.0 22286.8 22298.3 22312.2 25086.5 25936.4 27330.2 27377.2 27588.2 6807.0 6981.9 6986.3 6990.6 6992.8 6795.1 6856.0 6879.6 6880.9 6885.3 6494.2 6562.6 6784.9 6827.2 6829.5 6850.6 6895.3 6900.2 6906.1 6934.2 6755.3 6765.7 6769.4 6774.2 6789.5 29014.3 30644.2 31123.7 31177.8 32064.4 1994.8 2041.6 2042.1 2044.7 2050.5 19776.6 20216.6 20239.0 20282.6 20404.9 2422.0 2428.0 2532.3 2532.9 2534.5 125477.4 125654.0 127816.0 128499.0 129695.0 19480.8 21156.3 21220.0 21240.0 22378.8 43332.4 43681.6 43718.3 44030.8 44137.3 11693.6 11760.4 11886.4 12001.7 12102.2 9933.3 9954.2 10012.0 10019.3 10134.8 10748.3 10971.4 11053.8 11151.9 11383.8 3459.9 3592.7 3611.1 4244.8 4411.3 948.4 977.1 989.3 998.6 1000.6 19353.4 20239.3 20278.5 20828.9 20846.6 1039.5 1069.6 1077.7 1088.5 1090.1 10898.5 11104.9 11119.7 11273.9 11439.2 513603.0 539381.0 549971.0 553323.0 565066.0 102072.5 105154.0 105949.0 106437.0 106528.0 1188.7 1212.6 1231.0 1232.9 1242.2 16446.4 17856.6 17925.6 18008.5 18071.6 50091.0 50779.5 52154.5 52485.0 54180.2 64117.4 64156.0 64466.7 65001.0 70126.0 12913.9 13067.6 13118.5 13140.4 13218.8 15326.5 16936.0 19526.9 19607.1 19653.3 15877.0 15978.8 16047.8 16096.4 16270.6 13663.5 14173.2 14405.9 14948.5 15039.7 15379.4 15402.7 15585.5 15790.8 16910.2 12941.0 13191.6 13216.5 13284.1 13309.9 15120.5 16142.4 16156.9 16161.1 16241.2 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#3] mootools.html Cycles:180 Average:8552.28 Median:2618.24 stddev:5811.34 (222.0%) stddev-sans-first:5802.15 09:52:43 INFO - PID 15676 | Values: 1309.0 1405.5 1406.8 1416.6 1420.4 13477.4 14044.4 14059.2 14103.2 14114.9 13578.9 14086.7 14492.5 14508.3 14527.7 2626.0 2683.0 2683.8 2686.5 2690.1 2622.1 2652.5 2657.5 2659.3 2665.1 2582.2 2607.7 2614.4 2623.8 2625.5 2555.1 2649.7 2723.5 2729.4 2731.8 2661.7 2668.2 2679.2 2689.0 2698.4 13792.7 13981.7 14057.4 14062.6 14063.2 7456.5 7796.9 7807.5 7831.1 7837.7 4641.7 4806.6 4842.2 4850.6 4868.2 1846.8 1869.4 1888.8 1893.7 1952.7 22712.0 22930.7 22975.9 22978.4 23047.7 6347.1 6374.0 6383.1 6515.8 6547.1 15575.1 15599.9 15613.8 15634.3 15657.0 7202.7 7417.8 7423.6 7429.8 7443.9 6760.5 6795.8 6813.0 6916.3 6973.7 4549.4 4585.3 4693.9 4710.6 4727.0 1340.2 1341.8 1344.7 1352.5 1358.0 870.4 871.3 895.7 916.0 916.9 7258.4 7276.3 7282.1 7318.5 7339.7 691.5 707.2 980.3 1012.7 1032.7 4688.1 4898.3 4986.3 5103.3 5155.3 17338.9 18708.4 18858.0 18923.2 19192.4 17950.7 18218.4 18414.9 18500.4 18787.5 10089.2 10342.4 10446.8 10452.8 10510.4 7716.6 8087.8 8191.5 8310.8 8489.6 15942.9 15959.4 16256.3 16569.3 16632.9 16020.3 16577.0 16872.7 17150.1 17417.8 10371.9 10693.9 10699.1 10701.1 10705.7 12985.8 13183.9 13188.5 13218.9 13245.0 10576.4 10674.6 10710.4 10718.6 10943.4 10142.8 10467.7 10607.5 10613.3 10724.7 9397.1 9534.4 9548.0 9548.3 9554.5 6802.9 6892.8 6965.9 6994.3 7103.8 7056.2 7079.7 7278.2 7302.2 7410.2 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#4] prototype.html Cycles:180 Average:5394.50 Median:5880.22 stddev:1517.63 (25.8%) stddev-sans-first:1476.38 09:52:43 INFO - PID 15676 | Values: 479.8 505.2 506.7 510.5 512.6 5998.9 6094.7 6135.9 6142.8 6179.0 5871.8 5905.6 5914.9 5956.7 6074.8 4864.6 4877.5 4926.2 4930.2 4944.5 4868.8 4933.8 4934.7 4943.4 4944.8 4572.1 4758.9 4802.9 4825.0 4834.0 4751.8 4805.7 4842.4 4842.7 4853.8 4332.7 4340.5 4365.7 4366.3 4370.8 5830.0 5837.9 5842.2 5864.9 5888.6 5493.8 5536.3 5552.4 5553.9 5558.5 6261.9 6352.7 6375.5 6390.8 6399.4 4779.9 4781.4 4790.2 4790.5 4807.3 6716.5 6760.3 6776.0 6787.1 6800.4 4944.3 4950.3 4954.9 4973.2 4976.3 4937.3 4969.0 4996.4 5012.7 5014.5 5484.9 5524.1 5537.5 5538.3 5590.6 6258.0 6288.8 6298.7 6336.3 6465.8 1698.3 1738.8 1738.8 1748.2 1751.4 1081.6 1197.2 1198.8 1203.9 1207.7 5440.6 5518.9 5553.4 5622.8 5649.4 6497.3 6509.3 6562.6 6591.4 6720.0 5626.2 5675.5 5698.1 5726.5 5760.4 3440.4 3503.1 3506.9 3533.2 3560.7 6300.6 6312.8 6363.8 6403.6 6464.3 6756.0 6779.8 6829.6 6839.3 6859.6 6431.4 6453.8 6460.8 6475.8 6501.3 6547.6 6566.7 6581.4 6613.5 6645.3 6522.6 6567.7 6599.0 6608.2 6633.9 6385.8 6386.4 6426.6 6436.8 6437.5 4807.0 4831.6 4881.5 4918.9 4958.4 6602.4 6621.5 6635.2 6649.8 6662.2 6340.4 6388.7 6398.6 6423.4 6437.7 6425.5 6428.0 6460.0 6464.2 6471.4 6362.7 6390.3 6395.4 6396.5 6398.2 5808.0 6370.8 6374.5 6447.4 6477.9 6138.7 6188.9 6251.6 6264.4 6281.7 09:52:43 INFO - PID 15676 | 09:52:43 INFO - PID 15676 | [#5] yui.html Cycles:180 Average:21173.83 Median:19012.43 stddev:27623.75 (145.3%) stddev-sans-first:27659.46 09:52:43 INFO - PID 15676 | Values: 940.7 946.2 960.9 968.6 973.6 18167.1 18468.9 18601.7 18870.4 18889.9 19050.6 19884.7 20669.4 20850.4 20908.1 1030.1 1062.6 1064.3 1064.7 1064.7 1054.7 1063.0 1063.8 1066.8 1067.9 1017.0 1118.6 1119.1 1122.6 1123.0 1079.3 1089.7 1091.9 1094.6 1098.8 800.6 805.1 805.6 808.0 808.1 16300.8 17665.0 18923.2 19214.1 19263.6 19928.4 20172.4 20401.3 20445.1 20500.0 14958.0 15235.8 15340.3 15499.1 15517.9 3486.5 3565.6 3587.4 3588.5 3601.1 105933.5 108871.0 110008.0 111087.0 114246.0 16240.5 16602.0 16663.8 16668.2 16710.5 27741.6 29171.6 29428.7 29497.7 29787.6 9183.6 9252.4 9254.6 9276.6 9280.3 4120.3 4249.0 4266.8 4282.5 4296.5 4902.4 5003.1 5004.5 5035.5 5038.1 931.4 961.9 1036.3 1059.7 1061.5 693.3 719.8 725.1 733.0 743.0 11810.3 12242.6 12675.8 12738.5 12760.9 702.0 704.8 711.2 724.7 740.9 5429.3 5499.9 5585.0 5627.6 5796.0 93210.5 93474.5 97636.5 99406.5 101771.5 86035.6 88529.0 89443.6 90183.5 93257.1 71699.6 72728.6 73560.6 73823.6 74901.3 10297.5 10314.8 10354.0 10452.3 10675.6 35833.3 36473.3 36936.6 37455.8 37656.6 42811.4 43706.1 44768.0 44786.8 45896.8 14462.3 14470.1 14551.2 14561.1 14564.7 16094.5 16625.8 17181.8 17213.6 17237.7 15704.8 16163.2 18023.6 18974.2 19173.3 17658.5 18090.3 18365.2 18439.6 18806.6 18329.9 18456.4 18556.5 18834.4 18957.4 12847.0 13715.2 14057.7 14093.7 14109.5 13364.0 13381.9 14023.6 14274.8 14395.6 09:52:43 INFO - PID 15676 | -------- Summary: end -------- 09:52:43 INFO - PID 15676 | 09:52:43 INFO - TEST-INFO | 15676: exit 0 09:52:43 INFO - TEST-OK | dromaeo_css | took 1113070ms 09:52:43 INFO - TEST-START | kraken 09:52:43 INFO - Initialising browser for kraken test... 09:52:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59439/getInfo.html -profile /tmp/tmpZQd_Za/profile 09:52:43 INFO - TEST-INFO | started process 16077 (/builds/slave/test/build/application/firefox/firefox http://localhost:59439/getInfo.html) 09:52:49 INFO - TEST-INFO | 16077: exit 0 09:52:50 INFO - Browser initialized. 09:52:50 INFO - Running cycle 1/1 for kraken test... 09:52:50 INFO - TEST-INFO | started process 16278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZQd_Za/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:01 INFO - PID 16278 | RSS: Main: 169160704 09:53:01 INFO - PID 16278 | 09:53:03 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59439/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:04 INFO - PID 16278 | RSS: Main: 174133248 09:53:04 INFO - PID 16278 | 09:53:07 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59439/tests/kraken/driver.html?testName=audio-dft) 09:53:08 INFO - PID 16278 | RSS: Main: 174174208 09:53:08 INFO - PID 16278 | 09:53:11 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59439/tests/kraken/driver.html?testName=audio-fft) 09:53:11 INFO - PID 16278 | RSS: Main: 168935424 09:53:11 INFO - PID 16278 | 09:53:13 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59439/tests/kraken/driver.html?testName=audio-oscillator) 09:53:14 INFO - PID 16278 | RSS: Main: 169697280 09:53:14 INFO - PID 16278 | 09:53:16 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:17 INFO - PID 16278 | RSS: Main: 169996288 09:53:17 INFO - PID 16278 | 09:53:20 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59439/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:20 INFO - PID 16278 | RSS: Main: 173629440 09:53:20 INFO - PID 16278 | 09:53:24 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59439/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:24 INFO - PID 16278 | RSS: Main: 174747648 09:53:24 INFO - PID 16278 | 09:53:27 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59439/tests/kraken/driver.html?testName=json-parse-financial) 09:53:28 INFO - PID 16278 | RSS: Main: 174862336 09:53:28 INFO - PID 16278 | 09:53:29 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:30 INFO - PID 16278 | RSS: Main: 173662208 09:53:30 INFO - PID 16278 | 09:53:31 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:32 INFO - PID 16278 | RSS: Main: 174100480 09:53:32 INFO - PID 16278 | 09:53:34 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:35 INFO - PID 16278 | RSS: Main: 174014464 09:53:35 INFO - PID 16278 | 09:53:37 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:38 INFO - PID 16278 | RSS: Main: 173875200 09:53:38 INFO - PID 16278 | 09:53:41 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:42 INFO - PID 16278 | RSS: Main: 173957120 09:53:42 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | Cycle 1(1): loaded http://localhost:59439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59439/tests/kraken/driver.html?testName=ai-astar) 09:53:44 INFO - PID 16278 | RSS: Main: 175616000 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | __start_tp_report 09:53:44 INFO - PID 16278 | _x_x_mozilla_page_load 09:53:44 INFO - PID 16278 | _x_x_mozilla_page_load_details 09:53:44 INFO - PID 16278 | |i|pagename|runs| 09:53:44 INFO - PID 16278 | |0;ai-astar;100;108;108;108;112;109;108;108;109;111 09:53:44 INFO - PID 16278 | |1;audio-beat-detection;158;122;147;173;125;151;146;121;172;120 09:53:44 INFO - PID 16278 | |2;audio-dft;165;165;170;162;161;168;161;163;171;173 09:53:44 INFO - PID 16278 | |3;audio-fft;82;75;76;158;74;75;75;74;93;75 09:53:44 INFO - PID 16278 | |4;audio-oscillator;82;82;140;81;81;82;132;81;83;127 09:53:44 INFO - PID 16278 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;115;114;114 09:53:44 INFO - PID 16278 | |6;imaging-darkroom;150;150;151;150;150;150;150;150;150;149 09:53:44 INFO - PID 16278 | |7;imaging-desaturate;94;95;94;95;94;94;94;94;95;94 09:53:44 INFO - PID 16278 | |8;json-parse-financial;57;56;56;54;55;55;55;57;55;56 09:53:44 INFO - PID 16278 | |9;json-stringify-tinderbox;54;54;53;54;54;54;54;53;54;54 09:53:44 INFO - PID 16278 | |10;stanford-crypto-aes;78;78;77;76;79;77;76;78;77;77 09:53:44 INFO - PID 16278 | |11;stanford-crypto-ccm;136;128;134;128;127;125;126;145;139;171 09:53:44 INFO - PID 16278 | |12;stanford-crypto-pbkdf2;196;200;183;196;177;183;191;182;202;192 09:53:44 INFO - PID 16278 | |13;stanford-crypto-sha256-iterative;70;70;73;74;72;70;69;68;70;68 09:53:44 INFO - PID 16278 | __end_tp_report 09:53:44 INFO - PID 16278 | __start_cc_report 09:53:44 INFO - PID 16278 | _x_x_mozilla_cycle_collect,905 09:53:44 INFO - PID 16278 | __end_cc_report 09:53:44 INFO - PID 16278 | __startTimestamp1499360024283__endTimestamp 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | ------- Summary: start ------- 09:53:44 INFO - PID 16278 | Number of tests: 14 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.50 stddev:3.18 (2.9%) stddev-sans-first:1.50 09:53:44 INFO - PID 16278 | Values: 100.0 108.0 108.0 108.0 112.0 109.0 108.0 108.0 109.0 111.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.00 stddev:20.63 (13.8%) stddev-sans-first:21.20 09:53:44 INFO - PID 16278 | Values: 158.0 122.0 147.0 173.0 125.0 151.0 146.0 121.0 172.0 120.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.50 stddev:4.36 (2.6%) stddev-sans-first:4.61 09:53:44 INFO - PID 16278 | Values: 165.0 165.0 170.0 162.0 161.0 168.0 161.0 163.0 171.0 173.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#3] audio-fft Cycles:10 Average:85.70 Median:75.00 stddev:26.08 (34.8%) stddev-sans-first:27.62 09:53:44 INFO - PID 16278 | Values: 82.0 75.0 76.0 158.0 74.0 75.0 75.0 74.0 93.0 75.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:81.50 stddev:24.97 (30.6%) stddev-sans-first:25.88 09:53:44 INFO - PID 16278 | Values: 82.0 82.0 140.0 81.0 81.0 82.0 132.0 81.0 83.0 127.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:53:44 INFO - PID 16278 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:53:44 INFO - PID 16278 | Values: 150.0 150.0 151.0 150.0 150.0 150.0 150.0 150.0 150.0 149.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:53:44 INFO - PID 16278 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:0.88 09:53:44 INFO - PID 16278 | Values: 57.0 56.0 56.0 54.0 55.0 55.0 55.0 57.0 55.0 56.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:53:44 INFO - PID 16278 | Values: 54.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 54.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.50 stddev:0.95 (1.2%) stddev-sans-first:0.97 09:53:44 INFO - PID 16278 | Values: 78.0 78.0 77.0 76.0 79.0 77.0 76.0 78.0 77.0 77.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.00 stddev:13.94 (10.3%) stddev-sans-first:14.79 09:53:44 INFO - PID 16278 | Values: 136.0 128.0 134.0 128.0 127.0 125.0 126.0 145.0 139.0 171.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.20 Median:194.00 stddev:8.51 (4.4%) stddev-sans-first:8.76 09:53:44 INFO - PID 16278 | Values: 196.0 200.0 183.0 196.0 177.0 183.0 191.0 182.0 202.0 192.0 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.01 (2.9%) stddev-sans-first:2.13 09:53:44 INFO - PID 16278 | Values: 70.0 70.0 73.0 74.0 72.0 70.0 69.0 68.0 70.0 68.0 09:53:44 INFO - PID 16278 | -------- Summary: end -------- 09:53:44 INFO - PID 16278 | 09:53:44 INFO - PID 16278 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:53:44 INFO - TEST-INFO | 16278: exit 0 09:53:45 INFO - TEST-OK | kraken | took 61051ms 09:53:45 INFO - SUITE-END | took 1174s 09:53:45 INFO - Completed test suite (00:19:34) 09:53:45 INFO - javascript benchmark 09:53:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8337.443114594864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.3941211757656, 3079.2917628945356, 3087.8147311161324, 3104.8137111773294, 3131.311111555457, 5985.0, 5998.4301491358365, 6034.33622301547, 6125.173101631284, 6125.63246205228, 6089.056196289582, 6109.022556390978, 6142.201513803199, 6179.351168127349, 6191.721372538235, 5637.633553818989, 5641.971790141064, 5643.435656434365, 5679.062954612484, 5691.08942569189, 5482.5613950883835, 5554.638948468357, 5634.12671035988, 5637.0, 5647.830565083054, 5497.39528651848, 5540.113581826909, 5565.9443405566035, 5567.832965011056, 5568.16477528372, 5541.33503979525, 5551.8889622207325, 5575.944240557583, 5590.217369568264, 5596.160575913605, 5463.289772329572, 5490.917636235459, 5535.197396377543, 5539.723013849291, 5549.445055494459, 5981.0729336952845, 5990.9101363479585, 5997.910031349533, 5998.730057147439, 6006.519478441714, 6406.487481001509, 6483.0, 6485.805425837232, 6486.124373209651, 6495.7076931538195, 6510.739570417178, 6532.0, 6551.574147680385, 6562.573432726857, 6566.63883486408, 5970.522358211376, 6049.697515124226, 6053.455189032964, 6058.848528786772, 6059.363766804466, 6700.731970721116, 6713.12729345182, 6778.051072849805, 6785.491088168407, 6795.694193761243, 6252.249730032334, 6359.459445947146, 6381.425671689571, 6384.553081284358, 6399.680015999182, 6328.873422531616, 6352.078948552434, 6390.584612000205, 6391.840203994844, 6412.5190610704385, 4784.4497882743235, 6384.48924086072, 6420.6147631142285, 6436.324185960407, 6512.6092434454085, 6318.083877837687, 6424.775132870327, 6433.517486188554, 6479.22249330074, 6496.350364963466, 5132.5124113209185, 5148.794048238028, 5196.610254230948, 5210.0, 5210.47895210476, 4408.360787685768, 4464.553544645574, 4465.732056076646, 4473.642108631302, 4501.48232953208, 4681.573341185066, 5585.944140558624, 5603.467670571289, 5650.152477128464, 5651.434856514398, 6455.289918109004, 6529.7714579990425, 6539.901901471481, 6612.437942774822, 6659.966700166468, 5657.98156331856, 5680.971595141998, 5709.172170035322, 5709.286339207599, 5755.424457554295, 5643.802466913638, 5719.942800572025, 5728.942710572841, 5798.188253644493, 5803.7968671096305, 6352.460040896483, 6364.872702545923, 6365.2998170201245, 6369.713362898588, 6386.489080873519, 6501.804945851632, 6540.705668244846, 6565.573237739532, 6570.08018877348, 6591.769288074895, 6313.715882785377, 6317.96841015792, 6343.460805831556, 6365.204349456318, 6377.075324078076, 6366.9044964326495, 6368.745250189941, 6409.71156297977, 6419.582727122722, 6442.35576442352, 6521.217453905561, 6524.510661700487, 6533.67331633407, 6620.569662971891, 6633.70148343316, 6291.119243306032, 6303.6532990685955, 6381.138546296191, 6399.200099987502, 6414.326495718069, 6187.721552530057, 6302.842428939313, 6360.204974378203, 6362.077498762561, 6389.584676995981, 6217.813465596039, 6265.906011409924, 6278.183836101278, 6278.309385967448, 6291.465225455888, 6218.409251121137, 6331.651759153291, 6374.74501019954, 6399.2640846303275, 6399.8080057598345, 6131.019036954066, 6159.5688301818445, 6161.260648722182, 6164.907526387197, 6172.969135154295], "value": 5916.818963569782, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.5936675461742, 793.1354823242665, 823.411260948422, 848.1942154952796, 851.1786126388037, 40011.59988400115, 41331.17337653245, 41331.79334103333, 41396.0, 41546.79226603867, 37544.62455375445, 37600.811995939985, 37674.24651506968, 37911.431328530096, 38072.42891356625, 6909.274526174755, 6975.197852246981, 6989.580625162506, 7025.0, 7078.0, 6911.447084233249, 7040.225575186751, 7044.929550704479, 7046.365827075562, 7049.224585295613, 6950.096487456623, 7024.367806897379, 7031.8945215821805, 7038.436925045984, 7053.0, 6965.094537710116, 6966.616836074014, 6992.825179370506, 7018.4385249180195, 7021.403180729644, 6253.843653908643, 6297.370262973712, 6298.401651843067, 6344.619322840598, 6377.139086223347, 33765.831170844234, 33786.662133378595, 33835.15412114692, 33927.830360848035, 34050.31899361999, 3417.333619944112, 3426.623071462137, 3455.7235421166497, 3543.8759643412614, 3639.217568222845, 31907.84046079778, 31941.923774954786, 32073.358532829447, 32198.0, 32379.514307285408, 4760.23836186212, 4897.6326775491625, 4971.627127965381, 5040.7731652075745, 5047.49525047496, 196207.0, 199319.0, 200263.0, 200466.0, 202074.0, 48762.0, 49357.50642493601, 49722.75693107701, 49845.0, 49915.75042124839, 51597.0, 51663.22505162351, 51670.74164629153, 52009.7399513, 52013.0, 16543.83456165423, 16670.33318667264, 16742.414015509643, 16794.916025419796, 16839.57901052459, 13847.930760346133, 14001.789973150411, 14045.157290562598, 14064.789028164585, 14075.648108797363, 14230.0, 14257.643558910902, 14428.062175958528, 14524.49164279245, 14673.559793206221, 5633.887322253532, 5717.799877004285, 5800.361960184377, 5855.853603659857, 5871.853203669857, 985.4678473624163, 1009.2027298434155, 1021.3922715983978, 1031.9587216511256, 1044.6343779677052, 22706.318810435714, 22807.543849123256, 22896.542069158524, 23165.420864478187, 23726.88136559306, 1109.6227282723912, 1111.955521779136, 1133.5919069135105, 1136.7953768321615, 1139.6011396011495, 11863.88136118645, 11893.345865977455, 11973.580924667594, 12121.69695757613, 12181.208221465753, 235666.0, 235851.0, 237466.0, 239435.0, 241626.0, 54771.726141369836, 55193.44806551963, 55685.44314556884, 55805.0, 55849.44150558524, 1479.0164540580392, 1480.4226351723053, 1483.6365090552667, 1495.5887131038833, 1508.4569554960206, 27009.59485607757, 27947.021854235005, 28131.156065318075, 28279.57580636251, 28324.433511329247, 37377.62622373742, 37550.624493754716, 37762.0, 37953.4306985401, 38128.428073579475, 182647.0, 182751.0, 183933.0, 184072.0, 185188.0, 31249.68750312468, 34916.47625285674, 35009.474857876645, 35213.0, 35299.0, 41868.58131418647, 44088.77955610202, 44703.10593788041, 44935.32597010982, 45176.0, 31481.8425907869, 31957.0, 32293.0, 32335.67664323421, 32430.83784581062, 31640.683593164693, 32061.0, 32077.839610801795, 32178.0, 32415.351692965538, 34433.31133377369, 36021.81989090038, 36083.81958090298, 36091.0, 36116.63883361133, 30097.51287389062, 30865.228369290948, 31421.371572568878, 31545.684543155192, 31990.20024499313, 23762.643560346954, 25110.874445627654, 25249.242522724348, 25442.74557254478, 25988.0], "value": 16982.01848771047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.2407925221697, 559.6558116758192, 567.5317862763221, 572.2789285500269, 595.9880802383951, 21248.15007399704, 22283.0, 22286.777132228694, 22298.331050068482, 22312.21907233247, 25086.49827003459, 25936.35159121023, 27330.180094597195, 27377.178684639493, 27588.17235482939, 6807.0, 6981.895271570905, 6986.301369863024, 6990.6155161466095, 6992.79021629352, 6795.082663840392, 6856.040154378366, 6879.6216208108535, 6880.862382752342, 6885.3114688530995, 6494.188226471691, 6562.639054851981, 6784.864302713942, 6827.180738311409, 6829.521933464659, 6850.588964662112, 6895.34494223048, 6900.2064762551945, 6906.06768086312, 6934.167899851999, 6755.2906944771075, 6765.695543700545, 6769.3907548320885, 6774.220964589086, 6789.456843452512, 29014.27464313388, 30644.233894152603, 31123.688763112532, 31177.8441107793, 32064.35871282561, 1994.7905469925595, 2041.5814757974579, 2042.0708577597306, 2044.7444069491314, 2050.4771283322807, 19776.604467910704, 20216.595668086702, 20239.0, 20282.594348112954, 20404.897975510175, 2421.9515609687883, 2427.9514409711883, 2532.341591186305, 2532.9493410131877, 2534.5437821192177, 125477.37261313727, 125654.0, 127816.0, 128499.0, 129695.0, 19480.8051919479, 21156.259530916344, 21219.99740085768, 21240.0, 22378.842329297768, 43332.350014749805, 43681.56318436839, 43718.344224836655, 44030.779846100566, 44137.33793993093, 11693.590724324607, 11760.411979400995, 11886.40567971598, 12001.699957501132, 12102.213356131822, 9933.304668673123, 9954.153896918842, 10012.0, 10019.348742331726, 10134.797304053878, 10748.301360411548, 10971.396573188551, 11053.834192487118, 11151.944240278746, 11383.772324553629, 3459.8962031138603, 3592.7485076044427, 3611.115276757211, 4244.830206791756, 4411.250087485071, 948.4498990585444, 977.1254727019278, 989.3371441134457, 998.5805961496189, 1000.5797565022708, 19353.4193974181, 20239.291624793063, 20278.493037674176, 20828.895855520626, 20846.583068338547, 1039.4958445154093, 1069.6256310291335, 1077.7467295185625, 1088.4612117002134, 1090.1170052257696, 10898.482963939836, 11104.944475277573, 11119.72200694989, 11273.887261127284, 11439.199256052163, 513603.0, 539381.0, 549971.0, 553323.0, 565066.0, 102072.48963755133, 105154.0, 105949.0, 106436.99999999846, 106528.0, 1188.7432111542548, 1212.6483319837148, 1230.993845030769, 1232.8643849176583, 1242.2049888071642, 16446.424375146813, 17856.642867142844, 17925.551861203574, 18008.459746207634, 18071.554275658178, 50091.0, 50779.492205078954, 52154.478455214965, 52485.0, 54180.18729718978, 64117.358826413, 64156.0, 64466.67766661324, 65001.0, 70126.0, 12913.935430323165, 13067.607971760863, 13118.540851070167, 13140.408681609542, 13218.801717974045, 15326.540203793904, 16936.0, 19526.90236548808, 19607.117679704163, 19653.31213407524, 15877.0, 15978.760318595463, 16047.839521605101, 16096.356145754038, 16270.593235168742, 13663.453461861813, 14173.22047287409, 14405.92797036008, 14948.476803311833, 15039.699206016037, 15379.38482460689, 15402.691946161238, 15585.532434026998, 15790.76313855316, 16910.154492275582, 12941.029422793139, 13191.604251872459, 13216.537421190213, 13284.136531125447, 13309.933450333074, 15120.54638360851, 16142.435014774426, 16156.919215404318, 16161.111138887474, 16241.187940602686], "value": 12307.128436921177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.9803652945204, 1405.5221224783572, 1406.7678832992556, 1416.5608661314993, 1420.431827269093, 13477.39351729172, 14044.368003439844, 14059.22674252917, 14103.15381077136, 14114.929425352884, 13578.864211357883, 14086.718265634681, 14492.492762753305, 14508.347124379401, 14527.709445811077, 2625.973740262597, 2682.986585067072, 2683.798715096366, 2686.476137153256, 2690.1391554702504, 2622.1084831157405, 2652.4562464694786, 2657.548216803148, 2659.3484596273843, 2665.147152911069, 2582.2382397192873, 2607.7131515533274, 2614.372550587864, 2623.8032147589006, 2625.5274050670873, 2555.1312553731727, 2649.682038155424, 2723.482538317733, 2729.3623825704617, 2731.8497482638445, 2661.680598328213, 2668.212877201211, 2679.1560658392546, 2689.031948498539, 2698.3793727442603, 13792.724145517133, 13981.650458738512, 14057.367418466194, 14062.648433789238, 14063.226522541256, 7456.478046536745, 7796.883046754303, 7807.492512986638, 7831.099423566306, 7837.6864925402915, 4641.651876109306, 4806.591439727627, 4842.249451335048, 4850.5877000455, 4868.172410690191, 1846.8245516675895, 1869.3831035758167, 1888.7733471983313, 1893.715942608606, 1952.6778081616517, 22712.0, 22930.656040159578, 22975.88512057429, 22978.425539361484, 23047.654285185734, 6347.143135676717, 6374.0, 6383.138276332728, 6515.7719479818925, 6547.148870646785, 15575.065496070272, 15599.922000390152, 15613.765793513106, 15634.296456659478, 15657.0, 7202.71189152428, 7417.777466676009, 7423.62881855905, 7429.777106686808, 7443.85112297751, 6760.492963027793, 6795.830104247335, 6812.965935170391, 6916.3429474199875, 6973.686184121727, 4549.385832912514, 4585.312203169551, 4693.906121877611, 4710.599599034052, 4727.0, 1340.1891855427325, 1341.7987301904598, 1344.7108871592654, 1352.5198554513204, 1358.0357945858354, 870.3863776037878, 871.3464901324007, 895.6865097215922, 915.9679411220575, 916.8578870275118, 7258.383037441877, 7276.345128938315, 7282.053333066668, 7318.524295920748, 7339.7064117435775, 691.4572060932144, 707.1832034000737, 980.3333733061444, 1012.731626119079, 1032.695354870315, 4688.109259240801, 4898.289747986593, 4986.252062190628, 5103.2855400244, 5155.304033955368, 17338.91330543339, 18708.438746837615, 18858.0, 18923.24307027731, 19192.424227273204, 17950.730739038925, 18218.362357317696, 18414.907925460288, 18500.444986650422, 18787.530311742317, 10089.192864570818, 10342.37945723259, 10446.791064178673, 10452.843207351896, 10510.421926793946, 7716.5755883426955, 8087.757367278991, 8191.549464779256, 8310.83378332442, 8489.575521224038, 15942.920285398499, 15959.361625534848, 16256.268467918735, 16569.25438355253, 16632.916835415745, 16020.27908744086, 16577.0, 16872.735236729666, 17150.142492875057, 17417.82582174162, 10371.896281037092, 10693.9465302673, 10699.144068474348, 10701.090407315465, 10705.678829635124, 12985.805212921625, 13183.945284377418, 13188.472461101448, 13218.933905330412, 13245.0, 10576.418296993432, 10674.62638807638, 10710.410927398756, 10718.624848130277, 10943.398113103856, 10142.847857281999, 10467.685969420625, 10607.522661480407, 10613.257072005194, 10724.678259652223, 9397.107274808883, 9534.427934323685, 9547.952260238655, 9548.331616787036, 9554.52227388614, 6802.897956530557, 6892.758753443806, 6965.860682786417, 6994.311014494183, 7103.786886393416, 7056.188538317954, 7079.716811327489, 7278.199398066103, 7302.233265507045, 7410.184879663125], "value": 6251.761892970918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.7888928871294, 505.15891041416046, 506.7440942324126, 510.5481648740863, 512.5771238728049, 5998.850028749283, 6094.695265236737, 6135.938640613604, 6142.815715528542, 6179.0, 5871.823845284637, 5905.616134951225, 5914.940850591493, 5956.702164891749, 6074.754675291566, 4864.586510146642, 4877.463479017305, 4926.187179115442, 4930.161872481678, 4944.480829512903, 4868.780904859272, 4933.80264789408, 4934.679245849008, 4943.4067911850625, 4944.826931057413, 4572.062727140945, 4758.857234282977, 4802.855914322576, 4824.951750482485, 4833.975830120862, 4751.833685820997, 4805.711657300556, 4842.370491836074, 4842.685225460334, 4853.805847766085, 4332.740035597874, 4340.52254252032, 4365.672574556921, 4366.3013917773005, 4370.847020354272, 5829.970850145722, 5837.854053648693, 5842.152887831283, 5864.912026319608, 5888.617239879394, 5493.752781124859, 5536.307961504812, 5552.416996215379, 5553.945040335102, 5558.499735023867, 6261.8747625047245, 6352.682365881734, 6375.45808606269, 6390.7763228286785, 6399.424051835311, 4779.856604301876, 4781.402324709411, 4790.209615413452, 4790.4969978152485, 4807.326974223612, 6716.46268298535, 6760.32396760325, 6776.0, 6787.117674702257, 6800.421964133055, 4944.25836124577, 4950.292149208517, 4954.876128096755, 4973.204287314013, 4976.303317535548, 4937.308776771255, 4968.962725282617, 4996.4254110777, 5012.674176178537, 5014.473480284518, 5484.862878427992, 5524.116141417434, 5537.501624853782, 5538.252335934597, 5590.636608620427, 6258.028720952885, 6288.836565235446, 6298.716557754912, 6336.271328797156, 6465.838354041092, 1698.312183565658, 1738.7828520035773, 1738.817424170444, 1748.2133040131991, 1751.351999760097, 1081.5511562701547, 1197.2038594334845, 1198.8381568488142, 1203.867574566797, 1207.7403358278013, 5440.591955603346, 5518.91721624176, 5553.361363443256, 5622.823104945693, 5649.406812284733, 6497.252815926229, 6509.2839787623325, 6562.606243625398, 6591.439727623206, 6719.992001199859, 5626.1842032905, 5675.460831221028, 5698.0598201296325, 5726.5418766499415, 5760.3951585083805, 3440.449528075546, 3503.054175372635, 3506.8772592959126, 3533.169705119295, 3560.732945029133, 6300.621962682254, 6312.810615681445, 6363.840903977438, 6403.551751377358, 6464.319276988017, 6755.973208037569, 6779.847370972521, 6829.590224586442, 6839.2818754031105, 6859.5541289816, 6431.389018043278, 6453.774117905851, 6460.806175814733, 6475.838104047531, 6501.317361676955, 6547.607143571401, 6566.704498297492, 6581.407673309425, 6613.470922326299, 6645.305447111149, 6522.641254731036, 6567.665340875, 6599.0, 6608.173978252718, 6633.933660663524, 6385.776497822554, 6386.361363863763, 6426.550141490051, 6436.806895793134, 6437.452816510462, 4807.0, 4831.637627177905, 4881.463039065771, 4918.92621610669, 4958.355413796184, 6602.40578347951, 6621.470282377494, 6635.170603674541, 6649.767258145942, 6662.167229096363, 6340.4293613575, 6388.680565971776, 6398.648074355955, 6423.357664233727, 6437.678116094083, 6425.453836423956, 6427.967860160669, 6460.030995350735, 6464.191976003, 6471.449926756279, 6362.6818659067785, 6390.265119511316, 6395.392437718409, 6396.456301214449, 6398.168238129014, 5808.0, 6370.840728981627, 6374.458171055512, 6447.387498187664, 6477.902831457626, 6138.693065346625, 6188.876222475616, 6251.593646412968, 6264.373562643699, 6281.72335238402], "value": 4947.846507608357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.6613619097124, 946.1549977543789, 960.9087136722009, 968.6077138758806, 973.5716284834672, 18167.091645417724, 18468.90765546172, 18601.7209741854, 18870.433886983377, 18889.905550472264, 19050.618987620273, 19884.701729474033, 20669.379918602466, 20850.374488765323, 20908.05913733882, 1030.114101872391, 1062.6121465665053, 1064.302881612545, 1064.675274041417, 1064.7338165458636, 1054.741588310865, 1063.016709543669, 1063.8138325792993, 1066.8239740442818, 1067.898549637787, 1016.9542370593341, 1118.6420345489446, 1119.0599896087285, 1122.5622007417114, 1122.9893096213432, 1079.3416016230133, 1089.7112265249716, 1091.8635170603675, 1094.6332978452228, 1098.780243951209, 800.5836964778283, 805.0942689474341, 805.6455159729759, 808.0, 808.0989696488373, 16300.836991630169, 17665.028423436706, 18923.24307027717, 19214.13536390866, 19263.614727705506, 19928.402147935583, 20172.39482815518, 20401.285954991505, 20445.079971401174, 20499.975001249877, 14958.027728197632, 15235.847641523555, 15340.309686064042, 15499.070055796688, 15517.922410387988, 3486.477028445728, 3565.625609311037, 3587.3901436755814, 3588.4796704477967, 3601.099725068733, 105933.47033264785, 108871.0, 110008.0, 111087.0, 114246.0, 16240.51278461648, 16602.0, 16663.83336166647, 16668.249928753234, 16710.498685039467, 27741.58387624187, 29171.562426563618, 29428.705712942596, 29497.705022949925, 29787.55318670222, 9183.632654693738, 9252.444853308823, 9254.629814807467, 9276.62893484253, 9280.303977201602, 4120.299549076664, 4249.0, 4266.8293268269545, 4282.464691913511, 4296.484421869396, 4902.41171059468, 5003.074431230234, 5004.499550044967, 5035.521625445577, 5038.143515602356, 931.38993958957, 961.8701475300885, 1036.3212096077082, 1059.7297689089387, 1061.490484567412, 693.2582137113341, 719.8092505486051, 725.147951157388, 732.9670164842595, 742.9814254643677, 11810.324177579068, 12242.551489701917, 12675.809862852064, 12738.490460381667, 12760.872391275969, 701.9646022117438, 704.7639040921247, 711.1750369571273, 724.7282269149069, 740.8592367450167, 5429.348478182644, 5499.917501237484, 5585.0, 5627.634203776742, 5796.043652797325, 93210.53394732982, 93474.53262733779, 97636.51181744046, 99406.5029674847, 101771.49114254382, 86035.56982215049, 88529.0, 89443.55278223567, 90183.54908225549, 93257.0674293262, 71699.64150179215, 72728.63635681788, 73560.63219683868, 73823.63088184631, 74901.25098748943, 10297.50686150489, 10314.845277320695, 10354.0, 10452.32059916103, 10675.572977081141, 35833.28333433369, 36473.27053458863, 36936.63063369332, 37455.81272093622, 37656.623433765315, 42811.35782963196, 43706.12587748291, 44768.0, 44786.776066120765, 45896.770516147204, 14462.349194286493, 14470.059446135967, 14551.199684017058, 14561.053531520418, 14564.708705825613, 16094.517164485083, 16625.750613741046, 17181.82818171802, 17213.56966075808, 17237.65524689474, 15704.764428533352, 16163.191840407697, 18023.63952720912, 18974.24103035863, 19173.32893348726, 17658.470245892644, 18090.27638894482, 18365.173567189777, 18439.631207376045, 18806.6238675223, 18329.90835045816, 18456.446306610822, 18556.536086597942, 18834.434966950466, 18957.43127706171, 12847.0, 13715.177089374669, 14057.718845623234, 14093.718125637635, 14109.506167284097, 13364.0, 13381.866181338451, 14023.649408764863, 14274.785878211627, 14395.568132956028], "value": 8780.432549616868, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 108.0, 108.0, 112.0, 109.0, 108.0, 108.0, 109.0, 111.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 147.0, 173.0, 125.0, 151.0, 146.0, 121.0, 172.0, 120.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 170.0, 162.0, 161.0, 168.0, 161.0, 163.0, 171.0, 173.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 76.0, 158.0, 74.0, 75.0, 75.0, 74.0, 93.0, 75.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 81.0, 81.0, 82.0, 132.0, 81.0, 83.0, 127.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 54.0, 55.0, 55.0, 55.0, 57.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 76.0, 79.0, 77.0, 76.0, 78.0, 77.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 134.0, 128.0, 127.0, 125.0, 126.0, 145.0, 139.0, 171.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 183.0, 196.0, 177.0, 183.0, 191.0, 182.0, 202.0, 192.0], "value": 190.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 74.0, 72.0, 70.0, 69.0, 68.0, 70.0, 68.0], "value": 70.4, "unit": "score"}]}]} 09:53:45 INFO - Return code: 0 09:53:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:45 INFO - # TBPL SUCCESS # 09:53:45 INFO - Running post-action listener: _package_coverage_data 09:53:45 INFO - Running post-action listener: _resource_record_post_action 09:53:45 INFO - [mozharness: 2017-07-06 16:53:45.587255Z] Finished run-tests step (success) 09:53:45 INFO - Running post-run listener: _resource_record_post_run 09:53:45 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436916224; Read time: 0; Write time: 336652 09:53:45 INFO - TinderboxPrint: CPU usage
13.1% 09:53:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 09:53:45 INFO - TinderboxPrint: I/O write bytes / time
436,916,224 / 336,652 09:53:45 INFO - TinderboxPrint: CPU idle
8,265.4 (86.9%) 09:53:45 INFO - TinderboxPrint: CPU user
1,198.7 (12.6%) 09:53:45 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106455040; Read time: 0; Write time: 89564 09:53:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:53:45 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 328781824; Read time: 0; Write time: 246944 09:53:46 INFO - Running post-run listener: _upload_blobber_files 09:53:46 INFO - Blob upload gear active. 09:53:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:46 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 09:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:53:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:47 INFO - (blobuploader) - INFO - Done attempting. 09:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:48 INFO - (blobuploader) - INFO - Done attempting. 09:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:50 INFO - (blobuploader) - INFO - Done attempting. 09:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:53 INFO - (blobuploader) - INFO - Done attempting. 09:53:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:53 INFO - Return code: 0 09:53:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4f3af5458085619420706ae0e3c47427db5dbb6ffdabb28ee39b43fe71d1f044edd35ba9c05b0241abf74279e12b446a8cf44d9f5bfae042481cbc31847d345", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4dc9096d6ecbccd577b3387744b62171b3e5018746b0fe3d52b37dc27d4ce4da586dbf1b42b1e0808691ff32ddaebca47718d26412c9c6123e3f1b2c069f225", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d5d4984e0b8f4c4c7fee875f0884b3cb187115f7f72dea92c6a04d66953f80ce7ebbd9f35893c880cb1028dee11ad8684455cc89a4c071b466323d2e4928df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f447fd4f98dc68a80abf706e4ef37aaba0335f34b93c80dde1daa57eec536730ee407e3d8c34626db3b287672e560cddcec4cc6660329aaf0a40d741f9e67948"} 09:53:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:53 INFO - Contents: 09:53:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4f3af5458085619420706ae0e3c47427db5dbb6ffdabb28ee39b43fe71d1f044edd35ba9c05b0241abf74279e12b446a8cf44d9f5bfae042481cbc31847d345", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4dc9096d6ecbccd577b3387744b62171b3e5018746b0fe3d52b37dc27d4ce4da586dbf1b42b1e0808691ff32ddaebca47718d26412c9c6123e3f1b2c069f225", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d5d4984e0b8f4c4c7fee875f0884b3cb187115f7f72dea92c6a04d66953f80ce7ebbd9f35893c880cb1028dee11ad8684455cc89a4c071b466323d2e4928df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f447fd4f98dc68a80abf706e4ef37aaba0335f34b93c80dde1daa57eec536730ee407e3d8c34626db3b287672e560cddcec4cc6660329aaf0a40d741f9e67948"} 09:53:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:53 INFO - Copying logs to upload dir... 09:53:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.683799 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-06 09:53:54.006377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-06 09:53:54.010473) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4f3af5458085619420706ae0e3c47427db5dbb6ffdabb28ee39b43fe71d1f044edd35ba9c05b0241abf74279e12b446a8cf44d9f5bfae042481cbc31847d345", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4dc9096d6ecbccd577b3387744b62171b3e5018746b0fe3d52b37dc27d4ce4da586dbf1b42b1e0808691ff32ddaebca47718d26412c9c6123e3f1b2c069f225", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d5d4984e0b8f4c4c7fee875f0884b3cb187115f7f72dea92c6a04d66953f80ce7ebbd9f35893c880cb1028dee11ad8684455cc89a4c071b466323d2e4928df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f447fd4f98dc68a80abf706e4ef37aaba0335f34b93c80dde1daa57eec536730ee407e3d8c34626db3b287672e560cddcec4cc6660329aaf0a40d741f9e67948"} build_url:https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/PAE4w3vZQ4G-WzPrDvdDSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4f3af5458085619420706ae0e3c47427db5dbb6ffdabb28ee39b43fe71d1f044edd35ba9c05b0241abf74279e12b446a8cf44d9f5bfae042481cbc31847d345", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4dc9096d6ecbccd577b3387744b62171b3e5018746b0fe3d52b37dc27d4ce4da586dbf1b42b1e0808691ff32ddaebca47718d26412c9c6123e3f1b2c069f225", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d5d4984e0b8f4c4c7fee875f0884b3cb187115f7f72dea92c6a04d66953f80ce7ebbd9f35893c880cb1028dee11ad8684455cc89a4c071b466323d2e4928df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f447fd4f98dc68a80abf706e4ef37aaba0335f34b93c80dde1daa57eec536730ee407e3d8c34626db3b287672e560cddcec4cc6660329aaf0a40d741f9e67948"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-06 09:53:54.039471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:53:54.039823) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1499356669.673650-1872624080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-06 09:53:54.095989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-06 09:53:54.096430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-06 09:53:54.096704) ========= ========= Total master_lag: 0.26 =========