builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1503165243.59 results: success (0) revision: 10ce8f26a29424dbe21818e816c97a695c97fa07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.591747) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.593306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.593621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.736845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.737139) ========= 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=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-19 10:54:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-08-19 10:54:03 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113226 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.883238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.883569) ========= 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=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019206 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:03.940470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-19 10:54:03.940831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ce8f26a29424dbe21818e816c97a695c97fa07 --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 10ce8f26a29424dbe21818e816c97a695c97fa07 --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=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 10:54:04,021 truncating revision to first 12 chars 2017-08-19 10:54:04,021 Setting DEBUG logging. 2017-08-19 10:54:04,021 attempt 1/10 2017-08-19 10:54:04,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ce8f26a294?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-19 10:54:04,549 attempt 1/10 2017-08-19 10:54:05,613 current task status: no status available at this point. state: STARTED 2017-08-19 10:54:05,613 sleeping for 11.00s (attempt 1/10) 2017-08-19 10:54:16,625 attempt 2/10 2017-08-19 10:54:16,943 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-19 10:54:17,123 unpacking tar archive at: mozilla-central-10ce8f26a294/testing/mozharness/ program finished with exit code 0 elapsedTime=14.096177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-19 10:54:18.060081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:18.060504) ========= script_repo_revision: 10ce8f26a29424dbe21818e816c97a695c97fa07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:18.060941) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:18.061258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 10:54:18.073082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-19 10:54:18.073417) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:54:18 INFO - MultiFileLogger online at 20170819 10:54:18 in /builds/slave/test 10:54:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:54:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:54:18 INFO - {'append_to_log': False, 10:54:18 INFO - 'base_work_dir': '/builds/slave/test', 10:54:18 INFO - 'blob_upload_branch': 'Firefox', 10:54:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:54:18 INFO - 'branch': 'Firefox', 10:54:18 INFO - 'buildbot_json_path': 'buildprops.json', 10:54:18 INFO - 'code_coverage': False, 10:54:18 INFO - 'config_files': ('talos/linux_config.py',), 10:54:18 INFO - 'default_actions': ('clobber', 10:54:18 INFO - 'read-buildbot-config', 10:54:18 INFO - 'download-and-extract', 10:54:18 INFO - 'populate-webroot', 10:54:18 INFO - 'create-virtualenv', 10:54:18 INFO - 'install', 10:54:18 INFO - 'setup-mitmproxy', 10:54:18 INFO - 'run-tests'), 10:54:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:54:18 INFO - 'disable_ccov_upload': False, 10:54:18 INFO - 'download_minidump_stackwalk': True, 10:54:18 INFO - 'download_symbols': 'ondemand', 10:54:18 INFO - 'enable_stylo': False, 10:54:18 INFO - 'enable_webrender': False, 10:54:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:54:18 INFO - 'tooltool.py': '/tools/tooltool.py', 10:54:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:54:18 INFO - '/tools/misc-python/virtualenv.py')}, 10:54:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:54:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:54:18 INFO - 'gecko_profile': False, 10:54:18 INFO - 'gecko_profile_interval': 0, 10:54:18 INFO - 'installer_path': 'installer.exe', 10:54:18 INFO - 'log_level': 'info', 10:54:18 INFO - 'log_name': 'talos', 10:54:18 INFO - 'log_to_console': True, 10:54:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:54:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:54:18 INFO - 'opt_config_files': (), 10:54:18 INFO - 'pip_index': False, 10:54:18 INFO - 'suite': 'dromaeojs-e10s', 10:54:18 INFO - 'system_bits': '32', 10:54:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:54:18 INFO - 'title': 'talos-linux64-ix-008', 10:54:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:54:18 INFO - 'use_talos_json': True, 10:54:18 INFO - 'verify': 'False', 10:54:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:54:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:54:18 INFO - 'work_dir': 'build'} 10:54:18 INFO - [mozharness: 2017-08-19 17:54:18.295132Z] Running clobber step. 10:54:18 INFO - Running pre-action listener: _resource_record_pre_action 10:54:18 INFO - Running main action method: clobber 10:54:18 INFO - rmtree: /builds/slave/test/build 10:54:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:54:19 INFO - Running post-action listener: _resource_record_post_action 10:54:19 INFO - [mozharness: 2017-08-19 17:54:19.309837Z] Finished clobber step (success) 10:54:19 INFO - [mozharness: 2017-08-19 17:54:19.309934Z] Running read-buildbot-config step. 10:54:19 INFO - Running pre-action listener: _resource_record_pre_action 10:54:19 INFO - Running main action method: read_buildbot_config 10:54:19 INFO - Using buildbot properties: 10:54:19 INFO - { 10:54:19 INFO - "project": "", 10:54:19 INFO - "product": "firefox", 10:54:19 INFO - "who": "ffxbld@noreply.mozilla.org", 10:54:19 INFO - "installer_path": "public/build/target.tar.bz2", 10:54:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:54:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:54:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:54:19 INFO - "stage_platform": "linux64-stylo", 10:54:19 INFO - "basedir": "/builds/slave/test", 10:54:19 INFO - "buildnumber": 44, 10:54:19 INFO - "platform": "ubuntu64_hw_stylo", 10:54:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:54:19 INFO - "slavebuilddir": "test", 10:54:19 INFO - "taskId": "UCaZ9njHQN6Bci26SBQY6w", 10:54:19 INFO - "branch": "mozilla-central", 10:54:19 INFO - "script_repo_revision": "production", 10:54:19 INFO - "revision": "10ce8f26a29424dbe21818e816c97a695c97fa07", 10:54:19 INFO - "slavename": "talos-linux64-ix-008", 10:54:19 INFO - "repo_path": "mozilla-central" 10:54:19 INFO - } 10:54:19 INFO - Finding installer, test and symbols from parent task. 10:54:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UCaZ9njHQN6Bci26SBQY6w'}, attempt #1 10:54:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UCaZ9njHQN6Bci26SBQY6w'}, attempt #1 10:54:20 INFO - Task dependencies: EtAI5-StRyCj0OxT7-pNYg 10:54:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg'}, attempt #1 10:54:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 10:54:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.test_packages.json 10:54:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.crashreporter-symbols.zip 10:54:20 INFO - Running post-action listener: _resource_record_post_action 10:54:20 INFO - [mozharness: 2017-08-19 17:54:20.660368Z] Finished read-buildbot-config step (success) 10:54:20 INFO - [mozharness: 2017-08-19 17:54:20.660584Z] Running download-and-extract step. 10:54:20 INFO - Running pre-action listener: _resource_record_pre_action 10:54:20 INFO - Running main action method: download_and_extract 10:54:20 INFO - mkdir: /builds/slave/test/build/tests 10:54:20 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')]} 10:54:20 INFO - trying https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.test_packages.json 10:54:20 INFO - Downloading https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:54:21 INFO - Downloaded 989 bytes. 10:54:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:54:21 INFO - Using the following test package requirements: 10:54:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:54:21 INFO - u'common': [u'target.common.tests.zip'], 10:54:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:54:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:54:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:54:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:54:21 INFO - u'mozbase': [u'target.common.tests.zip'], 10:54:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:54:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:54:21 INFO - u'web-platform': [u'target.common.tests.zip', 10:54:21 INFO - u'target.web-platform.tests.tar.gz'], 10:54:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:54:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:54:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip 10:54:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:54:21 INFO - Fetch https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip into memory 10:54:22 INFO - Content-Length response header: 54005123 10:54:22 INFO - Bytes received: 54005123 10:54:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:54:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip 10:54:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:54:33 INFO - Fetch https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.common.tests.zip into memory 10:54:35 INFO - Content-Length response header: 54005123 10:54:35 INFO - Bytes received: 54005123 10:54:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.talos.tests.zip 10:54:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:54:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.talos.tests.zip into memory 10:54:49 INFO - Content-Length response header: 14496256 10:54:49 INFO - Bytes received: 14496256 10:54:50 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')]} 10:54:50 INFO - trying https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 10:54:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:54:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:54:51 INFO - Downloaded 62097887 bytes. 10:54:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 10:54:51 INFO - mkdir: /builds/slave/test/properties 10:54:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:51 INFO - Contents: 10:54:51 INFO - build_url:https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 10:54:51 INFO - Running post-action listener: _resource_record_post_action 10:54:51 INFO - Running post-action listener: find_tests_for_verification 10:54:51 INFO - Running post-action listener: set_extra_try_arguments 10:54:51 INFO - [mozharness: 2017-08-19 17:54:51.776243Z] Finished download-and-extract step (success) 10:54:51 INFO - [mozharness: 2017-08-19 17:54:51.776386Z] Running populate-webroot step. 10:54:51 INFO - Running pre-action listener: _resource_record_pre_action 10:54:51 INFO - Running main action method: populate_webroot 10:54:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:51 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:51 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:51 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'tests': ['damp', 'tps']}, 10:54:51 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['damp', 'tps']}, 10:54:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:54:51 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:54:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:54:51 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:54:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:51 INFO - 'ts_paint', 10:54:51 INFO - 'tpaint', 10:54:51 INFO - 'sessionrestore', 10:54:51 INFO - 'sessionrestore_many_windows', 10:54:51 INFO - 'sessionrestore_no_auto_restore', 10:54:51 INFO - 'tabpaint']}, 10:54:51 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['a11yr', 10:54:51 INFO - 'ts_paint', 10:54:51 INFO - 'tpaint', 10:54:51 INFO - 'sessionrestore', 10:54:51 INFO - 'sessionrestore_many_windows', 10:54:51 INFO - 'sessionrestore_no_auto_restore', 10:54:51 INFO - 'tabpaint']}, 10:54:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:54:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:54:51 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['bloom_basic_singleton']}, 10:54:51 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['bloom_basic']}, 10:54:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:51 INFO - 'tsvgr_opacity', 10:54:51 INFO - 'tart', 10:54:51 INFO - 'tscrollx', 10:54:51 INFO - 'tsvg_static']}, 10:54:51 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['tsvgx', 10:54:51 INFO - 'tsvgr_opacity', 10:54:51 INFO - 'tart', 10:54:51 INFO - 'tscrollx', 10:54:51 INFO - 'tsvg_static']}, 10:54:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:54:51 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--stylo'], 10:54:51 INFO - 'tests': ['tp5o']}, 10:54:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:54:51 INFO - 'talos_options': ['--mitmproxy', 10:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:54:51 INFO - '--firstNonBlankPaint'], 10:54:51 INFO - 'tests': ['tp6_google', 10:54:51 INFO - 'tp6_youtube', 10:54:51 INFO - 'tp6_amazon', 10:54:51 INFO - 'tp6_facebook']}, 10:54:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:54:51 INFO - 'talos_options': ['--stylo', 10:54:51 INFO - '--mitmproxy', 10:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:54:51 INFO - '--firstNonBlankPaint'], 10:54:51 INFO - 'tests': ['tp6_google', 10:54:51 INFO - 'tp6_youtube', 10:54:51 INFO - 'tp6_amazon', 10:54:51 INFO - 'tp6_facebook']}, 10:54:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:54:51 INFO - 'talos_options': ['--stylo', 10:54:51 INFO - '--stylo-threads=1', 10:54:51 INFO - '--mitmproxy', 10:54:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:54:51 INFO - '--firstNonBlankPaint'], 10:54:51 INFO - 'tests': ['tp6_google', 10:54:51 INFO - 'tp6_youtube', 10:54:51 INFO - 'tp6_amazon', 10:54:51 INFO - 'tp6_facebook']}, 10:54:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--xperf_path', 10:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:51 INFO - 'tests': ['tp5n']}, 10:54:51 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:54:51 INFO - 'talos_options': ['--stylo', 10:54:51 INFO - '--xperf_path', 10:54:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:51 INFO - 'tests': ['tp5n']}}} 10:54:51 INFO - Running post-action listener: _resource_record_post_action 10:54:51 INFO - [mozharness: 2017-08-19 17:54:51.792722Z] Finished populate-webroot step (success) 10:54:51 INFO - [mozharness: 2017-08-19 17:54:51.792811Z] Running create-virtualenv step. 10:54:51 INFO - Running pre-action listener: _resource_record_pre_action 10:54:51 INFO - Running main action method: create_virtualenv 10:54:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:51 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 10:54:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:54:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:51 INFO - Using real prefix '/usr' 10:54:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:54 INFO - Installing pip.................done. 10:54:54 INFO - Return code: 0 10:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:54:54 INFO - Reading from file tmpfile_stdout 10:54:54 INFO - Output received: 10:54:54 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) 10:54:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54:54 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')]} 10:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:54 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')]} 10:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:54:54 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 10:54:54 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 10:54:54 INFO - Using env: {'DISPLAY': ':0', 10:54:54 INFO - 'HOME': '/home/cltbld', 10:54:54 INFO - 'LANG': 'en_US.UTF-8', 10:54:54 INFO - 'LANGUAGE': 'en_US:en', 10:54:54 INFO - 'LOGNAME': 'cltbld', 10:54:54 INFO - 'MAIL': '/var/mail/cltbld', 10:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:54 INFO - 'MOZ_NO_REMOTE': '1', 10:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:54 INFO - 'NO_EM_RESTART': '1', 10:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:54 INFO - 'PWD': '/builds/slave/test', 10:54:54 INFO - 'SHELL': '/bin/bash', 10:54:54 INFO - 'SHLVL': '1', 10:54:54 INFO - 'TERM': 'linux', 10:54:54 INFO - 'TMOUT': '86400', 10:54:54 INFO - 'USER': 'cltbld', 10:54:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:54 INFO - '_': '/tools/buildbot/bin/python'} 10:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:54 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 10:54:54 INFO - Cleaning up... 10:54:54 INFO - Return code: 0 10:54:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54:54 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')]} 10:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:54 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')]} 10:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:54:54 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 10:54:54 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 10:54:54 INFO - Using env: {'DISPLAY': ':0', 10:54:54 INFO - 'HOME': '/home/cltbld', 10:54:54 INFO - 'LANG': 'en_US.UTF-8', 10:54:54 INFO - 'LANGUAGE': 'en_US:en', 10:54:54 INFO - 'LOGNAME': 'cltbld', 10:54:54 INFO - 'MAIL': '/var/mail/cltbld', 10:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:54 INFO - 'MOZ_NO_REMOTE': '1', 10:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:54 INFO - 'NO_EM_RESTART': '1', 10:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:54 INFO - 'PWD': '/builds/slave/test', 10:54:54 INFO - 'SHELL': '/bin/bash', 10:54:54 INFO - 'SHLVL': '1', 10:54:54 INFO - 'TERM': 'linux', 10:54:54 INFO - 'TMOUT': '86400', 10:54:54 INFO - 'USER': 'cltbld', 10:54:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:54 INFO - '_': '/tools/buildbot/bin/python'} 10:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:55 INFO - Downloading/unpacking psutil>=3.1.1 10:54:55 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 10:54:55 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 10:54:55 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 10:54:55 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 10:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:56 INFO - Installing collected packages: psutil 10:54:56 INFO - Running setup.py install for psutil 10:54:56 INFO - building 'psutil._psutil_linux' extension 10:54:56 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 10:54:56 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 10:54:56 INFO - building 'psutil._psutil_posix' extension 10:54:56 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 10:54:56 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 10:54:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:56 INFO - Successfully installed psutil 10:54:56 INFO - Cleaning up... 10:54:56 INFO - Return code: 0 10:54:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54:56 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')]} 10:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:56 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')]} 10:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:56 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:54:56 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 10:54:56 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 10:54:56 INFO - Using env: {'DISPLAY': ':0', 10:54:56 INFO - 'HOME': '/home/cltbld', 10:54:56 INFO - 'LANG': 'en_US.UTF-8', 10:54:56 INFO - 'LANGUAGE': 'en_US:en', 10:54:56 INFO - 'LOGNAME': 'cltbld', 10:54:56 INFO - 'MAIL': '/var/mail/cltbld', 10:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:56 INFO - 'MOZ_NO_REMOTE': '1', 10:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:56 INFO - 'NO_EM_RESTART': '1', 10:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:56 INFO - 'PWD': '/builds/slave/test', 10:54:56 INFO - 'SHELL': '/bin/bash', 10:54:56 INFO - 'SHLVL': '1', 10:54:56 INFO - 'TERM': 'linux', 10:54:56 INFO - 'TMOUT': '86400', 10:54:56 INFO - 'USER': 'cltbld', 10:54:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:56 INFO - '_': '/tools/buildbot/bin/python'} 10:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:58 INFO - Installing collected packages: mozsystemmonitor 10:54:58 INFO - Running setup.py install for mozsystemmonitor 10:54:58 INFO - Successfully installed mozsystemmonitor 10:54:58 INFO - Cleaning up... 10:54:58 INFO - Return code: 0 10:54:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54:58 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')]} 10:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:58 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')]} 10:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:58 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:54:58 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 10:54:58 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 10:54:58 INFO - Using env: {'DISPLAY': ':0', 10:54:58 INFO - 'HOME': '/home/cltbld', 10:54:58 INFO - 'LANG': 'en_US.UTF-8', 10:54:58 INFO - 'LANGUAGE': 'en_US:en', 10:54:58 INFO - 'LOGNAME': 'cltbld', 10:54:58 INFO - 'MAIL': '/var/mail/cltbld', 10:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:58 INFO - 'MOZ_NO_REMOTE': '1', 10:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:58 INFO - 'NO_EM_RESTART': '1', 10:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:58 INFO - 'PWD': '/builds/slave/test', 10:54:58 INFO - 'SHELL': '/bin/bash', 10:54:58 INFO - 'SHLVL': '1', 10:54:58 INFO - 'TERM': 'linux', 10:54:58 INFO - 'TMOUT': '86400', 10:54:58 INFO - 'USER': 'cltbld', 10:54:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:58 INFO - '_': '/tools/buildbot/bin/python'} 10:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:54:58 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 10:54:58 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 10:54:58 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 10:54:58 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 10:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:59 INFO - warning: no files found matching '*.txt' 10:54:59 INFO - no previously-included directories found matching 'build' 10:54:59 INFO - no previously-included directories found matching 'dist' 10:54:59 INFO - no previously-included directories found matching '.git*' 10:54:59 INFO - Installing collected packages: jsonschema, functools32 10:54:59 INFO - Running setup.py install for functools32 10:54:59 INFO - warning: no files found matching '*.txt' 10:54:59 INFO - no previously-included directories found matching 'build' 10:54:59 INFO - no previously-included directories found matching 'dist' 10:54:59 INFO - no previously-included directories found matching '.git*' 10:54:59 INFO - Successfully installed jsonschema functools32 10:54:59 INFO - Cleaning up... 10:54:59 INFO - Return code: 0 10:54:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:54:59 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')]} 10:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:59 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')]} 10:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:54:59 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 10:54:59 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 10:54:59 INFO - Using env: {'DISPLAY': ':0', 10:54:59 INFO - 'HOME': '/home/cltbld', 10:54:59 INFO - 'LANG': 'en_US.UTF-8', 10:54:59 INFO - 'LANGUAGE': 'en_US:en', 10:54:59 INFO - 'LOGNAME': 'cltbld', 10:54:59 INFO - 'MAIL': '/var/mail/cltbld', 10:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:59 INFO - 'MOZ_NO_REMOTE': '1', 10:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:59 INFO - 'NO_EM_RESTART': '1', 10:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:59 INFO - 'PWD': '/builds/slave/test', 10:54:59 INFO - 'SHELL': '/bin/bash', 10:54:59 INFO - 'SHLVL': '1', 10:54:59 INFO - 'TERM': 'linux', 10:54:59 INFO - 'TMOUT': '86400', 10:54:59 INFO - 'USER': 'cltbld', 10:54:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:59 INFO - '_': '/tools/buildbot/bin/python'} 10:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:55:00 INFO - Cleaning up... 10:55:00 INFO - Return code: 0 10:55:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55:00 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')]} 10:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:00 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')]} 10:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:00 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:55:00 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 10:55:00 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 10:55:00 INFO - Using env: {'DISPLAY': ':0', 10:55:00 INFO - 'HOME': '/home/cltbld', 10:55:00 INFO - 'LANG': 'en_US.UTF-8', 10:55:00 INFO - 'LANGUAGE': 'en_US:en', 10:55:00 INFO - 'LOGNAME': 'cltbld', 10:55:00 INFO - 'MAIL': '/var/mail/cltbld', 10:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:00 INFO - 'MOZ_NO_REMOTE': '1', 10:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:00 INFO - 'NO_EM_RESTART': '1', 10:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:00 INFO - 'PWD': '/builds/slave/test', 10:55:00 INFO - 'SHELL': '/bin/bash', 10:55:00 INFO - 'SHLVL': '1', 10:55:00 INFO - 'TERM': 'linux', 10:55:00 INFO - 'TMOUT': '86400', 10:55:00 INFO - 'USER': 'cltbld', 10:55:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:00 INFO - '_': '/tools/buildbot/bin/python'} 10:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:00 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 10:55:00 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 10:55:00 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 10:55:00 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 10:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:55:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:01 INFO - Downloading docopt-0.6.1.tar.gz 10:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:02 INFO - Running setup.py install for blobuploader 10:55:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:55:02 INFO - Running setup.py install for requests 10:55:02 INFO - Running setup.py install for docopt 10:55:02 INFO - Successfully installed blobuploader requests docopt 10:55:02 INFO - Cleaning up... 10:55:02 INFO - Return code: 0 10:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:02 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')]} 10:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:02 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')]} 10:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:02 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:55:02 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 10:55:02 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 10:55:02 INFO - Using env: {'DISPLAY': ':0', 10:55:02 INFO - 'HOME': '/home/cltbld', 10:55:02 INFO - 'LANG': 'en_US.UTF-8', 10:55:02 INFO - 'LANGUAGE': 'en_US:en', 10:55:02 INFO - 'LOGNAME': 'cltbld', 10:55:02 INFO - 'MAIL': '/var/mail/cltbld', 10:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:02 INFO - 'MOZ_NO_REMOTE': '1', 10:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:02 INFO - 'NO_EM_RESTART': '1', 10:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:02 INFO - 'PWD': '/builds/slave/test', 10:55:02 INFO - 'SHELL': '/bin/bash', 10:55:02 INFO - 'SHLVL': '1', 10:55:02 INFO - 'TERM': 'linux', 10:55:02 INFO - 'TMOUT': '86400', 10:55:02 INFO - 'USER': 'cltbld', 10:55:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:02 INFO - '_': '/tools/buildbot/bin/python'} 10:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:02 INFO - Running setup.py (path:/tmp/pip-6g9Uzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:02 INFO - Running setup.py (path:/tmp/pip-1_8jHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:03 INFO - Running setup.py (path:/tmp/pip-Jq79rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:03 INFO - Running setup.py (path:/tmp/pip-C7JneS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:03 INFO - Running setup.py (path:/tmp/pip-55ltbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:03 INFO - Running setup.py (path:/tmp/pip-6hvjft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:03 INFO - Running setup.py (path:/tmp/pip-P7swfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:03 INFO - Running setup.py (path:/tmp/pip-Rual73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:03 INFO - Running setup.py (path:/tmp/pip-Wb61EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:03 INFO - Running setup.py (path:/tmp/pip-M4slqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:03 INFO - Running setup.py (path:/tmp/pip-8KtyG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:03 INFO - Running setup.py (path:/tmp/pip-cPMnNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:03 INFO - Running setup.py (path:/tmp/pip-nnJ0JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:03 INFO - Running setup.py (path:/tmp/pip-rG3TWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:03 INFO - Running setup.py (path:/tmp/pip-l2rdvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:03 INFO - Running setup.py (path:/tmp/pip-53Quws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:04 INFO - Running setup.py (path:/tmp/pip-s8NTKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:04 INFO - Running setup.py install for manifestparser 10:55:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Running setup.py install for mozcrash 10:55:04 INFO - Running setup.py install for mozdebug 10:55:04 INFO - Running setup.py install for mozdevice 10:55:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Running setup.py install for mozfile 10:55:04 INFO - Running setup.py install for mozhttpd 10:55:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Running setup.py install for mozinfo 10:55:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Running setup.py install for mozInstall 10:55:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:55:04 INFO - Running setup.py install for mozleak 10:55:04 INFO - Running setup.py install for mozlog 10:55:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Running setup.py install for moznetwork 10:55:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Running setup.py install for mozprocess 10:55:05 INFO - Running setup.py install for mozprofile 10:55:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Running setup.py install for mozrunner 10:55:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Running setup.py install for mozscreenshot 10:55:05 INFO - Running setup.py install for moztest 10:55:05 INFO - Running setup.py install for mozversion 10:55:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:55:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:05 INFO - Cleaning up... 10:55:05 INFO - Return code: 0 10:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:05 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')]} 10:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:05 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')]} 10:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:05 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:55:05 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 10:55:05 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 10:55:05 INFO - Using env: {'DISPLAY': ':0', 10:55:05 INFO - 'HOME': '/home/cltbld', 10:55:05 INFO - 'LANG': 'en_US.UTF-8', 10:55:05 INFO - 'LANGUAGE': 'en_US:en', 10:55:05 INFO - 'LOGNAME': 'cltbld', 10:55:05 INFO - 'MAIL': '/var/mail/cltbld', 10:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:05 INFO - 'MOZ_NO_REMOTE': '1', 10:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:05 INFO - 'NO_EM_RESTART': '1', 10:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:05 INFO - 'PWD': '/builds/slave/test', 10:55:05 INFO - 'SHELL': '/bin/bash', 10:55:05 INFO - 'SHLVL': '1', 10:55:05 INFO - 'TERM': 'linux', 10:55:05 INFO - 'TMOUT': '86400', 10:55:05 INFO - 'USER': 'cltbld', 10:55:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:05 INFO - '_': '/tools/buildbot/bin/python'} 10:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:55:06 INFO - Running setup.py (path:/tmp/pip-xfBlga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:55:06 INFO - Running setup.py (path:/tmp/pip-Bb_4Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:55:06 INFO - Running setup.py (path:/tmp/pip-uhrFy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:55:06 INFO - Running setup.py (path:/tmp/pip-FhIQpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:55:06 INFO - Running setup.py (path:/tmp/pip-KdZ80C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:55:06 INFO - Running setup.py (path:/tmp/pip-oJVBvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:55:06 INFO - Running setup.py (path:/tmp/pip-mfx6we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:55:06 INFO - Running setup.py (path:/tmp/pip-qR_3E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:55:06 INFO - Running setup.py (path:/tmp/pip-wwAYNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:55:06 INFO - Running setup.py (path:/tmp/pip-PSS7tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:55:06 INFO - Running setup.py (path:/tmp/pip-MfndCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:55:06 INFO - Running setup.py (path:/tmp/pip-YHu7_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:55:06 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)) 10:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:55:06 INFO - Running setup.py (path:/tmp/pip-Vit0mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:55:07 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)) 10:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:55:07 INFO - Running setup.py (path:/tmp/pip-BwKTdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:55:07 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)) 10:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:07 INFO - Running setup.py (path:/tmp/pip-6HzBpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:55:07 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)) 10:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:55:07 INFO - Running setup.py (path:/tmp/pip-rSfA2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:55:07 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)) 10:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:55:07 INFO - Running setup.py (path:/tmp/pip-WwaSyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:55:07 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)) 10:55:07 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)) 10:55:07 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)) 10:55:07 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)) 10:55:07 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)) 10:55:07 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)) 10:55:07 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)) 10:55:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:07 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 10:55:07 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 10:55:07 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 10:55:07 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 10:55:08 INFO - Downloading blessings-1.6.tar.gz 10:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:55:08 INFO - Installing collected packages: blessings 10:55:08 INFO - Running setup.py install for blessings 10:55:08 INFO - Successfully installed blessings 10:55:08 INFO - Cleaning up... 10:55:08 INFO - Return code: 0 10:55:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:55:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:08 INFO - Reading from file tmpfile_stdout 10:55:08 INFO - Current package versions: 10:55:08 INFO - argparse == 1.2.1 10:55:08 INFO - blessings == 1.6 10:55:08 INFO - blobuploader == 1.2.4 10:55:08 INFO - docopt == 0.6.1 10:55:08 INFO - functools32 == 3.2.3-2 10:55:08 INFO - jsonschema == 2.5.1 10:55:08 INFO - manifestparser == 1.1 10:55:08 INFO - mozInstall == 1.13 10:55:08 INFO - mozcrash == 1.0 10:55:08 INFO - mozdebug == 0.1 10:55:08 INFO - mozdevice == 0.51 10:55:08 INFO - mozfile == 1.2 10:55:08 INFO - mozhttpd == 0.7 10:55:08 INFO - mozinfo == 0.10 10:55:08 INFO - mozleak == 0.1 10:55:08 INFO - mozlog == 3.5 10:55:08 INFO - moznetwork == 0.27 10:55:08 INFO - mozprocess == 0.25 10:55:08 INFO - mozprofile == 0.28 10:55:08 INFO - mozrunner == 6.13 10:55:08 INFO - mozscreenshot == 0.1 10:55:08 INFO - mozsystemmonitor == 0.3 10:55:08 INFO - moztest == 0.8 10:55:08 INFO - mozversion == 1.4 10:55:08 INFO - psutil == 3.1.1 10:55:08 INFO - requests == 1.2.3 10:55:08 INFO - wsgiref == 0.1.2 10:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:55:08 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')]} 10:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:08 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')]} 10:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:08 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:55:08 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 10:55:08 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 10:55:08 INFO - Using env: {'DISPLAY': ':0', 10:55:08 INFO - 'HOME': '/home/cltbld', 10:55:08 INFO - 'LANG': 'en_US.UTF-8', 10:55:08 INFO - 'LANGUAGE': 'en_US:en', 10:55:08 INFO - 'LOGNAME': 'cltbld', 10:55:08 INFO - 'MAIL': '/var/mail/cltbld', 10:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:08 INFO - 'MOZ_NO_REMOTE': '1', 10:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:08 INFO - 'NO_EM_RESTART': '1', 10:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:08 INFO - 'PWD': '/builds/slave/test', 10:55:08 INFO - 'SHELL': '/bin/bash', 10:55:08 INFO - 'SHLVL': '1', 10:55:08 INFO - 'TERM': 'linux', 10:55:08 INFO - 'TMOUT': '86400', 10:55:08 INFO - 'USER': 'cltbld', 10:55:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:08 INFO - '_': '/tools/buildbot/bin/python'} 10:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 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)) 10:55:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:55:09 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 10:55:09 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 10:55:09 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 10:55:09 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 10:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:55:10 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)) 10:55:10 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)) 10:55:10 INFO - Installing collected packages: simplejson 10:55:10 INFO - Running setup.py install for simplejson 10:55:10 INFO - building 'simplejson._speedups' extension 10:55:10 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 10:55:11 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 10:55:11 INFO - Successfully installed simplejson 10:55:11 INFO - Cleaning up... 10:55:11 INFO - Return code: 0 10:55:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:55:11 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')]} 10:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:11 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')]} 10:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:11 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 0x26151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2983f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, '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': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', '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 10:55:11 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 10:55:11 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 10:55:11 INFO - Using env: {'DISPLAY': ':0', 10:55:11 INFO - 'HOME': '/home/cltbld', 10:55:11 INFO - 'LANG': 'en_US.UTF-8', 10:55:11 INFO - 'LANGUAGE': 'en_US:en', 10:55:11 INFO - 'LOGNAME': 'cltbld', 10:55:11 INFO - 'MAIL': '/var/mail/cltbld', 10:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:11 INFO - 'MOZ_NO_REMOTE': '1', 10:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:11 INFO - 'NO_EM_RESTART': '1', 10:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:11 INFO - 'PWD': '/builds/slave/test', 10:55:11 INFO - 'SHELL': '/bin/bash', 10:55:11 INFO - 'SHLVL': '1', 10:55:11 INFO - 'TERM': 'linux', 10:55:11 INFO - 'TMOUT': '86400', 10:55:11 INFO - 'USER': 'cltbld', 10:55:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:11 INFO - '_': '/tools/buildbot/bin/python'} 10:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:55:11 INFO - Cleaning up... 10:55:11 INFO - Return code: 0 10:55:11 INFO - Running post-action listener: _resource_record_post_action 10:55:11 INFO - Running post-action listener: _start_resource_monitoring 10:55:11 INFO - Starting resource monitoring. 10:55:11 INFO - [mozharness: 2017-08-19 17:55:11.562597Z] Finished create-virtualenv step (success) 10:55:11 INFO - [mozharness: 2017-08-19 17:55:11.563111Z] Running install step. 10:55:11 INFO - Running pre-action listener: _resource_record_pre_action 10:55:11 INFO - Running main action method: install 10:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:55:11 INFO - Reading from file tmpfile_stdout 10:55:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:55:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:55:11 INFO - Reading from file tmpfile_stdout 10:55:11 INFO - Output received: 10:55:11 INFO - Usage: mozinstall [options] installer 10:55:11 INFO - Options: 10:55:11 INFO - -h, --help show this help message and exit 10:55:11 INFO - -d DEST, --destination=DEST 10:55:11 INFO - Directory to install application into. [default: 10:55:11 INFO - "/builds/slave/test"] 10:55:11 INFO - --app=APP Application being installed. [default: firefox] 10:55:11 INFO - mkdir: /builds/slave/test/build/application 10:55:11 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'] 10:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:55:29 INFO - Reading from file tmpfile_stdout 10:55:29 INFO - Output received: 10:55:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:55:29 INFO - Running post-action listener: _resource_record_post_action 10:55:29 INFO - [mozharness: 2017-08-19 17:55:29.894068Z] Finished install step (success) 10:55:29 INFO - [mozharness: 2017-08-19 17:55:29.894348Z] Running setup-mitmproxy step. 10:55:29 INFO - Running pre-action listener: _resource_record_pre_action 10:55:29 INFO - Running main action method: setup_mitmproxy 10:55:29 INFO - Skipping: mitmproxy is not required 10:55:29 INFO - Running post-action listener: _resource_record_post_action 10:55:29 INFO - [mozharness: 2017-08-19 17:55:29.895475Z] Finished setup-mitmproxy step (success) 10:55:29 INFO - [mozharness: 2017-08-19 17:55:29.895692Z] Running run-tests step. 10:55:29 INFO - Running pre-action listener: _resource_record_pre_action 10:55:29 INFO - Running pre-action listener: _set_gcov_prefix 10:55:29 INFO - Running main action method: run_tests 10:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:29 INFO - Python 2.7.3 10:55:29 INFO - Return code: 0 10:55:29 INFO - grabbing minidump binary from tooltool 10:55:29 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')]} 10:55:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2981130>, '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 0x2982030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29824c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:55:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:55:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:55:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:30 INFO - Return code: 0 10:55:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:30 INFO - ENV: RUST_BACKTRACE is now full 10:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 10:55:30 INFO - Using env: {'DISPLAY': ':0', 10:55:30 INFO - 'HOME': '/home/cltbld', 10:55:30 INFO - 'LANG': 'en_US.UTF-8', 10:55:30 INFO - 'LANGUAGE': 'en_US:en', 10:55:30 INFO - 'LOGNAME': 'cltbld', 10:55:30 INFO - 'MAIL': '/var/mail/cltbld', 10:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:30 INFO - 'MOZ_NO_REMOTE': '1', 10:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:30 INFO - 'NO_EM_RESTART': '1', 10:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:30 INFO - 'PWD': '/builds/slave/test', 10:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:30 INFO - 'RUST_BACKTRACE': 'full', 10:55:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:55:30 INFO - 'SHELL': '/bin/bash', 10:55:30 INFO - 'SHLVL': '1', 10:55:30 INFO - 'STYLO_FORCE_ENABLED': '1', 10:55:30 INFO - 'TERM': 'linux', 10:55:30 INFO - 'TMOUT': '86400', 10:55:30 INFO - 'USER': 'cltbld', 10:55:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679', 10:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:30 INFO - '_': '/tools/buildbot/bin/python'} 10:55:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 10:55:30 INFO - mozversion application_buildid: 20170819171054 10:55:30 INFO - mozversion application_changeset: 10ce8f26a29424dbe21818e816c97a695c97fa07 10:55:30 INFO - mozversion application_display_name: Nightly 10:55:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:30 INFO - mozversion application_name: Firefox 10:55:30 INFO - mozversion application_remotingname: firefox 10:55:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:55:30 INFO - mozversion application_vendor: Mozilla 10:55:30 INFO - mozversion application_version: 57.0a1 10:55:30 INFO - mozversion platform_buildid: 20170819171054 10:55:30 INFO - mozversion platform_changeset: 10ce8f26a29424dbe21818e816c97a695c97fa07 10:55:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:55:30 INFO - mozversion platform_version: 57.0a1 10:55:30 INFO - using testdate: 1503165330 10:55:30 INFO - actual date: 1503165330 10:55:30 INFO - starting webserver on 'localhost:35108' 10:55:30 INFO - SUITE-START | Running 2 tests 10:55:30 INFO - TEST-START | dromaeo_css 10:55:30 INFO - Initialising browser for dromaeo_css test... 10:55:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35108/getInfo.html -profile /tmp/tmpVlMvJ5/profile 10:55:30 INFO - TEST-INFO | started process 8848 (/builds/slave/test/build/application/firefox/firefox http://localhost:35108/getInfo.html) 10:55:36 INFO - TEST-INFO | 8848: exit 0 10:55:36 INFO - Browser initialized. 10:55:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:36 INFO - TEST-INFO | started process 9037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlMvJ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:37 INFO - PID 9037 | 10:55:37 INFO - PID 9037 | (/builds/slave/test/build/application/firefox/firefox:9086): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:55:37 INFO - PID 9037 | 10:55:37 INFO - PID 9037 | 10:55:37 INFO - PID 9037 | (/builds/slave/test/build/application/firefox/firefox:9147): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:55:37 INFO - PID 9037 | 10:55:38 INFO - PID 9037 | __metrics Screen width/height:1600/1200 10:55:38 INFO - PID 9037 | colorDepth:24 10:55:38 INFO - PID 9037 | Browser inner width/height: 1024/768 10:55:38 INFO - PID 9037 | __metrics 10:55:47 INFO - PID 9037 | RSS: Main: 174784512 10:55:47 INFO - PID 9037 | 10:58:46 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35108/tests/dromaeo/cssquery-ext.html) 10:58:47 INFO - PID 9037 | RSS: Main: 178700288 10:58:47 INFO - PID 9037 | 11:01:49 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-ext.html (next: http://localhost:35108/tests/dromaeo/cssquery-jquery.html) 11:01:50 INFO - PID 9037 | RSS: Main: 174903296 11:01:50 INFO - PID 9037 | 11:04:51 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35108/tests/dromaeo/cssquery-mootools.html) 11:04:52 INFO - PID 9037 | RSS: Main: 177532928 11:04:52 INFO - PID 9037 | 11:07:54 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35108/tests/dromaeo/cssquery-prototype.html) 11:07:54 INFO - PID 9037 | RSS: Main: 175378432 11:07:54 INFO - PID 9037 | 11:10:58 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35108/tests/dromaeo/cssquery-yui.html) 11:10:59 INFO - PID 9037 | RSS: Main: 176963584 11:10:59 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | Cycle 1(1): loaded http://localhost:35108/tests/dromaeo/cssquery-yui.html (next: http://localhost:35108/tests/dromaeo/cssquery-dojo.html) 11:14:01 INFO - PID 9037 | RSS: Main: 179994624 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | __start_tp_report 11:14:01 INFO - PID 9037 | _x_x_mozilla_page_load 11:14:01 INFO - PID 9037 | _x_x_mozilla_page_load_details 11:14:01 INFO - PID 9037 | |i|pagename|runs| 11:14:01 INFO - PID 9037 | |0;dojo.html;3116.688331166885;3162.193640621641;3164.1456806662195;3172.762042846787;3221.259110404607;6163.41447562482;6298.4646305064125;6322.778702745399;6324;6341.334159913212;6115.541334399927;6204.255489341285;6207.751689932397;6210.285817131031;6248.875022499547;5679.062954612495;5681.289838770153;5706.543476521868;5723.084306510959;5797.797077102302;5754.625949313281;5757.453041961028;5776.39347868474;5797.188393624896;5863.296404431474;5540.944590554083;5655.236543066674;5706.600537962344;5799.971000145015;5814.069748840187;5638.323401191883;5679.09134538476;5753.252077229975;5777.855553611152;5784.4504772046585;5664.065429204176;5700.885982280372;5741.253637027202;5743.770249190027;5745.798897038583;6080.905437021334;6090.5736598438125;6109.755609775603;6120.479759220471;6164.784232551884;6686.632235227061;6700.966495167541;6710.899336509956;6718.49611279156;6722.66386680664;6696.363845434676;6709.966450167718;6730.495212859007;6807.285235050298;6810.046593476917;5944.494717949023;6101.694915254219;6223.190985171898;6256.87486250277;6291.591046581958;6814.046033555207;6895.931040689629;6905.792826215222;6905.965470172617;6917.861642767117;6454.644994525346;6532.6733663316645;6578.506612004119;6585.967070164715;6589.077529145923;6665.933340666628;6698.765543205965;6727.461803055744;6739.090222819955;6778.3221677831825;6497.415232629086;6565.24499682533;6645.60126392418;6673.766418175438;6683.498737594603;6678.332166783282;6703.3296670332575;6708.832279192961;6710.865782684416;6715.294894036154;5348.331458567679;5374.3013408256675;5499.367572729107;5509.531689806411;5516;4642.907141857144;4672.766361681903;4675.0883577702025;4698.412698412699;4720.150372932905;5789.218455508452;5858.736356863951;5870.354261031283;5871.119332100134;5872.794452194153;6580.374864387875;6642.568233064835;6715.496337774589;6820.079289295981;6820.454363650995;5738.512226460714;5771.365149833515;5784.2769653793275;5786.739596718157;5792.131180322901;5893.882122357614;5909.409059094142;5913.113033044991;5914.792982245687;5915.585908986416;6425.58233714807;6427.614343139427;6429.132067170872;6433.774817881352;6440.130582371414;6600.306967768315;6609.801705948829;6640.966795165993;6649.966750166412;6655.900161497581;5688.658680479184;6435.51733619971;6465.676716164079;6541.542092053511;6587.143671322698;6585.176852893388;6604.7027883746305;6620.470362371095;6658.766943156967;6685;6660.200775906922;6678.933210667831;6704.262531121671;6751.156105486814;6757.831054223684;6455.386738259858;6468.8706225874275;6496.707648155939;6502.707378167899;6504.804855854332;6476.028595710681;6476.449501792212;6495.967520162369;6502.934970650233;6513.381228783258;6356.809295721136;6377.01156320771;6438.549301548846;6455.999320105391;6458.192725909262;6490.545661803629;6520.804375868732;6573.934260657332;6614.10709554204;6617.834554135992;6248.625082495065;6269.62382257066;6346.143270658402;6346.809595712136;6352.333005034405 11:14:01 INFO - PID 9037 | |1;ext.html;833.462416741202;840.9117042710511;870.6822009966362;892.4243862708552;898.9011208767031;42871.78564107179;43326.56673433265;43621.345679814825;43696;43742.343864842056;38135.61864381362;38302.616973830256;38339.808300958524;38352.23295534088;38358.61641383585;6919.2734762849805;7004;7019.262977387378;7021.22766495685;7047;6949.922761971877;6978.232394436608;7014.053102831129;7028.82427939303;7037.3666370026685;7773.7279195228175;7982.28159465648;7989.720359787409;7991;7996.040475142962;7876;7884.80287992799;7938.722144724936;7947.4039447041705;7951.840963180762;7630.504017238917;7770.067591889009;7781.41639377049;7911.723089691834;7926.365890728728;38811.41782873259;38847.8057609713;38860.22279554393;39013;39021.41467877984;3593.065802891267;3614.4397618369194;3614.530111085542;3631.4734363517405;3652.2878038782183;31428.685713142804;31881.362372752646;31931;31997.680023199704;32041.839790800896;4636.814527418899;4641.791119399635;4651;4653.906921861578;4654.952635656984;180111;183492.08253958778;194543;195319;204289.97855010777;51934.740326298124;52061.7396913013;52257.216141757905;52266.47733522616;52389.47610523922;54631.453685462635;55106.44893551093;55156.17265741017;55165;55200.72399637976;16633.750493742602;16753.246103925354;16828.663426731397;16834;16988.74516882248;13921.721565568632;13934.651633709036;13947.95390345728;13950.581482555539;13952.232627205602;15021.173835439156;15083.773743393858;15086;15105.093694378153;15269.770953435707;5870.559708021916;5908.3205431375945;6042.6072305300895;6074.54440916933;6132.478739307119;1011.8886922438674;1016.6441745389203;1017.8167929772563;1026.4918865161792;1028.1723212813608;22951.311460655874;22997.770022299897;23130.19044333474;23139.421514462272;23149.76850231476;1106.6403418888733;1109.7447587054862;1112.5994641928899;1125.9380734059541;1129.1531351486385;12232.571859984857;12349.073819463576;12364.381780910919;12370.989819060864;12409.69698181696;212334;235538;235975;237323;238086;56561;57012.71493642505;57015.429845701845;57020;57095.14357284644;1467.5890750589851;1503.7443634582148;1505.6085417791235;1511.2594828533938;1527.2287494815048;23122.76877231206;23261.651075233545;23431.179908703114;23510.412239694146;23530.411739706644;39732.60267397405;39779.40330894981;39820.80089599534;39830.2033959325;39877.80061099676;193444;193776;193916;194491;195346;31107.68892311048;31756.523652144773;35308.82345588256;35746.8212658935;35978.64021359753;45533.31700024568;45649.54350456586;45730.771346143054;45904.540954590026;45973.54026459826;33592.49611255882;33787.66212337845;33969.32061358808;34088.318233635684;34480.65519344775;32153.713851445682;32155.35689286248;32792.180195495304;33113.33773324568;33251.50122748209;36814.8159259202;36876.631233687316;37119.62880371162;37195.62804371922;37369.813150934075;31933.20166995844;32032;32107.19732006625;32151.839240803645;32577.511337330434;22583.548329033656;23131.768682312962;23662.763372366055;23857;24021.639675404535 11:14:01 INFO - PID 9037 | |2;jquery.html;566.8384510414531;570.7374607680467;573.3807487913049;573.8507987923139;583.5739909865798;22432;22628.88685556572;23266.18568350108;23294;23363.649545256812;26417.735822641767;26909;26996.1901142966;27022.729772702267;27119;6398.392152745481;6558.442532384753;6559.639219842907;6564.474842012652;6577.835554111138;5921.88156236875;6389.872202555946;6414.422701956823;6425.678716064202;6479.0281457781475;6430.614163150202;6431.967840160793;6439.098526206335;6439.6136231826;6451.096846441502;6414.550981431302;6426.6144031358035;6444.097826304321;6446.387593178664;6453.193350831146;5985.970070149621;6002.459778619901;6009.669468179249;6022.728977196037;6026.156338112668;29103.85448072746;29772.255693607618;30413.847930760203;30426.239344016354;30447.086587402413;1910.2550005497867;1945.9610807783906;1951.834094102003;1953.4920920560614;1955.0420294055953;19716.80283197164;20165.495862603406;20224.898875505674;20341.593168136704;20363;2357.381389926296;2418.5283869645427;2465.765752253551;2467.6545283660303;2481.6029435290266;142659;144838;145053.99999999895;145442;145500;14582;15167.620809479851;15202.923985380223;15325.923370383076;15491.457798977208;23967.52064958691;24026.87986560056;24057.27828165123;24132.276031719077;24137.396565085663;10454.63408780689;10579.84130238047;10610.681679549625;10649.733756656145;10763.3541987481;8332.33341332692;9841.163501102343;9906.257030722725;9909;9961.501924903725;8104.351651867836;9096.590653420611;9250.95374523123;9264.39781414206;9278.211352035018;2638.5039822235613;2649.7217792131933;2660.3349162709324;2814.3949050954143;2869.741723244918;943.2218419803552;970.3547141151197;970.84466485362;978.1001478639669;985.7437066362797;19900.303489377802;19920;19943.900280498794;20273.29043483471;20517.281895133598;1017.8829434614966;1025.9281850270559;1029.8712660917386;1042.6402891002592;1043.3635482355758;11113.11095112389;11124.332540047622;11160.218784685156;11184.608538701106;11266.943665281786;533145;538471;539554;545683;546658;107919.46040269906;113823.43088284506;118267;118348;118955;1199.6700907250402;1215.1736818963013;1219.890209881115;1222.3399364343334;1227.7176249462495;17868.821311786716;17968.73046904271;18025.819741802938;18037.278508859497;18306;54172.72913635564;54230.728846355516;55713.72143139259;56406.15390769224;56409.74361025513;66655.66672166609;67862.3213767856;68713.65643171752;68954;69471.65264173849;12499.75000500003;12563.037156381912;14860.85139148638;15075.170865602497;15100;23550.17574384957;23663.408414789767;23892.641610376206;23899.761002389754;24049.278521644377;18375.264989400275;18837.15232814554;18872.433826985212;18940.905295473436;19045.61908761845;16559.83440165583;16883.40908068212;17245.137743112544;17276.13619319004;17430.477085686944;18752.718709219647;18823.529411764815;18918.716219256446;19236.326728564432;19405.4178374649;14791.630209244424;14911.17988510599;14912.105273683614;14914.403423862925;14915.030523015968;18208.180631871863;18442.907785460986;18446.446606601825;18486.075696215405;18586.628267434848 11:14:01 INFO - PID 9037 | |3;mootools.html;1323.821284126643;1349.2174538767515;1363.4546181527394;1377.5178687459384;1383.6471699716574;13832.446702131916;14299.428022879072;14336.354864031118;14352.067115637503;14476.2761861907;14323.57029289123;14575.635609109777;14594.708105837877;14623.195724235164;14627.926860365684;2671.412289296352;2710.227585138236;2712.22701530064;2712.471068141703;2715.022591866926;2611.647427597269;2786.651668541432;2791.1207969489647;2796.5106106431394;2797.8880844766286;2739.5479745841913;2746.807723459359;2770.9584356234673;2772.7781777457753;2775.528160212769;2668.4663067386505;2673.1980405878353;2698.9743897318895;2710.783137349017;2730.6177135200987;2569.0622922633293;2603.5313643544155;2604.609308603706;2605.4268061026546;2606.0357667662897;14154.796842268419;14166.220857852813;14223.573292801233;14260.35828387725;14331.42674293027;7536.133344665379;7794.532328060334;7892.0529536455415;7903.723369682091;7905.446618736691;4949.133901567247;5151.896962060775;5183.714895680736;5213.113770658959;5217.869553261161;1779.644071185768;1807.5300421890404;1808.5478630342413;1860.8046155153784;1886.556659185104;22902.427439313982;23173.420664483354;23198.884005579865;23219.53560928789;23246.76753232463;6521.08704781331;6545.639989800607;6677.699503522354;6743.696533655997;6804.897926531106;16111.677766444605;16157.838421615634;16267;16307.673846523241;16325.755113673304;7555.962220188974;7750.883736743954;7752.26353496417;7756.728514501965;7757.26306000929;7137.643117844191;7179.138503379628;7279.490435669558;7310.342069213796;7316.487845850739;4974.427940786856;5104;5126.410462796752;5212.478752124833;5233.267342572043;1511.1839606612307;1524.0322395278856;1528.99235503824;1545.2275056465994;1558.3844381469255;892.3708785306344;912.397817440486;925.1442415765524;926.6154545863526;935.7426707655313;7570.621468926642;7589.316961473494;7655.57894315818;7659.731909383145;7688.308052275322;686.7630667419733;704.9577025378494;716.7133146741345;725.1551941987631;731.1336066760905;4401.427814384109;4535.115652447807;4554.590086892129;4583.381243532081;4629.3518907353;18885;19726.408207753502;19876.204951802054;19894.104765285596;20186.19255229804;18604.025910012086;18697.81302186988;19298.71051934222;19411.708824367644;19448.70826937597;10700.732481688021;10810.135189184846;10886.129109671207;10889.509972051277;10902.182336324808;8175;8253.463524870864;8317.168283171635;8374.120717324593;8392.28665563434;16664.25010874538;16764.32942682328;16946.491605251864;17025.829741702426;17049.829501704826;17481.82518174853;17516.562085947953;17606.82393176103;17619.55951101233;17737.645247095243;10526.10528105089;10677.359358438518;11552.191346605658;12026.75946481083;12140.635780926586;13444.932775336452;13505.189688618322;13507.729845403233;13569.118007329493;13586.524471643444;11132.109431245643;11196.160287978271;11325.773484530428;11331.886681133083;11406.942965285121;10497.632582859564;10529.4735263235;10569.682909512727;10827.458627068772;10949.288296260718;9582;9690.321677482509;9710.854337185088;9715.902840971783;9770.071843174886;6989.825254368681;7006.894896576454;7051.1186101737285;7057.541259818096;7108.431325493844;7162.212156662658;7223.819404514719;7247.456440766858;7253.709851606088;7289.635518223961 11:14:01 INFO - PID 9037 | |4;prototype.html;492.3653470478012;499.71878375217153;514.3442111308084;527.1854984049643;530.8991291654586;6180.412860778224;6214.285357183925;6282.246130464345;6316.241836107509;6376.394242546962;5942.940570594293;6038.245219347582;6044.546659000571;6074.422929821671;6170.7223174957235;4844.5155484451625;4882.707037577739;4921.80312787488;4930.556249937505;4950.90098198035;4903.901921961558;4922.950770492285;4945.802167913279;4966.726830024347;4981.626378021645;4685.344051832729;4879.6828206166665;4897.461279259279;4898.951010489903;4933.7533123343865;4855.684380515255;4866.635002374836;4879.852864739503;4889.315495830587;4908.9263661045115;4384.320430333303;4417.779111044467;4432.027747652296;4445;4468.151051300275;6100.145979562864;6134.539909506805;6145;6180.81457556274;6193.349698281706;5613.410591887834;5627.662340259598;5641.238432811559;5645;5659.4340565943485;6435.6782160892235;6452.193475815523;6474.255460621995;6548.214214294315;6567.967160164217;4747.7626118693925;4773.689710168863;4809.519048095198;4813.326134341195;4840.394950631171;6846.4522838172825;6880.449564034865;6943.72225111;6960.79117626472;7024.473164512682;4939.925901111486;4955.959248557843;4956.628252881048;4964.205727083649;4970.776315065831;4990.725510096907;5002.849914502571;5030.89938201234;5031.465403052104;5041.697498150123;5605.32736071674;5646.350669672958;5655.943440565624;5677.858053548612;5703.315602127771;6498.38265364799;6564.063601237646;6582.407583317525;6596.901046484307;6607.603543787388;1642.7371620540657;1680.3614626442118;1710.3757128647953;1711.0076155829588;1741.651669666072;1178.1105265524475;1191.112621097288;1199.9700007499882;1210.8244304575787;1228.74054094552;5684.857878552986;5691.430856914359;5699.401562835926;5744.885102297931;5796.101604251347;6431.324710905381;6679.165104361955;6682.532222744361;6738.59568425896;6777;5698.458646428583;5729.512991395694;5739.741711622987;5741.19623252745;5791.797287094932;3518.9824050879583;3567.9643203568153;3616.2044350242904;3638.5451818522683;3640.472131540912;6519.445847102955;6534.575252608565;6558.704858281389;6620.602763834186;6626.536142470077;6913.619750913647;6922.2731613180895;6963.373296403348;6979.965100174467;7002.894956575656;6541.640209788412;6562.343765623399;6578.177727784123;6578.572392794453;6603.240627327918;6718;6728.73085076611;6737.359950804862;6852.760153394607;6874.793756187322;6642.568233064835;6690.330966903271;6712.2616512184595;6727.192736871607;6745.2242992056545;6504.38208370223;6523.445507131947;6532.085508028785;6543.116679248241;6549.24683661385;4911.115999120193;4930.383702037246;4945.554900059012;4954.5540901319055;4979.829740011022;6669.4997875160525;6714.294999025032;6719.832004199934;6796.35434633709;6838.350356716104;6481.740730370732;6511.153550038464;6519.4784417245555;6564.113844631104;6603.669816509059;6343.90484142729;6472.320406357453;6551.541392102507;6565.80302590923;6588.472922166119;6185.84535386619;6295.779647712308;6403.8719225614295;6405.583637063576;6460.834191246349;6374.840628984312;6399.712012959521;6430.517711171775;6540.345965403421;6546.705398256994;6252.249730032425;6264.906026409516;6281.403266689657;6324.588901721373;6348 11:14:01 INFO - PID 9037 | |5;yui.html;894.0612357025124;905.2260317428603;914.0904799724274;916.3631276262992;916.7433118726759;18952;19735.802641973576;19739.802601973977;19773.40679779607;22402.551948961012;21341.146354145854;21707.891460542676;21836.126554937782;21999.34001979939;22110.778892211114;1031.8503816946557;1046.6546039806883;1048.1981284317465;1058.3544038136731;1059.523214553454;1026.8767747870265;1037.1702637889696;1043.0716662170673;1045.0751085289535;1049.2864851900704;1118.4407796101948;1122.876483586809;1123.2754873106883;1123.8876112388778;1124.2242852431796;1115.6987613344352;1117.3463523838564;1119.160629527854;1124.213050864394;1125.4991528769701;817.8650522663753;819.49191501269;819.5533434278333;821.6713314674118;823.1069289820551;19575.314863979835;20139.093740781555;20176.596468070704;20272.49318767028;20300.289489867784;19369.22523099074;19472.80527194724;19634.116464758976;20001.499962500908;20070.397888063235;16604.83395166045;16910.323587056504;16951.91524042384;17085.82914170855;17182.398616048504;3649.835757390897;3678.779273243614;3679.2641471705765;3679.908002299937;3680.815959202056;126246;126418.36790815987;127049.36475317564;127702.36148819196;129737;17132.914335428493;17158.142092895305;17327.306907723803;17465.08379888253;17492.737608935877;31139.688603114133;31421.214469637984;31511.684883150876;31642.367152656818;32011.679883201337;7512.136104347961;7932.286094251545;8554.18735220153;8603.440776349516;9079.909200907907;4108.424820525129;4173.561776013536;4203.600657937491;4212.705110642226;4224.746515209097;4948.703077815343;5040.143175660147;5048.697078175322;5107.87230319245;5122.078025955289;955.8040601676639;966.917811985989;975.0493269062607;979.4417182206074;982.2485798364257;679.3172861274387;690.1063123255396;690.3372762148293;699.3111784891878;704.4188544450849;11690.532378704756;12243.632691019284;12409.875901241052;12415.44130514129;12870;683.1324218242804;686.6326515314283;696.8571442854203;712.0245263988369;712.1311999360771;5694.259746232963;5734.741936612779;5785.0454674978155;5895.056790913433;5963.731632076567;112368;114685.4265728666;116538.41730791293;116863;117894;101510;103526.48236758918;104760.47619761853;105714.99999999846;109268;88000.5599971996;88211.55894220616;88436.5578172105;90531.54734226418;92631.53684231536;11147.442627868411;12756.48974041065;12922.547710830077;13302.268375239455;13553.661158471117;40651;40752;41377.586224137376;41559.376609351486;42727.3590896143;72588.27411725814;73919;75162.24837751553;77848.61075694585;78295.21704782879;15493.457728979432;18937.242510299435;18996.905015474833;19968.20127194954;19987.60024799525;19158.521036974187;19187.520311992314;20165.899170504053;21537;22706.886465567568;19214.711779323043;19331.226750929804;19858.304959326353;19977.800221997593;20041.699374509684;16840.9895406276;17060.74408883843;17154.142292885055;17755.55611109681;18190.272389104815;16852.241649125575;17003.149842507577;18483.72274415858;18873.245070197037;19300.324488643393;14526.346314416089;14822.555323340317;14852.925735371255;14946.327415266122;15033.548993530212;14913.701725965202;15000.149433646358;15076.321565529797;15086.471973480875;15193.392264309305 11:14:01 INFO - PID 9037 | __end_tp_report 11:14:01 INFO - PID 9037 | __start_cc_report 11:14:01 INFO - PID 9037 | _x_x_mozilla_cycle_collect,383 11:14:01 INFO - PID 9037 | __end_cc_report 11:14:01 INFO - PID 9037 | __startTimestamp1503166441271__endTimestamp 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | ------- Summary: start ------- 11:14:01 INFO - PID 9037 | Number of tests: 6 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#0] dojo.html Cycles:165 Average:6149.23 Median:6377.01 stddev:717.00 (11.2%) stddev-sans-first:678.59 11:14:01 INFO - PID 9037 | Values: 3116.7 3162.2 3164.1 3172.8 3221.3 6163.4 6298.5 6322.8 6324.0 6341.3 6115.5 6204.3 6207.8 6210.3 6248.9 5679.1 5681.3 5706.5 5723.1 5797.8 5754.6 5757.5 5776.4 5797.2 5863.3 5540.9 5655.2 5706.6 5800.0 5814.1 5638.3 5679.1 5753.3 5777.9 5784.5 5664.1 5700.9 5741.3 5743.8 5745.8 6080.9 6090.6 6109.8 6120.5 6164.8 6686.6 6701.0 6710.9 6718.5 6722.7 6696.4 6710.0 6730.5 6807.3 6810.0 5944.5 6101.7 6223.2 6256.9 6291.6 6814.0 6895.9 6905.8 6906.0 6917.9 6454.6 6532.7 6578.5 6586.0 6589.1 6665.9 6698.8 6727.5 6739.1 6778.3 6497.4 6565.2 6645.6 6673.8 6683.5 6678.3 6703.3 6708.8 6710.9 6715.3 5348.3 5374.3 5499.4 5509.5 5516.0 4642.9 4672.8 4675.1 4698.4 4720.2 5789.2 5858.7 5870.4 5871.1 5872.8 6580.4 6642.6 6715.5 6820.1 6820.5 5738.5 5771.4 5784.3 5786.7 5792.1 5893.9 5909.4 5913.1 5914.8 5915.6 6425.6 6427.6 6429.1 6433.8 6440.1 6600.3 6609.8 6641.0 6650.0 6655.9 5688.7 6435.5 6465.7 6541.5 6587.1 6585.2 6604.7 6620.5 6658.8 6685.0 6660.2 6678.9 6704.3 6751.2 6757.8 6455.4 6468.9 6496.7 6502.7 6504.8 6476.0 6476.4 6496.0 6502.9 6513.4 6356.8 6377.0 6438.5 6456.0 6458.2 6490.5 6520.8 6573.9 6614.1 6617.8 6248.6 6269.6 6346.1 6346.8 6352.3 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#1] ext.html Cycles:180 Average:38175.18 Median:19796.54 stddev:53655.38 (271.0%) stddev-sans-first:53732.63 11:14:01 INFO - PID 9037 | Values: 833.5 840.9 870.7 892.4 898.9 42871.8 43326.6 43621.3 43696.0 43742.3 38135.6 38302.6 38339.8 38352.2 38358.6 6919.3 7004.0 7019.3 7021.2 7047.0 6949.9 6978.2 7014.1 7028.8 7037.4 7773.7 7982.3 7989.7 7991.0 7996.0 7876.0 7884.8 7938.7 7947.4 7951.8 7630.5 7770.1 7781.4 7911.7 7926.4 38811.4 38847.8 38860.2 39013.0 39021.4 3593.1 3614.4 3614.5 3631.5 3652.3 31428.7 31881.4 31931.0 31997.7 32041.8 4636.8 4641.8 4651.0 4653.9 4655.0 180111.0 183492.1 194543.0 195319.0 204290.0 51934.7 52061.7 52257.2 52266.5 52389.5 54631.5 55106.4 55156.2 55165.0 55200.7 16633.8 16753.2 16828.7 16834.0 16988.7 13921.7 13934.7 13948.0 13950.6 13952.2 15021.2 15083.8 15086.0 15105.1 15269.8 5870.6 5908.3 6042.6 6074.5 6132.5 1011.9 1016.6 1017.8 1026.5 1028.2 22951.3 22997.8 23130.2 23139.4 23149.8 1106.6 1109.7 1112.6 1125.9 1129.2 12232.6 12349.1 12364.4 12371.0 12409.7 212334.0 235538.0 235975.0 237323.0 238086.0 56561.0 57012.7 57015.4 57020.0 57095.1 1467.6 1503.7 1505.6 1511.3 1527.2 23122.8 23261.7 23431.2 23510.4 23530.4 39732.6 39779.4 39820.8 39830.2 39877.8 193444.0 193776.0 193916.0 194491.0 195346.0 31107.7 31756.5 35308.8 35746.8 35978.6 45533.3 45649.5 45730.8 45904.5 45973.5 33592.5 33787.7 33969.3 34088.3 34480.7 32153.7 32155.4 32792.2 33113.3 33251.5 36814.8 36876.6 37119.6 37195.6 37369.8 31933.2 32032.0 32107.2 32151.8 32577.5 22583.5 23131.8 23662.8 23857.0 24021.6 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#2] jquery.html Cycles:180 Average:36420.13 Median:12953.78 stddev:90579.63 (699.3%) stddev-sans-first:90793.73 11:14:01 INFO - PID 9037 | Values: 566.8 570.7 573.4 573.9 583.6 22432.0 22628.9 23266.2 23294.0 23363.6 26417.7 26909.0 26996.2 27022.7 27119.0 6398.4 6558.4 6559.6 6564.5 6577.8 5921.9 6389.9 6414.4 6425.7 6479.0 6430.6 6432.0 6439.1 6439.6 6451.1 6414.6 6426.6 6444.1 6446.4 6453.2 5986.0 6002.5 6009.7 6022.7 6026.2 29103.9 29772.3 30413.8 30426.2 30447.1 1910.3 1946.0 1951.8 1953.5 1955.0 19716.8 20165.5 20224.9 20341.6 20363.0 2357.4 2418.5 2465.8 2467.7 2481.6 142659.0 144838.0 145054.0 145442.0 145500.0 14582.0 15167.6 15202.9 15325.9 15491.5 23967.5 24026.9 24057.3 24132.3 24137.4 10454.6 10579.8 10610.7 10649.7 10763.4 8332.3 9841.2 9906.3 9909.0 9961.5 8104.4 9096.6 9251.0 9264.4 9278.2 2638.5 2649.7 2660.3 2814.4 2869.7 943.2 970.4 970.8 978.1 985.7 19900.3 19920.0 19943.9 20273.3 20517.3 1017.9 1025.9 1029.9 1042.6 1043.4 11113.1 11124.3 11160.2 11184.6 11266.9 533145.0 538471.0 539554.0 545683.0 546658.0 107919.5 113823.4 118267.0 118348.0 118955.0 1199.7 1215.2 1219.9 1222.3 1227.7 17868.8 17968.7 18025.8 18037.3 18306.0 54172.7 54230.7 55713.7 56406.2 56409.7 66655.7 67862.3 68713.7 68954.0 69471.7 12499.8 12563.0 14860.9 15075.2 15100.0 23550.2 23663.4 23892.6 23899.8 24049.3 18375.3 18837.2 18872.4 18940.9 19045.6 16559.8 16883.4 17245.1 17276.1 17430.5 18752.7 18823.5 18918.7 19236.3 19405.4 14791.6 14911.2 14912.1 14914.4 14915.0 18208.2 18442.9 18446.4 18486.1 18586.6 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#3] mootools.html Cycles:180 Average:8817.20 Median:2640.06 stddev:6019.78 (228.0%) stddev-sans-first:6010.33 11:14:01 INFO - PID 9037 | Values: 1323.8 1349.2 1363.5 1377.5 1383.6 13832.4 14299.4 14336.4 14352.1 14476.3 14323.6 14575.6 14594.7 14623.2 14627.9 2671.4 2710.2 2712.2 2712.5 2715.0 2611.6 2786.7 2791.1 2796.5 2797.9 2739.5 2746.8 2771.0 2772.8 2775.5 2668.5 2673.2 2699.0 2710.8 2730.6 2569.1 2603.5 2604.6 2605.4 2606.0 14154.8 14166.2 14223.6 14260.4 14331.4 7536.1 7794.5 7892.1 7903.7 7905.4 4949.1 5151.9 5183.7 5213.1 5217.9 1779.6 1807.5 1808.5 1860.8 1886.6 22902.4 23173.4 23198.9 23219.5 23246.8 6521.1 6545.6 6677.7 6743.7 6804.9 16111.7 16157.8 16267.0 16307.7 16325.8 7556.0 7750.9 7752.3 7756.7 7757.3 7137.6 7179.1 7279.5 7310.3 7316.5 4974.4 5104.0 5126.4 5212.5 5233.3 1511.2 1524.0 1529.0 1545.2 1558.4 892.4 912.4 925.1 926.6 935.7 7570.6 7589.3 7655.6 7659.7 7688.3 686.8 705.0 716.7 725.2 731.1 4401.4 4535.1 4554.6 4583.4 4629.4 18885.0 19726.4 19876.2 19894.1 20186.2 18604.0 18697.8 19298.7 19411.7 19448.7 10700.7 10810.1 10886.1 10889.5 10902.2 8175.0 8253.5 8317.2 8374.1 8392.3 16664.3 16764.3 16946.5 17025.8 17049.8 17481.8 17516.6 17606.8 17619.6 17737.6 10526.1 10677.4 11552.2 12026.8 12140.6 13444.9 13505.2 13507.7 13569.1 13586.5 11132.1 11196.2 11325.8 11331.9 11406.9 10497.6 10529.5 10569.7 10827.5 10949.3 9582.0 9690.3 9710.9 9715.9 9770.1 6989.8 7006.9 7051.1 7057.5 7108.4 7162.2 7223.8 7247.5 7253.7 7289.6 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#4] prototype.html Cycles:180 Average:5490.28 Median:6139.77 stddev:1558.49 (25.4%) stddev-sans-first:1517.05 11:14:01 INFO - PID 9037 | Values: 492.4 499.7 514.3 527.2 530.9 6180.4 6214.3 6282.2 6316.2 6376.4 5942.9 6038.2 6044.5 6074.4 6170.7 4844.5 4882.7 4921.8 4930.6 4950.9 4903.9 4923.0 4945.8 4966.7 4981.6 4685.3 4879.7 4897.5 4899.0 4933.8 4855.7 4866.6 4879.9 4889.3 4908.9 4384.3 4417.8 4432.0 4445.0 4468.2 6100.1 6134.5 6145.0 6180.8 6193.3 5613.4 5627.7 5641.2 5645.0 5659.4 6435.7 6452.2 6474.3 6548.2 6568.0 4747.8 4773.7 4809.5 4813.3 4840.4 6846.5 6880.4 6943.7 6960.8 7024.5 4939.9 4956.0 4956.6 4964.2 4970.8 4990.7 5002.8 5030.9 5031.5 5041.7 5605.3 5646.4 5655.9 5677.9 5703.3 6498.4 6564.1 6582.4 6596.9 6607.6 1642.7 1680.4 1710.4 1711.0 1741.7 1178.1 1191.1 1200.0 1210.8 1228.7 5684.9 5691.4 5699.4 5744.9 5796.1 6431.3 6679.2 6682.5 6738.6 6777.0 5698.5 5729.5 5739.7 5741.2 5791.8 3519.0 3568.0 3616.2 3638.5 3640.5 6519.4 6534.6 6558.7 6620.6 6626.5 6913.6 6922.3 6963.4 6980.0 7002.9 6541.6 6562.3 6578.2 6578.6 6603.2 6718.0 6728.7 6737.4 6852.8 6874.8 6642.6 6690.3 6712.3 6727.2 6745.2 6504.4 6523.4 6532.1 6543.1 6549.2 4911.1 4930.4 4945.6 4954.6 4979.8 6669.5 6714.3 6719.8 6796.4 6838.4 6481.7 6511.2 6519.5 6564.1 6603.7 6343.9 6472.3 6551.5 6565.8 6588.5 6185.8 6295.8 6403.9 6405.6 6460.8 6374.8 6399.7 6430.5 6540.3 6546.7 6252.2 6264.9 6281.4 6324.6 6348.0 11:14:01 INFO - PID 9037 | 11:14:01 INFO - PID 9037 | [#5] yui.html Cycles:180 Average:24638.34 Median:19913.25 stddev:33521.55 (168.3%) stddev-sans-first:33568.17 11:14:01 INFO - PID 9037 | Values: 894.1 905.2 914.1 916.4 916.7 18952.0 19735.8 19739.8 19773.4 22402.6 21341.1 21707.9 21836.1 21999.3 22110.8 1031.9 1046.7 1048.2 1058.4 1059.5 1026.9 1037.2 1043.1 1045.1 1049.3 1118.4 1122.9 1123.3 1123.9 1124.2 1115.7 1117.3 1119.2 1124.2 1125.5 817.9 819.5 819.6 821.7 823.1 19575.3 20139.1 20176.6 20272.5 20300.3 19369.2 19472.8 19634.1 20001.5 20070.4 16604.8 16910.3 16951.9 17085.8 17182.4 3649.8 3678.8 3679.3 3679.9 3680.8 126246.0 126418.4 127049.4 127702.4 129737.0 17132.9 17158.1 17327.3 17465.1 17492.7 31139.7 31421.2 31511.7 31642.4 32011.7 7512.1 7932.3 8554.2 8603.4 9079.9 4108.4 4173.6 4203.6 4212.7 4224.7 4948.7 5040.1 5048.7 5107.9 5122.1 955.8 966.9 975.0 979.4 982.2 679.3 690.1 690.3 699.3 704.4 11690.5 12243.6 12409.9 12415.4 12870.0 683.1 686.6 696.9 712.0 712.1 5694.3 5734.7 5785.0 5895.1 5963.7 112368.0 114685.4 116538.4 116863.0 117894.0 101510.0 103526.5 104760.5 105715.0 109268.0 88000.6 88211.6 88436.6 90531.5 92631.5 11147.4 12756.5 12922.5 13302.3 13553.7 40651.0 40752.0 41377.6 41559.4 42727.4 72588.3 73919.0 75162.2 77848.6 78295.2 15493.5 18937.2 18996.9 19968.2 19987.6 19158.5 19187.5 20165.9 21537.0 22706.9 19214.7 19331.2 19858.3 19977.8 20041.7 16841.0 17060.7 17154.1 17755.6 18190.3 16852.2 17003.1 18483.7 18873.2 19300.3 14526.3 14822.6 14852.9 14946.3 15033.5 14913.7 15000.1 15076.3 15086.5 15193.4 11:14:01 INFO - PID 9037 | -------- Summary: end -------- 11:14:01 INFO - PID 9037 | 11:14:01 INFO - TEST-INFO | 9037: exit 0 11:14:02 INFO - TEST-OK | dromaeo_css | took 1111749ms 11:14:02 INFO - TEST-START | kraken 11:14:02 INFO - Initialising browser for kraken test... 11:14:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35108/getInfo.html -profile /tmp/tmpoiWjyA/profile 11:14:02 INFO - TEST-INFO | started process 9459 (/builds/slave/test/build/application/firefox/firefox http://localhost:35108/getInfo.html) 11:14:07 INFO - TEST-INFO | 9459: exit 0 11:14:07 INFO - Browser initialized. 11:14:07 INFO - Running cycle 1/1 for kraken test... 11:14:07 INFO - TEST-INFO | started process 9645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoiWjyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:08 INFO - PID 9645 | 11:14:08 INFO - PID 9645 | (/builds/slave/test/build/application/firefox/firefox:9695): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:14:08 INFO - PID 9645 | 11:14:09 INFO - PID 9645 | 11:14:09 INFO - PID 9645 | (/builds/slave/test/build/application/firefox/firefox:9756): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:14:09 INFO - PID 9645 | 11:14:09 INFO - PID 9645 | __metrics Screen width/height:1600/1200 11:14:09 INFO - PID 9645 | colorDepth:24 11:14:09 INFO - PID 9645 | Browser inner width/height: 1024/768 11:14:09 INFO - PID 9645 | __metrics 11:14:19 INFO - PID 9645 | RSS: Main: 174280704 11:14:19 INFO - PID 9645 | 11:14:21 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35108/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:22 INFO - PID 9645 | RSS: Main: 178634752 11:14:22 INFO - PID 9645 | 11:14:25 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35108/tests/kraken/driver.html?testName=audio-dft) 11:14:26 INFO - PID 9645 | RSS: Main: 180977664 11:14:26 INFO - PID 9645 | 11:14:29 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35108/tests/kraken/driver.html?testName=audio-fft) 11:14:29 INFO - PID 9645 | RSS: Main: 174870528 11:14:29 INFO - PID 9645 | 11:14:32 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35108/tests/kraken/driver.html?testName=audio-oscillator) 11:14:32 INFO - PID 9645 | RSS: Main: 174845952 11:14:32 INFO - PID 9645 | 11:14:34 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:35 INFO - PID 9645 | RSS: Main: 175210496 11:14:35 INFO - PID 9645 | 11:14:38 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35108/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:39 INFO - PID 9645 | RSS: Main: 176766976 11:14:39 INFO - PID 9645 | 11:14:42 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35108/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:43 INFO - PID 9645 | RSS: Main: 176553984 11:14:43 INFO - PID 9645 | 11:14:46 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35108/tests/kraken/driver.html?testName=json-parse-financial) 11:14:47 INFO - PID 9645 | RSS: Main: 177094656 11:14:47 INFO - PID 9645 | 11:14:48 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:49 INFO - PID 9645 | RSS: Main: 177278976 11:14:49 INFO - PID 9645 | 11:14:51 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:51 INFO - PID 9645 | RSS: Main: 178081792 11:14:51 INFO - PID 9645 | 11:14:53 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:54 INFO - PID 9645 | RSS: Main: 177373184 11:14:54 INFO - PID 9645 | 11:14:57 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:58 INFO - PID 9645 | RSS: Main: 177684480 11:14:58 INFO - PID 9645 | 11:15:01 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:01 INFO - PID 9645 | RSS: Main: 177831936 11:15:01 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | Cycle 1(1): loaded http://localhost:35108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35108/tests/kraken/driver.html?testName=ai-astar) 11:15:03 INFO - PID 9645 | RSS: Main: 179302400 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | __start_tp_report 11:15:03 INFO - PID 9645 | _x_x_mozilla_page_load 11:15:03 INFO - PID 9645 | _x_x_mozilla_page_load_details 11:15:03 INFO - PID 9645 | |i|pagename|runs| 11:15:03 INFO - PID 9645 | |0;ai-astar;98;108;104;108;108;116;110;99;112;106 11:15:03 INFO - PID 9645 | |1;audio-beat-detection;152;121;154;176;117;149;147;124;171;121 11:15:03 INFO - PID 9645 | |2;audio-dft;168;173;164;165;162;167;172;163;162;166 11:15:03 INFO - PID 9645 | |3;audio-fft;75;75;74;177;76;79;73;77;178;76 11:15:03 INFO - PID 9645 | |4;audio-oscillator;85;78;132;80;79;78;125;79;78;128 11:15:03 INFO - PID 9645 | |5;imaging-gaussian-blur;114;114;114;114;117;117;117;116;115;115 11:15:03 INFO - PID 9645 | |6;imaging-darkroom;154;151;151;151;150;151;150;159;150;152 11:15:03 INFO - PID 9645 | |7;imaging-desaturate;95;103;93;95;98;97;94;97;94;94 11:15:03 INFO - PID 9645 | |8;json-parse-financial;54;54;53;54;54;56;53;53;52;53 11:15:03 INFO - PID 9645 | |9;json-stringify-tinderbox;57;54;59;54;55;55;59;55;54;57 11:15:03 INFO - PID 9645 | |10;stanford-crypto-aes;79;76;79;76;78;85;75;77;81;79 11:15:03 INFO - PID 9645 | |11;stanford-crypto-ccm;124;120;129;120;120;125;128;120;125;165 11:15:03 INFO - PID 9645 | |12;stanford-crypto-pbkdf2;174;181;169;183;187;189;184;189;178;176 11:15:03 INFO - PID 9645 | |13;stanford-crypto-sha256-iterative;72;71;69;67;67;70;72;75;67;68 11:15:03 INFO - PID 9645 | __end_tp_report 11:15:03 INFO - PID 9645 | __start_cc_report 11:15:03 INFO - PID 9645 | _x_x_mozilla_cycle_collect,975 11:15:03 INFO - PID 9645 | __end_cc_report 11:15:03 INFO - PID 9645 | __startTimestamp1503166503942__endTimestamp 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | ------- Summary: start ------- 11:15:03 INFO - PID 9645 | Number of tests: 14 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#0] ai-astar Cycles:10 Average:106.90 Median:111.00 stddev:5.51 (5.0%) stddev-sans-first:4.81 11:15:03 INFO - PID 9645 | Values: 98.0 108.0 104.0 108.0 108.0 116.0 110.0 99.0 112.0 106.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:150.50 stddev:21.43 (14.2%) stddev-sans-first:22.49 11:15:03 INFO - PID 9645 | Values: 152.0 121.0 154.0 176.0 117.0 149.0 147.0 124.0 171.0 121.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:3.88 (2.3%) stddev-sans-first:4.06 11:15:03 INFO - PID 9645 | Values: 168.0 173.0 164.0 165.0 162.0 167.0 172.0 163.0 162.0 166.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.50 stddev:42.99 (56.9%) stddev-sans-first:44.92 11:15:03 INFO - PID 9645 | Values: 75.0 75.0 74.0 177.0 76.0 79.0 73.0 77.0 178.0 76.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.50 stddev:23.70 (30.2%) stddev-sans-first:24.90 11:15:03 INFO - PID 9645 | Values: 85.0 78.0 132.0 80.0 79.0 78.0 125.0 79.0 78.0 128.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.50 stddev:1.34 (1.2%) stddev-sans-first:1.33 11:15:03 INFO - PID 9645 | Values: 114.0 114.0 114.0 114.0 117.0 117.0 117.0 116.0 115.0 115.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.00 stddev:2.77 (1.8%) stddev-sans-first:2.83 11:15:03 INFO - PID 9645 | Values: 154.0 151.0 151.0 151.0 150.0 151.0 150.0 159.0 150.0 152.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.94 (3.1%) stddev-sans-first:3.10 11:15:03 INFO - PID 9645 | Values: 95.0 103.0 93.0 95.0 98.0 97.0 94.0 97.0 94.0 94.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.07 (2.0%) stddev-sans-first:1.13 11:15:03 INFO - PID 9645 | Values: 54.0 54.0 53.0 54.0 54.0 56.0 53.0 53.0 52.0 53.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:1.97 (3.5%) stddev-sans-first:2.05 11:15:03 INFO - PID 9645 | Values: 57.0 54.0 59.0 54.0 55.0 55.0 59.0 55.0 54.0 57.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.00 stddev:2.92 (3.7%) stddev-sans-first:3.09 11:15:03 INFO - PID 9645 | Values: 79.0 76.0 79.0 76.0 78.0 85.0 75.0 77.0 81.0 79.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.00 stddev:13.57 (10.9%) stddev-sans-first:14.34 11:15:03 INFO - PID 9645 | Values: 124.0 120.0 129.0 120.0 120.0 125.0 128.0 120.0 125.0 165.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:183.50 stddev:6.70 (3.7%) stddev-sans-first:6.61 11:15:03 INFO - PID 9645 | Values: 174.0 181.0 169.0 183.0 187.0 189.0 184.0 189.0 178.0 176.0 11:15:03 INFO - PID 9645 | 11:15:03 INFO - PID 9645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:2.70 (3.8%) stddev-sans-first:2.74 11:15:03 INFO - PID 9645 | Values: 72.0 71.0 69.0 67.0 67.0 70.0 72.0 75.0 67.0 68.0 11:15:03 INFO - PID 9645 | -------- Summary: end -------- 11:15:03 INFO - PID 9645 | 11:15:04 INFO - PID 9645 | 11:15:04 INFO - PID 9645 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:15:04 INFO - PID 9645 | 11:15:04 INFO - PID 9645 | 11:15:04 INFO - PID 9645 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:15:04 INFO - PID 9645 | 11:15:04 INFO - PID 9645 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:15:04 INFO - TEST-INFO | 9645: exit 0 11:15:04 INFO - TEST-OK | kraken | took 62736ms 11:15:04 INFO - SUITE-END | took 1174s 11:15:05 INFO - Completed test suite (00:19:34) 11:15:05 INFO - javascript benchmark 11:15:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.21186696115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.688331166885, 3162.193640621641, 3164.1456806662195, 3172.762042846787, 3221.259110404607, 6163.41447562482, 6298.4646305064125, 6322.778702745399, 6324.0, 6341.334159913212, 6115.541334399927, 6204.255489341285, 6207.751689932397, 6210.285817131031, 6248.875022499547, 5679.062954612495, 5681.289838770153, 5706.543476521868, 5723.084306510959, 5797.797077102302, 5754.625949313281, 5757.453041961028, 5776.39347868474, 5797.188393624896, 5863.296404431474, 5540.944590554083, 5655.236543066674, 5706.600537962344, 5799.971000145015, 5814.069748840187, 5638.323401191883, 5679.09134538476, 5753.252077229975, 5777.855553611152, 5784.4504772046585, 5664.065429204176, 5700.885982280372, 5741.253637027202, 5743.770249190027, 5745.798897038583, 6080.905437021334, 6090.5736598438125, 6109.755609775603, 6120.479759220471, 6164.784232551884, 6686.632235227061, 6700.966495167541, 6710.899336509956, 6718.49611279156, 6722.66386680664, 6696.363845434676, 6709.966450167718, 6730.495212859007, 6807.285235050298, 6810.046593476917, 5944.494717949023, 6101.694915254219, 6223.190985171898, 6256.87486250277, 6291.591046581958, 6814.046033555207, 6895.931040689629, 6905.792826215222, 6905.965470172617, 6917.861642767117, 6454.644994525346, 6532.6733663316645, 6578.506612004119, 6585.967070164715, 6589.077529145923, 6665.933340666628, 6698.765543205965, 6727.461803055744, 6739.090222819955, 6778.3221677831825, 6497.415232629086, 6565.24499682533, 6645.60126392418, 6673.766418175438, 6683.498737594603, 6678.332166783282, 6703.3296670332575, 6708.832279192961, 6710.865782684416, 6715.294894036154, 5348.331458567679, 5374.3013408256675, 5499.367572729107, 5509.531689806411, 5516.0, 4642.907141857144, 4672.766361681903, 4675.0883577702025, 4698.412698412699, 4720.150372932905, 5789.218455508452, 5858.736356863951, 5870.354261031283, 5871.119332100134, 5872.794452194153, 6580.374864387875, 6642.568233064835, 6715.496337774589, 6820.079289295981, 6820.454363650995, 5738.512226460714, 5771.365149833515, 5784.2769653793275, 5786.739596718157, 5792.131180322901, 5893.882122357614, 5909.409059094142, 5913.113033044991, 5914.792982245687, 5915.585908986416, 6425.58233714807, 6427.614343139427, 6429.132067170872, 6433.774817881352, 6440.130582371414, 6600.306967768315, 6609.801705948829, 6640.966795165993, 6649.966750166412, 6655.900161497581, 5688.658680479184, 6435.51733619971, 6465.676716164079, 6541.542092053511, 6587.143671322698, 6585.176852893388, 6604.7027883746305, 6620.470362371095, 6658.766943156967, 6685.0, 6660.200775906922, 6678.933210667831, 6704.262531121671, 6751.156105486814, 6757.831054223684, 6455.386738259858, 6468.8706225874275, 6496.707648155939, 6502.707378167899, 6504.804855854332, 6476.028595710681, 6476.449501792212, 6495.967520162369, 6502.934970650233, 6513.381228783258, 6356.809295721136, 6377.01156320771, 6438.549301548846, 6455.999320105391, 6458.192725909262, 6490.545661803629, 6520.804375868732, 6573.934260657332, 6614.10709554204, 6617.834554135992, 6248.625082495065, 6269.62382257066, 6346.143270658402, 6346.809595712136, 6352.333005034405], "value": 6096.308123152787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.462416741202, 840.9117042710511, 870.6822009966362, 892.4243862708552, 898.9011208767031, 42871.78564107179, 43326.56673433265, 43621.345679814825, 43696.0, 43742.343864842056, 38135.61864381362, 38302.616973830256, 38339.808300958524, 38352.23295534088, 38358.61641383585, 6919.2734762849805, 7004.0, 7019.262977387378, 7021.22766495685, 7047.0, 6949.922761971877, 6978.232394436608, 7014.053102831129, 7028.82427939303, 7037.3666370026685, 7773.7279195228175, 7982.28159465648, 7989.720359787409, 7991.0, 7996.040475142962, 7876.0, 7884.80287992799, 7938.722144724936, 7947.4039447041705, 7951.840963180762, 7630.504017238917, 7770.067591889009, 7781.41639377049, 7911.723089691834, 7926.365890728728, 38811.41782873259, 38847.8057609713, 38860.22279554393, 39013.0, 39021.41467877984, 3593.065802891267, 3614.4397618369194, 3614.530111085542, 3631.4734363517405, 3652.2878038782183, 31428.685713142804, 31881.362372752646, 31931.0, 31997.680023199704, 32041.839790800896, 4636.814527418899, 4641.791119399635, 4651.0, 4653.906921861578, 4654.952635656984, 180111.0, 183492.08253958778, 194543.0, 195319.0, 204289.97855010777, 51934.740326298124, 52061.7396913013, 52257.216141757905, 52266.47733522616, 52389.47610523922, 54631.453685462635, 55106.44893551093, 55156.17265741017, 55165.0, 55200.72399637976, 16633.750493742602, 16753.246103925354, 16828.663426731397, 16834.0, 16988.74516882248, 13921.721565568632, 13934.651633709036, 13947.95390345728, 13950.581482555539, 13952.232627205602, 15021.173835439156, 15083.773743393858, 15086.0, 15105.093694378153, 15269.770953435707, 5870.559708021916, 5908.3205431375945, 6042.6072305300895, 6074.54440916933, 6132.478739307119, 1011.8886922438674, 1016.6441745389203, 1017.8167929772563, 1026.4918865161792, 1028.1723212813608, 22951.311460655874, 22997.770022299897, 23130.19044333474, 23139.421514462272, 23149.76850231476, 1106.6403418888733, 1109.7447587054862, 1112.5994641928899, 1125.9380734059541, 1129.1531351486385, 12232.571859984857, 12349.073819463576, 12364.381780910919, 12370.989819060864, 12409.69698181696, 212334.0, 235538.0, 235975.0, 237323.0, 238086.0, 56561.0, 57012.71493642505, 57015.429845701845, 57020.0, 57095.14357284644, 1467.5890750589851, 1503.7443634582148, 1505.6085417791235, 1511.2594828533938, 1527.2287494815048, 23122.76877231206, 23261.651075233545, 23431.179908703114, 23510.412239694146, 23530.411739706644, 39732.60267397405, 39779.40330894981, 39820.80089599534, 39830.2033959325, 39877.80061099676, 193444.0, 193776.0, 193916.0, 194491.0, 195346.0, 31107.68892311048, 31756.523652144773, 35308.82345588256, 35746.8212658935, 35978.64021359753, 45533.31700024568, 45649.54350456586, 45730.771346143054, 45904.540954590026, 45973.54026459826, 33592.49611255882, 33787.66212337845, 33969.32061358808, 34088.318233635684, 34480.65519344775, 32153.713851445682, 32155.35689286248, 32792.180195495304, 33113.33773324568, 33251.50122748209, 36814.8159259202, 36876.631233687316, 37119.62880371162, 37195.62804371922, 37369.813150934075, 31933.20166995844, 32032.0, 32107.19732006625, 32151.839240803645, 32577.511337330434, 22583.548329033656, 23131.768682312962, 23662.763372366055, 23857.0, 24021.639675404535], "value": 17422.576498289225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8384510414531, 570.7374607680467, 573.3807487913049, 573.8507987923139, 583.5739909865798, 22432.0, 22628.88685556572, 23266.18568350108, 23294.0, 23363.649545256812, 26417.735822641767, 26909.0, 26996.1901142966, 27022.729772702267, 27119.0, 6398.392152745481, 6558.442532384753, 6559.639219842907, 6564.474842012652, 6577.835554111138, 5921.88156236875, 6389.872202555946, 6414.422701956823, 6425.678716064202, 6479.0281457781475, 6430.614163150202, 6431.967840160793, 6439.098526206335, 6439.6136231826, 6451.096846441502, 6414.550981431302, 6426.6144031358035, 6444.097826304321, 6446.387593178664, 6453.193350831146, 5985.970070149621, 6002.459778619901, 6009.669468179249, 6022.728977196037, 6026.156338112668, 29103.85448072746, 29772.255693607618, 30413.847930760203, 30426.239344016354, 30447.086587402413, 1910.2550005497867, 1945.9610807783906, 1951.834094102003, 1953.4920920560614, 1955.0420294055953, 19716.80283197164, 20165.495862603406, 20224.898875505674, 20341.593168136704, 20363.0, 2357.381389926296, 2418.5283869645427, 2465.765752253551, 2467.6545283660303, 2481.6029435290266, 142659.0, 144838.0, 145053.99999999895, 145442.0, 145500.0, 14582.0, 15167.620809479851, 15202.923985380223, 15325.923370383076, 15491.457798977208, 23967.52064958691, 24026.87986560056, 24057.27828165123, 24132.276031719077, 24137.396565085663, 10454.63408780689, 10579.84130238047, 10610.681679549625, 10649.733756656145, 10763.3541987481, 8332.33341332692, 9841.163501102343, 9906.257030722725, 9909.0, 9961.501924903725, 8104.351651867836, 9096.590653420611, 9250.95374523123, 9264.39781414206, 9278.211352035018, 2638.5039822235613, 2649.7217792131933, 2660.3349162709324, 2814.3949050954143, 2869.741723244918, 943.2218419803552, 970.3547141151197, 970.84466485362, 978.1001478639669, 985.7437066362797, 19900.303489377802, 19920.0, 19943.900280498794, 20273.29043483471, 20517.281895133598, 1017.8829434614966, 1025.9281850270559, 1029.8712660917386, 1042.6402891002592, 1043.3635482355758, 11113.11095112389, 11124.332540047622, 11160.218784685156, 11184.608538701106, 11266.943665281786, 533145.0, 538471.0, 539554.0, 545683.0, 546658.0, 107919.46040269906, 113823.43088284506, 118267.0, 118348.0, 118955.0, 1199.6700907250402, 1215.1736818963013, 1219.890209881115, 1222.3399364343334, 1227.7176249462495, 17868.821311786716, 17968.73046904271, 18025.819741802938, 18037.278508859497, 18306.0, 54172.72913635564, 54230.728846355516, 55713.72143139259, 56406.15390769224, 56409.74361025513, 66655.66672166609, 67862.3213767856, 68713.65643171752, 68954.0, 69471.65264173849, 12499.75000500003, 12563.037156381912, 14860.85139148638, 15075.170865602497, 15100.0, 23550.17574384957, 23663.408414789767, 23892.641610376206, 23899.761002389754, 24049.278521644377, 18375.264989400275, 18837.15232814554, 18872.433826985212, 18940.905295473436, 19045.61908761845, 16559.83440165583, 16883.40908068212, 17245.137743112544, 17276.13619319004, 17430.477085686944, 18752.718709219647, 18823.529411764815, 18918.716219256446, 19236.326728564432, 19405.4178374649, 14791.630209244424, 14911.17988510599, 14912.105273683614, 14914.403423862925, 14915.030523015968, 18208.180631871863, 18442.907785460986, 18446.446606601825, 18486.075696215405, 18586.628267434848], "value": 12082.099873201396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.821284126643, 1349.2174538767515, 1363.4546181527394, 1377.5178687459384, 1383.6471699716574, 13832.446702131916, 14299.428022879072, 14336.354864031118, 14352.067115637503, 14476.2761861907, 14323.57029289123, 14575.635609109777, 14594.708105837877, 14623.195724235164, 14627.926860365684, 2671.412289296352, 2710.227585138236, 2712.22701530064, 2712.471068141703, 2715.022591866926, 2611.647427597269, 2786.651668541432, 2791.1207969489647, 2796.5106106431394, 2797.8880844766286, 2739.5479745841913, 2746.807723459359, 2770.9584356234673, 2772.7781777457753, 2775.528160212769, 2668.4663067386505, 2673.1980405878353, 2698.9743897318895, 2710.783137349017, 2730.6177135200987, 2569.0622922633293, 2603.5313643544155, 2604.609308603706, 2605.4268061026546, 2606.0357667662897, 14154.796842268419, 14166.220857852813, 14223.573292801233, 14260.35828387725, 14331.42674293027, 7536.133344665379, 7794.532328060334, 7892.0529536455415, 7903.723369682091, 7905.446618736691, 4949.133901567247, 5151.896962060775, 5183.714895680736, 5213.113770658959, 5217.869553261161, 1779.644071185768, 1807.5300421890404, 1808.5478630342413, 1860.8046155153784, 1886.556659185104, 22902.427439313982, 23173.420664483354, 23198.884005579865, 23219.53560928789, 23246.76753232463, 6521.08704781331, 6545.639989800607, 6677.699503522354, 6743.696533655997, 6804.897926531106, 16111.677766444605, 16157.838421615634, 16267.0, 16307.673846523241, 16325.755113673304, 7555.962220188974, 7750.883736743954, 7752.26353496417, 7756.728514501965, 7757.26306000929, 7137.643117844191, 7179.138503379628, 7279.490435669558, 7310.342069213796, 7316.487845850739, 4974.427940786856, 5104.0, 5126.410462796752, 5212.478752124833, 5233.267342572043, 1511.1839606612307, 1524.0322395278856, 1528.99235503824, 1545.2275056465994, 1558.3844381469255, 892.3708785306344, 912.397817440486, 925.1442415765524, 926.6154545863526, 935.7426707655313, 7570.621468926642, 7589.316961473494, 7655.57894315818, 7659.731909383145, 7688.308052275322, 686.7630667419733, 704.9577025378494, 716.7133146741345, 725.1551941987631, 731.1336066760905, 4401.427814384109, 4535.115652447807, 4554.590086892129, 4583.381243532081, 4629.3518907353, 18885.0, 19726.408207753502, 19876.204951802054, 19894.104765285596, 20186.19255229804, 18604.025910012086, 18697.81302186988, 19298.71051934222, 19411.708824367644, 19448.70826937597, 10700.732481688021, 10810.135189184846, 10886.129109671207, 10889.509972051277, 10902.182336324808, 8175.0, 8253.463524870864, 8317.168283171635, 8374.120717324593, 8392.28665563434, 16664.25010874538, 16764.32942682328, 16946.491605251864, 17025.829741702426, 17049.829501704826, 17481.82518174853, 17516.562085947953, 17606.82393176103, 17619.55951101233, 17737.645247095243, 10526.10528105089, 10677.359358438518, 11552.191346605658, 12026.75946481083, 12140.635780926586, 13444.932775336452, 13505.189688618322, 13507.729845403233, 13569.118007329493, 13586.524471643444, 11132.109431245643, 11196.160287978271, 11325.773484530428, 11331.886681133083, 11406.942965285121, 10497.632582859564, 10529.4735263235, 10569.682909512727, 10827.458627068772, 10949.288296260718, 9582.0, 9690.321677482509, 9710.854337185088, 9715.902840971783, 9770.071843174886, 6989.825254368681, 7006.894896576454, 7051.1186101737285, 7057.541259818096, 7108.431325493844, 7162.212156662658, 7223.819404514719, 7247.456440766858, 7253.709851606088, 7289.635518223961], "value": 6387.314267340828, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3653470478012, 499.71878375217153, 514.3442111308084, 527.1854984049643, 530.8991291654586, 6180.412860778224, 6214.285357183925, 6282.246130464345, 6316.241836107509, 6376.394242546962, 5942.940570594293, 6038.245219347582, 6044.546659000571, 6074.422929821671, 6170.7223174957235, 4844.5155484451625, 4882.707037577739, 4921.80312787488, 4930.556249937505, 4950.90098198035, 4903.901921961558, 4922.950770492285, 4945.802167913279, 4966.726830024347, 4981.626378021645, 4685.344051832729, 4879.6828206166665, 4897.461279259279, 4898.951010489903, 4933.7533123343865, 4855.684380515255, 4866.635002374836, 4879.852864739503, 4889.315495830587, 4908.9263661045115, 4384.320430333303, 4417.779111044467, 4432.027747652296, 4445.0, 4468.151051300275, 6100.145979562864, 6134.539909506805, 6145.0, 6180.81457556274, 6193.349698281706, 5613.410591887834, 5627.662340259598, 5641.238432811559, 5645.0, 5659.4340565943485, 6435.6782160892235, 6452.193475815523, 6474.255460621995, 6548.214214294315, 6567.967160164217, 4747.7626118693925, 4773.689710168863, 4809.519048095198, 4813.326134341195, 4840.394950631171, 6846.4522838172825, 6880.449564034865, 6943.72225111, 6960.79117626472, 7024.473164512682, 4939.925901111486, 4955.959248557843, 4956.628252881048, 4964.205727083649, 4970.776315065831, 4990.725510096907, 5002.849914502571, 5030.89938201234, 5031.465403052104, 5041.697498150123, 5605.32736071674, 5646.350669672958, 5655.943440565624, 5677.858053548612, 5703.315602127771, 6498.38265364799, 6564.063601237646, 6582.407583317525, 6596.901046484307, 6607.603543787388, 1642.7371620540657, 1680.3614626442118, 1710.3757128647953, 1711.0076155829588, 1741.651669666072, 1178.1105265524475, 1191.112621097288, 1199.9700007499882, 1210.8244304575787, 1228.74054094552, 5684.857878552986, 5691.430856914359, 5699.401562835926, 5744.885102297931, 5796.101604251347, 6431.324710905381, 6679.165104361955, 6682.532222744361, 6738.59568425896, 6777.0, 5698.458646428583, 5729.512991395694, 5739.741711622987, 5741.19623252745, 5791.797287094932, 3518.9824050879583, 3567.9643203568153, 3616.2044350242904, 3638.5451818522683, 3640.472131540912, 6519.445847102955, 6534.575252608565, 6558.704858281389, 6620.602763834186, 6626.536142470077, 6913.619750913647, 6922.2731613180895, 6963.373296403348, 6979.965100174467, 7002.894956575656, 6541.640209788412, 6562.343765623399, 6578.177727784123, 6578.572392794453, 6603.240627327918, 6718.0, 6728.73085076611, 6737.359950804862, 6852.760153394607, 6874.793756187322, 6642.568233064835, 6690.330966903271, 6712.2616512184595, 6727.192736871607, 6745.2242992056545, 6504.38208370223, 6523.445507131947, 6532.085508028785, 6543.116679248241, 6549.24683661385, 4911.115999120193, 4930.383702037246, 4945.554900059012, 4954.5540901319055, 4979.829740011022, 6669.4997875160525, 6714.294999025032, 6719.832004199934, 6796.35434633709, 6838.350356716104, 6481.740730370732, 6511.153550038464, 6519.4784417245555, 6564.113844631104, 6603.669816509059, 6343.90484142729, 6472.320406357453, 6551.541392102507, 6565.80302590923, 6588.472922166119, 6185.84535386619, 6295.779647712308, 6403.8719225614295, 6405.583637063576, 6460.834191246349, 6374.840628984312, 6399.712012959521, 6430.517711171775, 6540.345965403421, 6546.705398256994, 6252.249730032425, 6264.906026409516, 6281.403266689657, 6324.588901721373, 6348.0], "value": 5030.131303975161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.0612357025124, 905.2260317428603, 914.0904799724274, 916.3631276262992, 916.7433118726759, 18952.0, 19735.802641973576, 19739.802601973977, 19773.40679779607, 22402.551948961012, 21341.146354145854, 21707.891460542676, 21836.126554937782, 21999.34001979939, 22110.778892211114, 1031.8503816946557, 1046.6546039806883, 1048.1981284317465, 1058.3544038136731, 1059.523214553454, 1026.8767747870265, 1037.1702637889696, 1043.0716662170673, 1045.0751085289535, 1049.2864851900704, 1118.4407796101948, 1122.876483586809, 1123.2754873106883, 1123.8876112388778, 1124.2242852431796, 1115.6987613344352, 1117.3463523838564, 1119.160629527854, 1124.213050864394, 1125.4991528769701, 817.8650522663753, 819.49191501269, 819.5533434278333, 821.6713314674118, 823.1069289820551, 19575.314863979835, 20139.093740781555, 20176.596468070704, 20272.49318767028, 20300.289489867784, 19369.22523099074, 19472.80527194724, 19634.116464758976, 20001.499962500908, 20070.397888063235, 16604.83395166045, 16910.323587056504, 16951.91524042384, 17085.82914170855, 17182.398616048504, 3649.835757390897, 3678.779273243614, 3679.2641471705765, 3679.908002299937, 3680.815959202056, 126246.0, 126418.36790815987, 127049.36475317564, 127702.36148819196, 129737.0, 17132.914335428493, 17158.142092895305, 17327.306907723803, 17465.08379888253, 17492.737608935877, 31139.688603114133, 31421.214469637984, 31511.684883150876, 31642.367152656818, 32011.679883201337, 7512.136104347961, 7932.286094251545, 8554.18735220153, 8603.440776349516, 9079.909200907907, 4108.424820525129, 4173.561776013536, 4203.600657937491, 4212.705110642226, 4224.746515209097, 4948.703077815343, 5040.143175660147, 5048.697078175322, 5107.87230319245, 5122.078025955289, 955.8040601676639, 966.917811985989, 975.0493269062607, 979.4417182206074, 982.2485798364257, 679.3172861274387, 690.1063123255396, 690.3372762148293, 699.3111784891878, 704.4188544450849, 11690.532378704756, 12243.632691019284, 12409.875901241052, 12415.44130514129, 12870.0, 683.1324218242804, 686.6326515314283, 696.8571442854203, 712.0245263988369, 712.1311999360771, 5694.259746232963, 5734.741936612779, 5785.0454674978155, 5895.056790913433, 5963.731632076567, 112368.0, 114685.4265728666, 116538.41730791293, 116863.0, 117894.0, 101510.0, 103526.48236758918, 104760.47619761853, 105714.99999999846, 109268.0, 88000.5599971996, 88211.55894220616, 88436.5578172105, 90531.54734226418, 92631.53684231536, 11147.442627868411, 12756.48974041065, 12922.547710830077, 13302.268375239455, 13553.661158471117, 40651.0, 40752.0, 41377.586224137376, 41559.376609351486, 42727.3590896143, 72588.27411725814, 73919.0, 75162.24837751553, 77848.61075694585, 78295.21704782879, 15493.457728979432, 18937.242510299435, 18996.905015474833, 19968.20127194954, 19987.60024799525, 19158.521036974187, 19187.520311992314, 20165.899170504053, 21537.0, 22706.886465567568, 19214.711779323043, 19331.226750929804, 19858.304959326353, 19977.800221997593, 20041.699374509684, 16840.9895406276, 17060.74408883843, 17154.142292885055, 17755.55611109681, 18190.272389104815, 16852.241649125575, 17003.149842507577, 18483.72274415858, 18873.245070197037, 19300.324488643393, 14526.346314416089, 14822.555323340317, 14852.925735371255, 14946.327415266122, 15033.548993530212, 14913.701725965202, 15000.149433646358, 15076.321565529797, 15086.471973480875, 15193.392264309305], "value": 9396.254645714003, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 104.0, 108.0, 108.0, 116.0, 110.0, 99.0, 112.0, 106.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 154.0, 176.0, 117.0, 149.0, 147.0, 124.0, 171.0, 121.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 164.0, 165.0, 162.0, 167.0, 172.0, 163.0, 162.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 177.0, 76.0, 79.0, 73.0, 77.0, 178.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 132.0, 80.0, 79.0, 78.0, 125.0, 79.0, 78.0, 128.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 117.0, 117.0, 117.0, 116.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 151.0, 151.0, 150.0, 151.0, 150.0, 159.0, 150.0, 152.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 103.0, 93.0, 95.0, 98.0, 97.0, 94.0, 97.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 56.0, 53.0, 53.0, 52.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 59.0, 54.0, 55.0, 55.0, 59.0, 55.0, 54.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 79.0, 76.0, 78.0, 85.0, 75.0, 77.0, 81.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 129.0, 120.0, 120.0, 125.0, 128.0, 120.0, 125.0, 165.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 169.0, 183.0, 187.0, 189.0, 184.0, 189.0, 178.0, 176.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 67.0, 67.0, 70.0, 72.0, 75.0, 67.0, 68.0], "value": 69.8, "unit": "score"}]}]} 11:15:05 INFO - Return code: 0 11:15:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:15:05 INFO - # TBPL SUCCESS # 11:15:05 INFO - Running post-action listener: _package_coverage_data 11:15:05 INFO - Running post-action listener: _resource_record_post_action 11:15:05 INFO - [mozharness: 2017-08-19 18:15:05.216775Z] Finished run-tests step (success) 11:15:05 INFO - Running post-run listener: _resource_record_post_run 11:15:05 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 221184; Write bytes: 446754816; Read time: 668; Write time: 344172 11:15:05 INFO - TinderboxPrint: CPU usage
13.2% 11:15:05 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 668 11:15:05 INFO - TinderboxPrint: I/O write bytes / time
446,754,816 / 344,172 11:15:05 INFO - TinderboxPrint: CPU idle
8,258.7 (86.8%) 11:15:05 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 11:15:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:15:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118575104; Read time: 324; Write time: 129852 11:15:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:15:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 212992; Write bytes: 327532544; Read time: 332; Write time: 214288 11:15:05 INFO - Running post-run listener: _upload_blobber_files 11:15:05 INFO - Blob upload gear active. 11:15:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:15:05 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 11:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:15:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:12 INFO - (blobuploader) - INFO - Done attempting. 11:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:12 INFO - (blobuploader) - INFO - Done attempting. 11:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:14 INFO - (blobuploader) - INFO - Done attempting. 11:15:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:15:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:14 INFO - (blobuploader) - INFO - Done attempting. 11:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:15:14 INFO - Return code: 0 11:15:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/570d2536c57ebe493431feec6b867202911a26c2f1e5f73225198b97d3981864f7baa0d2f6f412c448153f1f441b83aa23cae3334df44e3399922ffae84cd0f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c744547f976cda2ec075536125f560d7f0ab8ad6a3aa10c6d273c922606544eaf09a1f9664a214f4d7ea30d4c1c5b4c8553473180c0303d72c1e0b2be44bc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f612f08611313183a00ea2ea85758660b541297d13332cdbb64b5d9612db512418d6951f6924426e17df9458980902c39294406ec8d7cac155131fde37876ba6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/024b694fdeb78b778238bf50dd72bfbfc21004427c0e0319e93fba066c44e133ae4fd18b218d2ab3b275d39eb72151b0725dd2e6f620dc6615fbd948358d2f4b"} 11:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:15:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:15:14 INFO - Contents: 11:15:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/570d2536c57ebe493431feec6b867202911a26c2f1e5f73225198b97d3981864f7baa0d2f6f412c448153f1f441b83aa23cae3334df44e3399922ffae84cd0f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c744547f976cda2ec075536125f560d7f0ab8ad6a3aa10c6d273c922606544eaf09a1f9664a214f4d7ea30d4c1c5b4c8553473180c0303d72c1e0b2be44bc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f612f08611313183a00ea2ea85758660b541297d13332cdbb64b5d9612db512418d6951f6924426e17df9458980902c39294406ec8d7cac155131fde37876ba6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/024b694fdeb78b778238bf50dd72bfbfc21004427c0e0319e93fba066c44e133ae4fd18b218d2ab3b275d39eb72151b0725dd2e6f620dc6615fbd948358d2f4b"} 11:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:15:14 INFO - Copying logs to upload dir... 11:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.839374 ========= master_lag: -0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-19 11:15:14.673417) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 11:15:14.679863) ========= 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=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/570d2536c57ebe493431feec6b867202911a26c2f1e5f73225198b97d3981864f7baa0d2f6f412c448153f1f441b83aa23cae3334df44e3399922ffae84cd0f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c744547f976cda2ec075536125f560d7f0ab8ad6a3aa10c6d273c922606544eaf09a1f9664a214f4d7ea30d4c1c5b4c8553473180c0303d72c1e0b2be44bc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f612f08611313183a00ea2ea85758660b541297d13332cdbb64b5d9612db512418d6951f6924426e17df9458980902c39294406ec8d7cac155131fde37876ba6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/024b694fdeb78b778238bf50dd72bfbfc21004427c0e0319e93fba066c44e133ae4fd18b218d2ab3b275d39eb72151b0725dd2e6f620dc6615fbd948358d2f4b"} build_url:https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/EtAI5-StRyCj0OxT7-pNYg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/570d2536c57ebe493431feec6b867202911a26c2f1e5f73225198b97d3981864f7baa0d2f6f412c448153f1f441b83aa23cae3334df44e3399922ffae84cd0f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c744547f976cda2ec075536125f560d7f0ab8ad6a3aa10c6d273c922606544eaf09a1f9664a214f4d7ea30d4c1c5b4c8553473180c0303d72c1e0b2be44bc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f612f08611313183a00ea2ea85758660b541297d13332cdbb64b5d9612db512418d6951f6924426e17df9458980902c39294406ec8d7cac155131fde37876ba6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/024b694fdeb78b778238bf50dd72bfbfc21004427c0e0319e93fba066c44e133ae4fd18b218d2ab3b275d39eb72151b0725dd2e6f620dc6615fbd948358d2f4b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 11:15:14.709542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:15:14.709881) ========= 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=32c5991c409366f7fec8a718000001d2-1503163276.717850-1193425679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 11:15:14.790191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 11:15:14.793515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 11:15:14.793811) ========= ========= Total master_lag: -0.05 =========