builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1504224676.38 results: success (0) revision: 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.375688) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.376130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.376411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.550531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.550827) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 17:11:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2017-08-31 17:11:16 (43.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145577 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.742215) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.742541) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:16.790947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-31 17:11:16.791256) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 --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 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 --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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 17:11:16,951 truncating revision to first 12 chars 2017-08-31 17:11:16,952 Setting DEBUG logging. 2017-08-31 17:11:16,952 attempt 1/10 2017-08-31 17:11:16,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/14eea6bedcf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 17:11:17,391 attempt 1/10 2017-08-31 17:11:18,320 current task status: no status available at this point. state: STARTED 2017-08-31 17:11:18,321 sleeping for 10.00s (attempt 1/10) 2017-08-31 17:11:28,331 attempt 2/10 2017-08-31 17:11:28,670 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-31 17:11:28,894 unpacking tar archive at: mozilla-central-14eea6bedcf3/testing/mozharness/ program finished with exit code 0 elapsedTime=12.252141 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-31 17:11:29.071447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:29.074794) ========= script_repo_revision: 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:29.075182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:29.075451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 17:11:29.087433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-31 17:11:29.087742) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:29 INFO - MultiFileLogger online at 20170831 17:11:29 in /builds/slave/test 17:11:29 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 17:11:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:29 INFO - {'append_to_log': False, 17:11:29 INFO - 'base_work_dir': '/builds/slave/test', 17:11:29 INFO - 'blob_upload_branch': 'Firefox', 17:11:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:29 INFO - 'branch': 'Firefox', 17:11:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:29 INFO - 'code_coverage': False, 17:11:29 INFO - 'config_files': ('talos/linux_config.py',), 17:11:29 INFO - 'default_actions': ('clobber', 17:11:29 INFO - 'read-buildbot-config', 17:11:29 INFO - 'download-and-extract', 17:11:29 INFO - 'populate-webroot', 17:11:29 INFO - 'create-virtualenv', 17:11:29 INFO - 'install', 17:11:29 INFO - 'setup-mitmproxy', 17:11:29 INFO - 'run-tests'), 17:11:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:29 INFO - 'disable_ccov_upload': False, 17:11:29 INFO - 'disable_stylo': False, 17:11:29 INFO - 'download_minidump_stackwalk': True, 17:11:29 INFO - 'download_symbols': 'ondemand', 17:11:29 INFO - 'enable_stylo': False, 17:11:29 INFO - 'enable_webrender': False, 17:11:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:11:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:29 INFO - 'gecko_profile': False, 17:11:29 INFO - 'gecko_profile_interval': 0, 17:11:29 INFO - 'installer_path': 'installer.exe', 17:11:29 INFO - 'log_level': 'info', 17:11:29 INFO - 'log_name': 'talos', 17:11:29 INFO - 'log_to_console': True, 17:11:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:29 INFO - 'opt_config_files': (), 17:11:29 INFO - 'pip_index': False, 17:11:29 INFO - 'suite': 'dromaeojs-e10s', 17:11:29 INFO - 'system_bits': '32', 17:11:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:29 INFO - 'title': 'talos-linux64-ix-012', 17:11:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:29 INFO - 'use_talos_json': True, 17:11:29 INFO - 'verify': 'False', 17:11:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:29 INFO - 'work_dir': 'build'} 17:11:29 INFO - [mozharness: 2017-09-01 00:11:29.377752Z] Running clobber step. 17:11:29 INFO - Running pre-action listener: _resource_record_pre_action 17:11:29 INFO - Running main action method: clobber 17:11:29 INFO - rmtree: /builds/slave/test/build 17:11:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:30 INFO - Running post-action listener: _resource_record_post_action 17:11:30 INFO - [mozharness: 2017-09-01 00:11:30.396560Z] Finished clobber step (success) 17:11:30 INFO - [mozharness: 2017-09-01 00:11:30.396658Z] Running read-buildbot-config step. 17:11:30 INFO - Running pre-action listener: _resource_record_pre_action 17:11:30 INFO - Running main action method: read_buildbot_config 17:11:30 INFO - Using buildbot properties: 17:11:30 INFO - { 17:11:30 INFO - "project": "", 17:11:30 INFO - "product": "firefox", 17:11:30 INFO - "who": "kwierso@gmail.com", 17:11:30 INFO - "installer_path": "public/build/target.tar.bz2", 17:11:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:11:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:11:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:11:30 INFO - "stage_platform": "linux64-stylosequential", 17:11:30 INFO - "basedir": "/builds/slave/test", 17:11:30 INFO - "buildnumber": 53, 17:11:30 INFO - "platform": "ubuntu64_hw_styloseq", 17:11:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:11:30 INFO - "slavebuilddir": "test", 17:11:30 INFO - "taskId": "MW58Z8hBSfSvDaJtTC8QRw", 17:11:30 INFO - "branch": "mozilla-central", 17:11:30 INFO - "script_repo_revision": "production", 17:11:30 INFO - "revision": "14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0", 17:11:30 INFO - "slavename": "talos-linux64-ix-012", 17:11:30 INFO - "repo_path": "mozilla-central" 17:11:30 INFO - } 17:11:30 INFO - Finding installer, test and symbols from parent task. 17:11:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MW58Z8hBSfSvDaJtTC8QRw'}, attempt #1 17:11:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MW58Z8hBSfSvDaJtTC8QRw'}, attempt #1 17:11:31 INFO - Task dependencies: VwskOH_MSgKsTQf61Zi0cg 17:11:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg'}, attempt #1 17:11:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 17:11:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.test_packages.json 17:11:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.crashreporter-symbols.zip 17:11:31 INFO - Running post-action listener: _resource_record_post_action 17:11:31 INFO - [mozharness: 2017-09-01 00:11:31.745650Z] Finished read-buildbot-config step (success) 17:11:31 INFO - [mozharness: 2017-09-01 00:11:31.745869Z] Running download-and-extract step. 17:11:31 INFO - Running pre-action listener: _resource_record_pre_action 17:11:31 INFO - Running main action method: download_and_extract 17:11:31 INFO - mkdir: /builds/slave/test/build/tests 17:11:31 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')]} 17:11:31 INFO - trying https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.test_packages.json 17:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:11:32 INFO - Downloaded 989 bytes. 17:11:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:11:32 INFO - Using the following test package requirements: 17:11:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:11:32 INFO - u'common': [u'target.common.tests.zip'], 17:11:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:11:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:11:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:11:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:11:32 INFO - u'mozbase': [u'target.common.tests.zip'], 17:11:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:11:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:11:32 INFO - u'web-platform': [u'target.common.tests.zip', 17:11:32 INFO - u'target.web-platform.tests.tar.gz'], 17:11:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:11:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:11:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip 17:11:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:11:32 INFO - Fetch https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip into memory 17:11:33 INFO - Content-Length response header: 54933712 17:11:33 INFO - Bytes received: 54933712 17:11:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip 17:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.common.tests.zip into memory 17:11:45 INFO - Content-Length response header: 54933712 17:11:45 INFO - Bytes received: 54933712 17:11:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.talos.tests.zip 17:11:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:11:57 INFO - Fetch https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.talos.tests.zip into memory 17:11:58 INFO - Content-Length response header: 14496650 17:11:58 INFO - Bytes received: 14496650 17:11: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')]} 17:11:58 INFO - trying https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 17:11:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:11:59 INFO - Downloaded 62603869 bytes. 17:11:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 17:11:59 INFO - mkdir: /builds/slave/test/properties 17:11:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:59 INFO - Contents: 17:11:59 INFO - build_url:https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 17:11:59 INFO - Running post-action listener: _resource_record_post_action 17:11:59 INFO - Running post-action listener: find_tests_for_verification 17:11:59 INFO - Running post-action listener: set_extra_try_arguments 17:11:59 INFO - [mozharness: 2017-09-01 00:11:59.959752Z] Finished download-and-extract step (success) 17:11:59 INFO - [mozharness: 2017-09-01 00:11:59.959869Z] Running populate-webroot step. 17:11:59 INFO - Running pre-action listener: _resource_record_pre_action 17:11:59 INFO - Running main action method: populate_webroot 17:11:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:59 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:59 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:59 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'tests': ['damp', 'tps']}, 17:11:59 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['damp', 'tps']}, 17:11:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:11:59 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:11:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:11:59 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:11:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:59 INFO - 'ts_paint', 17:11:59 INFO - 'tpaint', 17:11:59 INFO - 'sessionrestore', 17:11:59 INFO - 'sessionrestore_many_windows', 17:11:59 INFO - 'sessionrestore_no_auto_restore', 17:11:59 INFO - 'tabpaint']}, 17:11:59 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['a11yr', 17:11:59 INFO - 'ts_paint', 17:11:59 INFO - 'tpaint', 17:11:59 INFO - 'sessionrestore', 17:11:59 INFO - 'sessionrestore_many_windows', 17:11:59 INFO - 'sessionrestore_no_auto_restore', 17:11:59 INFO - 'tabpaint']}, 17:11:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:11:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:11:59 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['bloom_basic_singleton']}, 17:11:59 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['bloom_basic']}, 17:11:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:59 INFO - 'tsvgr_opacity', 17:11:59 INFO - 'tart', 17:11:59 INFO - 'tscrollx', 17:11:59 INFO - 'tsvg_static']}, 17:11:59 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['tsvgx', 17:11:59 INFO - 'tsvgr_opacity', 17:11:59 INFO - 'tart', 17:11:59 INFO - 'tscrollx', 17:11:59 INFO - 'tsvg_static']}, 17:11:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:11:59 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo'], 17:11:59 INFO - 'tests': ['tp5o']}, 17:11:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:59 INFO - 'talos_options': ['--mitmproxy', 17:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:59 INFO - '--firstNonBlankPaint'], 17:11:59 INFO - 'tests': ['tp6_google', 17:11:59 INFO - 'tp6_youtube', 17:11:59 INFO - 'tp6_amazon', 17:11:59 INFO - 'tp6_facebook']}, 17:11:59 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo', 17:11:59 INFO - '--mitmproxy', 17:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:59 INFO - '--firstNonBlankPaint'], 17:11:59 INFO - 'tests': ['tp6_google', 17:11:59 INFO - 'tp6_youtube', 17:11:59 INFO - 'tp6_amazon', 17:11:59 INFO - 'tp6_facebook']}, 17:11:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo', 17:11:59 INFO - '--stylo-threads=1', 17:11:59 INFO - '--mitmproxy', 17:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:11:59 INFO - '--firstNonBlankPaint'], 17:11:59 INFO - 'tests': ['tp6_google', 17:11:59 INFO - 'tp6_youtube', 17:11:59 INFO - 'tp6_amazon', 17:11:59 INFO - 'tp6_facebook']}, 17:11:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--xperf_path', 17:11:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:59 INFO - 'tests': ['tp5n']}, 17:11:59 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:11:59 INFO - 'talos_options': ['--enable-stylo', 17:11:59 INFO - '--xperf_path', 17:11:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:59 INFO - 'tests': ['tp5n']}}} 17:11:59 INFO - Running post-action listener: _resource_record_post_action 17:11:59 INFO - [mozharness: 2017-09-01 00:11:59.974262Z] Finished populate-webroot step (success) 17:11:59 INFO - [mozharness: 2017-09-01 00:11:59.974351Z] Running create-virtualenv step. 17:11:59 INFO - Running pre-action listener: _resource_record_pre_action 17:11:59 INFO - Running main action method: create_virtualenv 17:11:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:59 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:11:59 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:11:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:12:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:00 INFO - Installing pip...............done. 17:12:00 INFO - Return code: 0 17:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:12:00 INFO - Reading from file tmpfile_stdout 17:12:00 INFO - Output received: 17:12:00 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:12:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12: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')]} 17:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12: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', 'pip>=1.5'] in /builds/slave/test/build 17:12: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 pip>=1.5 17:12:00 INFO - Using env: {'DISPLAY': ':0', 17:12:00 INFO - 'HOME': '/home/cltbld', 17:12:00 INFO - 'LANG': 'en_US.UTF-8', 17:12:00 INFO - 'LANGUAGE': 'en_US:en', 17:12:00 INFO - 'LOGNAME': 'cltbld', 17:12:00 INFO - 'MAIL': '/var/mail/cltbld', 17:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:00 INFO - 'MOZ_NO_REMOTE': '1', 17:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:00 INFO - 'NO_EM_RESTART': '1', 17:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:00 INFO - 'PWD': '/builds/slave/test', 17:12:00 INFO - 'SHELL': '/bin/bash', 17:12:00 INFO - 'SHLVL': '1', 17:12:00 INFO - 'TERM': 'linux', 17:12:00 INFO - 'TMOUT': '86400', 17:12:00 INFO - 'USER': 'cltbld', 17:12:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:00 INFO - '_': '/tools/buildbot/bin/python'} 17:12:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:12:02 INFO - Downloading/unpacking pip>=1.5 17:12:02 INFO - Running setup.py egg_info for package pip 17:12:02 INFO - warning: no files found matching 'pip/cacert.pem' 17:12:02 INFO - warning: no files found matching '*.html' under directory 'docs' 17:12:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:12:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:12:02 INFO - Installing collected packages: pip 17:12:02 INFO - Found existing installation: pip 1.1 17:12:02 INFO - Uninstalling pip: 17:12:02 INFO - Successfully uninstalled pip 17:12:02 INFO - Running setup.py install for pip 17:12:02 INFO - warning: no files found matching 'pip/cacert.pem' 17:12:02 INFO - warning: no files found matching '*.html' under directory 'docs' 17:12:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:12:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:12:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:12:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:12:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:12:02 INFO - Successfully installed pip 17:12:02 INFO - Cleaning up... 17:12:02 INFO - Return code: 0 17:12:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12: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')]} 17:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:02 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 17:12:02 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 17:12:02 INFO - Using env: {'DISPLAY': ':0', 17:12:02 INFO - 'HOME': '/home/cltbld', 17:12:02 INFO - 'LANG': 'en_US.UTF-8', 17:12:02 INFO - 'LANGUAGE': 'en_US:en', 17:12:02 INFO - 'LOGNAME': 'cltbld', 17:12:02 INFO - 'MAIL': '/var/mail/cltbld', 17:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:02 INFO - 'MOZ_NO_REMOTE': '1', 17:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:02 INFO - 'NO_EM_RESTART': '1', 17:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:02 INFO - 'PWD': '/builds/slave/test', 17:12:02 INFO - 'SHELL': '/bin/bash', 17:12:02 INFO - 'SHLVL': '1', 17:12:02 INFO - 'TERM': 'linux', 17:12:02 INFO - 'TMOUT': '86400', 17:12:02 INFO - 'USER': 'cltbld', 17:12:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:02 INFO - '_': '/tools/buildbot/bin/python'} 17:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:02 INFO - Downloading/unpacking psutil>=3.1.1 17:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:03 INFO - Installing collected packages: psutil 17:12:03 INFO - Running setup.py install for psutil 17:12:03 INFO - building 'psutil._psutil_linux' extension 17:12:03 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 17:12:03 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 17:12:03 INFO - building 'psutil._psutil_posix' extension 17:12:03 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 17:12:04 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 17:12:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:04 INFO - Successfully installed psutil 17:12:04 INFO - Cleaning up... 17:12:04 INFO - Return code: 0 17:12:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:04 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 17:12:04 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 17:12:04 INFO - Using env: {'DISPLAY': ':0', 17:12:04 INFO - 'HOME': '/home/cltbld', 17:12:04 INFO - 'LANG': 'en_US.UTF-8', 17:12:04 INFO - 'LANGUAGE': 'en_US:en', 17:12:04 INFO - 'LOGNAME': 'cltbld', 17:12:04 INFO - 'MAIL': '/var/mail/cltbld', 17:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:04 INFO - 'MOZ_NO_REMOTE': '1', 17:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:04 INFO - 'NO_EM_RESTART': '1', 17:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:04 INFO - 'PWD': '/builds/slave/test', 17:12:04 INFO - 'SHELL': '/bin/bash', 17:12:04 INFO - 'SHLVL': '1', 17:12:04 INFO - 'TERM': 'linux', 17:12:04 INFO - 'TMOUT': '86400', 17:12:04 INFO - 'USER': 'cltbld', 17:12:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:04 INFO - '_': '/tools/buildbot/bin/python'} 17:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:05 INFO - Installing collected packages: mozsystemmonitor 17:12:05 INFO - Running setup.py install for mozsystemmonitor 17:12:05 INFO - Successfully installed mozsystemmonitor 17:12:05 INFO - Cleaning up... 17:12:05 INFO - Return code: 0 17:12:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12: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')]} 17:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:05 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 17:12:05 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 17:12:05 INFO - Using env: {'DISPLAY': ':0', 17:12:05 INFO - 'HOME': '/home/cltbld', 17:12:05 INFO - 'LANG': 'en_US.UTF-8', 17:12:05 INFO - 'LANGUAGE': 'en_US:en', 17:12:05 INFO - 'LOGNAME': 'cltbld', 17:12:05 INFO - 'MAIL': '/var/mail/cltbld', 17:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:05 INFO - 'MOZ_NO_REMOTE': '1', 17:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:05 INFO - 'NO_EM_RESTART': '1', 17:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:05 INFO - 'PWD': '/builds/slave/test', 17:12:05 INFO - 'SHELL': '/bin/bash', 17:12:05 INFO - 'SHLVL': '1', 17:12:05 INFO - 'TERM': 'linux', 17:12:05 INFO - 'TMOUT': '86400', 17:12:05 INFO - 'USER': 'cltbld', 17:12:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:05 INFO - '_': '/tools/buildbot/bin/python'} 17:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:05 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 17:12:05 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 17:12:05 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 17:12:05 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 17:12:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12: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 17:12: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 17:12: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 17:12: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 17:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:07 INFO - warning: no files found matching '*.txt' 17:12:07 INFO - no previously-included directories found matching 'build' 17:12:07 INFO - no previously-included directories found matching 'dist' 17:12:07 INFO - no previously-included directories found matching '.git*' 17:12:07 INFO - Installing collected packages: jsonschema, functools32 17:12:07 INFO - Running setup.py install for functools32 17:12:07 INFO - warning: no files found matching '*.txt' 17:12:07 INFO - no previously-included directories found matching 'build' 17:12:07 INFO - no previously-included directories found matching 'dist' 17:12:07 INFO - no previously-included directories found matching '.git*' 17:12:07 INFO - Successfully installed jsonschema functools32 17:12:07 INFO - Cleaning up... 17:12:07 INFO - Return code: 0 17:12:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:12:07 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')]} 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:07 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')]} 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:07 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:07 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 17:12:07 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 17:12:07 INFO - Using env: {'DISPLAY': ':0', 17:12:07 INFO - 'HOME': '/home/cltbld', 17:12:07 INFO - 'LANG': 'en_US.UTF-8', 17:12:07 INFO - 'LANGUAGE': 'en_US:en', 17:12:07 INFO - 'LOGNAME': 'cltbld', 17:12:07 INFO - 'MAIL': '/var/mail/cltbld', 17:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:07 INFO - 'MOZ_NO_REMOTE': '1', 17:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:07 INFO - 'NO_EM_RESTART': '1', 17:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:07 INFO - 'PWD': '/builds/slave/test', 17:12:07 INFO - 'SHELL': '/bin/bash', 17:12:07 INFO - 'SHLVL': '1', 17:12:07 INFO - 'TERM': 'linux', 17:12:07 INFO - 'TMOUT': '86400', 17:12:07 INFO - 'USER': 'cltbld', 17:12:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:07 INFO - '_': '/tools/buildbot/bin/python'} 17:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:12:07 INFO - Cleaning up... 17:12:07 INFO - Return code: 0 17:12:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:07 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')]} 17:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:07 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')]} 17:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:07 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:07 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 17:12:07 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 17:12:07 INFO - Using env: {'DISPLAY': ':0', 17:12:07 INFO - 'HOME': '/home/cltbld', 17:12:07 INFO - 'LANG': 'en_US.UTF-8', 17:12:07 INFO - 'LANGUAGE': 'en_US:en', 17:12:07 INFO - 'LOGNAME': 'cltbld', 17:12:07 INFO - 'MAIL': '/var/mail/cltbld', 17:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:07 INFO - 'MOZ_NO_REMOTE': '1', 17:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:07 INFO - 'NO_EM_RESTART': '1', 17:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:07 INFO - 'PWD': '/builds/slave/test', 17:12:07 INFO - 'SHELL': '/bin/bash', 17:12:07 INFO - 'SHLVL': '1', 17:12:07 INFO - 'TERM': 'linux', 17:12:07 INFO - 'TMOUT': '86400', 17:12:07 INFO - 'USER': 'cltbld', 17:12:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:07 INFO - '_': '/tools/buildbot/bin/python'} 17:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:12: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 17:12: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 17:12: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 17:12: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 17:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12: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 17:12: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 17:12: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 17:12: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 17:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12: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 17:12: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 17:12: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 17:12: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 17:12:09 INFO - Downloading docopt-0.6.1.tar.gz 17:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:09 INFO - Running setup.py install for blobuploader 17:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:09 INFO - Running setup.py install for requests 17:12:09 INFO - Running setup.py install for docopt 17:12:10 INFO - Successfully installed blobuploader requests docopt 17:12:10 INFO - Cleaning up... 17:12:10 INFO - Return code: 0 17:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:10 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:10 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 17:12:10 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 17:12:10 INFO - Using env: {'DISPLAY': ':0', 17:12:10 INFO - 'HOME': '/home/cltbld', 17:12:10 INFO - 'LANG': 'en_US.UTF-8', 17:12:10 INFO - 'LANGUAGE': 'en_US:en', 17:12:10 INFO - 'LOGNAME': 'cltbld', 17:12:10 INFO - 'MAIL': '/var/mail/cltbld', 17:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:10 INFO - 'MOZ_NO_REMOTE': '1', 17:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:10 INFO - 'NO_EM_RESTART': '1', 17:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:10 INFO - 'PWD': '/builds/slave/test', 17:12:10 INFO - 'SHELL': '/bin/bash', 17:12:10 INFO - 'SHLVL': '1', 17:12:10 INFO - 'TERM': 'linux', 17:12:10 INFO - 'TMOUT': '86400', 17:12:10 INFO - 'USER': 'cltbld', 17:12:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:10 INFO - '_': '/tools/buildbot/bin/python'} 17:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:10 INFO - Running setup.py (path:/tmp/pip-7_k9QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:10 INFO - Running setup.py (path:/tmp/pip-x2QTKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:10 INFO - Running setup.py (path:/tmp/pip-JkUx7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:10 INFO - Running setup.py (path:/tmp/pip-nk3Lc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:10 INFO - Running setup.py (path:/tmp/pip-V_GcQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:10 INFO - Running setup.py (path:/tmp/pip-yWHNZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:10 INFO - Running setup.py (path:/tmp/pip-yC0p4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:10 INFO - Running setup.py (path:/tmp/pip-aVADLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:10 INFO - Running setup.py (path:/tmp/pip-oYiYqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:10 INFO - Running setup.py (path:/tmp/pip-GnHP8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:11 INFO - Running setup.py (path:/tmp/pip-cMQV71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:11 INFO - Running setup.py (path:/tmp/pip-0b4T2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:11 INFO - Running setup.py (path:/tmp/pip-fdDacT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:11 INFO - Running setup.py (path:/tmp/pip-DokXfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:11 INFO - Running setup.py (path:/tmp/pip-NGyu9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:11 INFO - Running setup.py (path:/tmp/pip-OMf2_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:11 INFO - Running setup.py (path:/tmp/pip-JXDLEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:11 INFO - Running setup.py install for manifestparser 17:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozcrash 17:12:11 INFO - Running setup.py install for mozdebug 17:12:11 INFO - Running setup.py install for mozdevice 17:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozfile 17:12:12 INFO - Running setup.py install for mozhttpd 17:12:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozinfo 17:12:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozInstall 17:12:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozleak 17:12:12 INFO - Running setup.py install for mozlog 17:12:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for moznetwork 17:12:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozprocess 17:12:12 INFO - Running setup.py install for mozprofile 17:12:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozrunner 17:12:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozscreenshot 17:12:13 INFO - Running setup.py install for moztest 17:12:13 INFO - Running setup.py install for mozversion 17:12:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:13 INFO - Cleaning up... 17:12:13 INFO - Return code: 0 17:12:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:13 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')]} 17:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:13 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')]} 17:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:13 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:13 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 17:12:13 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 17:12:13 INFO - Using env: {'DISPLAY': ':0', 17:12:13 INFO - 'HOME': '/home/cltbld', 17:12:13 INFO - 'LANG': 'en_US.UTF-8', 17:12:13 INFO - 'LANGUAGE': 'en_US:en', 17:12:13 INFO - 'LOGNAME': 'cltbld', 17:12:13 INFO - 'MAIL': '/var/mail/cltbld', 17:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:13 INFO - 'MOZ_NO_REMOTE': '1', 17:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:13 INFO - 'NO_EM_RESTART': '1', 17:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:13 INFO - 'PWD': '/builds/slave/test', 17:12:13 INFO - 'SHELL': '/bin/bash', 17:12:13 INFO - 'SHLVL': '1', 17:12:13 INFO - 'TERM': 'linux', 17:12:13 INFO - 'TMOUT': '86400', 17:12:13 INFO - 'USER': 'cltbld', 17:12:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:13 INFO - '_': '/tools/buildbot/bin/python'} 17:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:13 INFO - Running setup.py (path:/tmp/pip-u6ANGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:13 INFO - Running setup.py (path:/tmp/pip-2ZvciQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:13 INFO - Running setup.py (path:/tmp/pip-TQZ9hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:13 INFO - Running setup.py (path:/tmp/pip-8j2k3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:13 INFO - Running setup.py (path:/tmp/pip-ARyAkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:13 INFO - Running setup.py (path:/tmp/pip-KVk3xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:13 INFO - Running setup.py (path:/tmp/pip-RtY8i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:14 INFO - Running setup.py (path:/tmp/pip-MM3q9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:14 INFO - Running setup.py (path:/tmp/pip-5mqnPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:14 INFO - Running setup.py (path:/tmp/pip-t7fbX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:14 INFO - Running setup.py (path:/tmp/pip-gLJIrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:14 INFO - Running setup.py (path:/tmp/pip-vt70kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:14 INFO - Running setup.py (path:/tmp/pip-xJeh8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:14 INFO - Running setup.py (path:/tmp/pip-ZbzczB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:14 INFO - Running setup.py (path:/tmp/pip-UTKJRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:14 INFO - Running setup.py (path:/tmp/pip-gdY846-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:14 INFO - Running setup.py (path:/tmp/pip-lty6yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:14 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 17:12:14 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 17:12:14 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 17:12:14 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 17:12:15 INFO - Downloading blessings-1.6.tar.gz 17:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:15 INFO - Installing collected packages: blessings 17:12:15 INFO - Running setup.py install for blessings 17:12:15 INFO - Successfully installed blessings 17:12:15 INFO - Cleaning up... 17:12:16 INFO - Return code: 0 17:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:16 INFO - Reading from file tmpfile_stdout 17:12:16 INFO - Current package versions: 17:12:16 INFO - argparse == 1.2.1 17:12:16 INFO - blessings == 1.6 17:12:16 INFO - blobuploader == 1.2.4 17:12:16 INFO - docopt == 0.6.1 17:12:16 INFO - functools32 == 3.2.3-2 17:12:16 INFO - jsonschema == 2.5.1 17:12:16 INFO - manifestparser == 1.1 17:12:16 INFO - mozInstall == 1.13 17:12:16 INFO - mozcrash == 1.0 17:12:16 INFO - mozdebug == 0.1 17:12:16 INFO - mozdevice == 0.51 17:12:16 INFO - mozfile == 1.2 17:12:16 INFO - mozhttpd == 0.7 17:12:16 INFO - mozinfo == 0.10 17:12:16 INFO - mozleak == 0.1 17:12:16 INFO - mozlog == 3.5 17:12:16 INFO - moznetwork == 0.27 17:12:16 INFO - mozprocess == 0.25 17:12:16 INFO - mozprofile == 0.28 17:12:16 INFO - mozrunner == 6.13 17:12:16 INFO - mozscreenshot == 0.1 17:12:16 INFO - mozsystemmonitor == 0.3 17:12:16 INFO - moztest == 0.8 17:12:16 INFO - mozversion == 1.4 17:12:16 INFO - psutil == 3.1.1 17:12:16 INFO - requests == 1.2.3 17:12:16 INFO - wsgiref == 0.1.2 17:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:16 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')]} 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:16 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')]} 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:16 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:16 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 17:12:16 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 17:12:16 INFO - Using env: {'DISPLAY': ':0', 17:12:16 INFO - 'HOME': '/home/cltbld', 17:12:16 INFO - 'LANG': 'en_US.UTF-8', 17:12:16 INFO - 'LANGUAGE': 'en_US:en', 17:12:16 INFO - 'LOGNAME': 'cltbld', 17:12:16 INFO - 'MAIL': '/var/mail/cltbld', 17:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:16 INFO - 'MOZ_NO_REMOTE': '1', 17:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:16 INFO - 'NO_EM_RESTART': '1', 17:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:16 INFO - 'PWD': '/builds/slave/test', 17:12:16 INFO - 'SHELL': '/bin/bash', 17:12:16 INFO - 'SHLVL': '1', 17:12:16 INFO - 'TERM': 'linux', 17:12:16 INFO - 'TMOUT': '86400', 17:12:16 INFO - 'USER': 'cltbld', 17:12:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:16 INFO - '_': '/tools/buildbot/bin/python'} 17:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:12:16 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 17:12:16 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 17:12:16 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 17:12:16 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 17:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:12:18 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)) 17:12:18 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)) 17:12:18 INFO - Installing collected packages: simplejson 17:12:18 INFO - Running setup.py install for simplejson 17:12:18 INFO - building 'simplejson._speedups' extension 17:12:18 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 17:12:19 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 17:12:19 INFO - Successfully installed simplejson 17:12:19 INFO - Cleaning up... 17:12:19 INFO - Return code: 0 17:12:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:19 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')]} 17:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:19 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')]} 17:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:19 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 0xe181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1184a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', '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 17:12:19 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 17:12:19 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 17:12:19 INFO - Using env: {'DISPLAY': ':0', 17:12:19 INFO - 'HOME': '/home/cltbld', 17:12:19 INFO - 'LANG': 'en_US.UTF-8', 17:12:19 INFO - 'LANGUAGE': 'en_US:en', 17:12:19 INFO - 'LOGNAME': 'cltbld', 17:12:19 INFO - 'MAIL': '/var/mail/cltbld', 17:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:19 INFO - 'MOZ_NO_REMOTE': '1', 17:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:19 INFO - 'NO_EM_RESTART': '1', 17:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:19 INFO - 'PWD': '/builds/slave/test', 17:12:19 INFO - 'SHELL': '/bin/bash', 17:12:19 INFO - 'SHLVL': '1', 17:12:19 INFO - 'TERM': 'linux', 17:12:19 INFO - 'TMOUT': '86400', 17:12:19 INFO - 'USER': 'cltbld', 17:12:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:19 INFO - '_': '/tools/buildbot/bin/python'} 17:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:19 INFO - Cleaning up... 17:12:19 INFO - Return code: 0 17:12:19 INFO - Running post-action listener: _resource_record_post_action 17:12:19 INFO - Running post-action listener: _start_resource_monitoring 17:12:19 INFO - Starting resource monitoring. 17:12:19 INFO - [mozharness: 2017-09-01 00:12:19.969317Z] Finished create-virtualenv step (success) 17:12:19 INFO - [mozharness: 2017-09-01 00:12:19.969833Z] Running install step. 17:12:19 INFO - Running pre-action listener: _resource_record_pre_action 17:12:19 INFO - Running main action method: install 17:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:20 INFO - Reading from file tmpfile_stdout 17:12:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:20 INFO - Reading from file tmpfile_stdout 17:12:20 INFO - Output received: 17:12:20 INFO - Usage: mozinstall [options] installer 17:12:20 INFO - Options: 17:12:20 INFO - -h, --help show this help message and exit 17:12:20 INFO - -d DEST, --destination=DEST 17:12:20 INFO - Directory to install application into. [default: 17:12:20 INFO - "/builds/slave/test"] 17:12:20 INFO - --app=APP Application being installed. [default: firefox] 17:12:20 INFO - mkdir: /builds/slave/test/build/application 17:12:20 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'] 17:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:12:36 INFO - Reading from file tmpfile_stdout 17:12:36 INFO - Output received: 17:12:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:36 INFO - Running post-action listener: _resource_record_post_action 17:12:36 INFO - [mozharness: 2017-09-01 00:12:36.847163Z] Finished install step (success) 17:12:36 INFO - [mozharness: 2017-09-01 00:12:36.847418Z] Running setup-mitmproxy step. 17:12:36 INFO - Running pre-action listener: _resource_record_pre_action 17:12:36 INFO - Running main action method: setup_mitmproxy 17:12:36 INFO - Skipping: mitmproxy is not required 17:12:36 INFO - Running post-action listener: _resource_record_post_action 17:12:36 INFO - [mozharness: 2017-09-01 00:12:36.848587Z] Finished setup-mitmproxy step (success) 17:12:36 INFO - [mozharness: 2017-09-01 00:12:36.848808Z] Running run-tests step. 17:12:36 INFO - Running pre-action listener: _resource_record_pre_action 17:12:36 INFO - Running pre-action listener: _set_gcov_prefix 17:12:36 INFO - Running main action method: run_tests 17:12:36 WARNING - Try message not found. 17:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:36 INFO - Python 2.7.3 17:12:36 INFO - Return code: 0 17:12:36 INFO - grabbing minidump binary from tooltool 17:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:12:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1188090>, '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 0x1188d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1182f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:12:36 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:12:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:12:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:36 INFO - Return code: 0 17:12:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:36 INFO - ENV: RUST_BACKTRACE is now full 17:12:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:36 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/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:12:36 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/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 17:12:36 INFO - Using env: {'DISPLAY': ':0', 17:12:36 INFO - 'HOME': '/home/cltbld', 17:12:36 INFO - 'LANG': 'en_US.UTF-8', 17:12:36 INFO - 'LANGUAGE': 'en_US:en', 17:12:36 INFO - 'LOGNAME': 'cltbld', 17:12:36 INFO - 'MAIL': '/var/mail/cltbld', 17:12:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:36 INFO - 'MOZ_NO_REMOTE': '1', 17:12:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:36 INFO - 'NO_EM_RESTART': '1', 17:12:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:36 INFO - 'PWD': '/builds/slave/test', 17:12:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:36 INFO - 'RUST_BACKTRACE': 'full', 17:12:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:12:36 INFO - 'SHELL': '/bin/bash', 17:12:36 INFO - 'SHLVL': '1', 17:12:36 INFO - 'STYLO_FORCE_ENABLED': '1', 17:12:36 INFO - 'STYLO_THREADS': '1', 17:12:36 INFO - 'TERM': 'linux', 17:12:36 INFO - 'TMOUT': '86400', 17:12:36 INFO - 'USER': 'cltbld', 17:12:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:36 INFO - '_': '/tools/buildbot/bin/python'} 17:12:36 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/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 17:12:37 INFO - mozversion application_buildid: 20170831232651 17:12:37 INFO - mozversion application_changeset: 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 17:12:37 INFO - mozversion application_display_name: Nightly 17:12:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:37 INFO - mozversion application_name: Firefox 17:12:37 INFO - mozversion application_remotingname: firefox 17:12:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:12:37 INFO - mozversion application_vendor: Mozilla 17:12:37 INFO - mozversion application_version: 57.0a1 17:12:37 INFO - mozversion platform_buildid: 20170831232651 17:12:37 INFO - mozversion platform_changeset: 14eea6bedcf3e2f46ea7c908e1ac9b7d256a42f0 17:12:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:12:37 INFO - mozversion platform_version: 57.0a1 17:12:37 INFO - using testdate: 1504224757 17:12:37 INFO - actual date: 1504224757 17:12:37 INFO - starting webserver on 'localhost:45903' 17:12:37 INFO - SUITE-START | Running 2 tests 17:12:37 INFO - TEST-START | dromaeo_css 17:12:37 INFO - Initialising browser for dromaeo_css test... 17:12:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45903/getInfo.html -profile /tmp/tmpvWHkkA/profile 17:12:37 INFO - TEST-INFO | started process 28824 (/builds/slave/test/build/application/firefox/firefox http://localhost:45903/getInfo.html) 17:12:42 INFO - TEST-INFO | 28824: exit 0 17:12:42 INFO - Browser initialized. 17:12:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:42 INFO - Using env: {'DISPLAY': ':0', 17:12:42 INFO - 'HOME': '/home/cltbld', 17:12:42 INFO - 'JSGC_DISABLE_POISONING': '1', 17:12:42 INFO - 'LANG': 'en_US.UTF-8', 17:12:42 INFO - 'LANGUAGE': 'en_US:en', 17:12:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:12:42 INFO - 'LOGNAME': 'cltbld', 17:12:42 INFO - 'MAIL': '/var/mail/cltbld', 17:12:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:42 INFO - 'MOZ_CRASHREPORTER': '1', 17:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:12:42 INFO - 'MOZ_NO_REMOTE': '1', 17:12:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:42 INFO - 'NO_EM_RESTART': '1', 17:12:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:42 INFO - 'PWD': '/builds/slave/test', 17:12:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:42 INFO - 'RUST_BACKTRACE': 'full', 17:12:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:12:42 INFO - 'SHELL': '/bin/bash', 17:12:42 INFO - 'SHLVL': '1', 17:12:42 INFO - 'STYLO_FORCE_ENABLED': '1', 17:12:42 INFO - 'STYLO_THREADS': '1', 17:12:42 INFO - 'TERM': 'linux', 17:12:42 INFO - 'TMOUT': '86400', 17:12:42 INFO - 'USER': 'cltbld', 17:12:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:42 INFO - '_': '/tools/buildbot/bin/python'} 17:12:42 INFO - TEST-INFO | started process 29013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvWHkkA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:43 INFO - PID 29013 | 17:12:43 INFO - PID 29013 | (/builds/slave/test/build/application/firefox/firefox:29064): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:12:43 INFO - PID 29013 | 17:12:53 INFO - PID 29013 | RSS: Main: 167477248 17:12:53 INFO - PID 29013 | 17:15:51 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45903/tests/dromaeo/cssquery-ext.html) 17:15:53 INFO - PID 29013 | RSS: Main: 173985792 17:15:53 INFO - PID 29013 | 17:18:55 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-ext.html (next: http://localhost:45903/tests/dromaeo/cssquery-jquery.html) 17:18:56 INFO - PID 29013 | RSS: Main: 169533440 17:18:56 INFO - PID 29013 | 17:21:57 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45903/tests/dromaeo/cssquery-mootools.html) 17:21:58 INFO - PID 29013 | RSS: Main: 171929600 17:21:58 INFO - PID 29013 | 17:25:00 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45903/tests/dromaeo/cssquery-prototype.html) 17:25:01 INFO - PID 29013 | RSS: Main: 170610688 17:25:01 INFO - PID 29013 | 17:28:04 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45903/tests/dromaeo/cssquery-yui.html) 17:28:05 INFO - PID 29013 | RSS: Main: 173912064 17:28:05 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | Cycle 1(1): loaded http://localhost:45903/tests/dromaeo/cssquery-yui.html (next: http://localhost:45903/tests/dromaeo/cssquery-dojo.html) 17:31:07 INFO - PID 29013 | RSS: Main: 173187072 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | __start_tp_report 17:31:07 INFO - PID 29013 | _x_x_mozilla_page_load 17:31:07 INFO - PID 29013 | _x_x_mozilla_page_load_details 17:31:07 INFO - PID 29013 | |i|pagename|runs| 17:31:07 INFO - PID 29013 | |0;dojo.html;3295.653956334585;3333.2500187457827;3354.7987120772773;3357.6306606273306;3372.9325413491715;6399.264084630269;6493;6494.967525162368;6510.316416776242;6536.836579085525;6358.586691865025;6449.580777249487;6450.870982580345;6472.838179045514;6574.079628851964;5915.260592425947;5991.400859914017;6008.519318454535;6044.788432404866;6047.848803779897;964.1585332193071;5917.88164236715;5919.6152250103605;5931.466168044875;6085.178500902388;5919.289685237756;5935.525157987372;6004.09938509225;6009.969950150265;6038.0942858571125;5926.555508336892;5959;5999.520038396918;6022.277326720778;6038.154658347835;5931.762729490815;5946.167536544844;5968.582199246054;5980.073088671263;6015.27816661999;6464.644444555547;6484.902726459107;6524.412802847719;6532.608043517404;6566.770163044271;6772.153480814898;6789.592624442549;6859.485538584626;6873.106496155518;6892.241853396123;6753.966230168867;6767.458603311723;6769.323067693241;6946.687399067054;7033.788986330418;6429;6443.967780161116;6453.548251622436;6460.967695161494;6471.255805582324;7072.080629518233;7097.645117744195;7163.140423149255;7166.570005799565;7216.242294559101;6772.0857684212;6792.320767923267;6797.388235058769;6871.244163142051;6898.551594146365;6798.762043328558;6816.863662726718;6867.828304292432;6896.310368963063;6899;6872.62200578973;6894.793156205322;6897.517173797886;6903.240643529208;6904.861902762017;6739.494537909578;6832.6925288362145;6847.075644787989;6943.027976083353;6956.8956465653055;5373.973130134403;5387.676739395649;5389.7035663038905;5393.946060539344;5394.514493695508;4730.290456431563;4740.2178640523925;4750.596199323028;4801.735904525284;4808.807647694053;6047.758089676364;6118.816435506942;6130.754769809247;6138.478229350466;6158.353372895871;6952;6962.268961759044;6976.581405115608;7078.823029424306;7079.1505019398;5858.443447872445;5937.139114828412;6020.066889632114;6072.332043475214;6080.574359794772;5864.06175011996;5918.615290006136;5967.791127310524;5967.8209653710455;5990.580659353804;6620.073189753439;6721.1598550181225;6725.663716814238;6732.057511948331;6744.190697116279;6911.654417279216;6952.5480843745;7007.089078419773;7007.194172670208;7016.614086225102;6511.47908167336;6622.536422450575;6637.535372523877;6640.203175618956;6730.528862979741;6788.76239331621;6844.863102738017;6845.178578570603;6854.383105520527;6854.451643868579;6979.895301570582;7060.682269297997;7080.929190708027;7084.397826184832;7088.893666594902;6723.159605049369;6753.493487988322;6811.318868113347;6815.045893574805;6847.965760171366;6556.704948277244;6623.602583844985;6633.502487313374;6656.633885136171;6725.495587830835;6530.738770449128;6537.5750576212395;6555.082288479712;6561.1470508833545;6564.606123632598;6561.114249576246;6588.077669126422;6648.5678430901835;6665.133532640726;6677.43241824431;6439.581427207217;6444.806655800334;6472.35276472349;6473.611583305017;6491 17:31:07 INFO - PID 29013 | |1;ext.html;814.9062857771358;859.312549960032;886.6852267445059;888.5468411110336;1135.1372956553016;30714.69285307146;31093.222669433275;40884.386734198975;41428.58571414285;41443;41577;41812.372814407805;41822.58177418233;41930.37104443436;41931.79034104833;7691.538507689556;7711.537307761539;7801.882971755428;7893.250141236574;7915.327197188217;7716.5370077795515;7797.0643522777345;7799.259070388304;7825.295723384894;7840.255175758322;7797.532148071134;7828.256315650033;7852.568108754016;7862.842743145134;7870.881936770953;7830.6084695764985;7840;7859.842803143905;7862.095858976205;7863.410244231677;7833.804154896116;7839;7853.607319633996;7870.252326029018;7876.881846772303;37478.81260593679;37836.81081594574;37849.62150378488;37891.43162852559;37938.24123517514;3549.236914063463;3556.5376501054698;3586.659267369596;3595.7482976191677;3598.6941110005682;30999.690003099906;31016.224594385094;31138.221544461343;31282.374352512823;31295;4976.7013979161;5158.845234642967;5247.921281180786;5251.291075704808;5252.921206181873;192278;193361;193631.0318448413;194226;194384;47640.76179619149;48232.758836206296;48273.75863120732;48309.275360869615;48344.27483587749;51217.487825122014;51555.7422212894;51581.74209128931;51612.22581661278;51622.48377516252;13399.397027133607;15123.697526049418;15366.769498457532;15367.154806485527;15390.3074361654;11147.442627868573;11780.94109529464;12000.159988800875;12027.639170824888;12060.276383417024;14366;14373.209473479059;14412.567622971328;14494.855051449562;14570.271486425636;5705.572082093777;5799.2750906136735;5812.651240925558;5966.671833049224;6013.879722405527;1007.6573964851839;1021.4433133942019;1028.1466382902174;1039.77644806367;1046.3930920066343;22697.546049078926;23515.764842351356;29125.7087429123;29565.408691826044;30002.549961750592;1080.989190108089;1093.6937657455926;1099.7470581766238;1110.5502271580024;1127.5095333529941;12497.87502124967;12565.87434125647;12746.553870614669;12762.489500420064;12818.679533011562;227060;229598;230753;230823;230965;55967.44032559704;56687.14969275464;56696;56713.43286567164;57109.14336284959;1444.248990524921;1455.3960106555874;1461.8245810502808;1474.5723740115461;1476.2766244540098;27310.180694579194;27531;27847.86076069607;27881.16356509308;28243.43513129767;37591.81204093962;37668.81165594154;37703.81148094242;37718.8114059428;37750;199950;200100;201069;201639;202606;34858.47712284369;37055.44416833696;37681.81159094187;37926.431103532916;37935.43096853605;46699.76650116863;46971.29543056789;47631.76184119057;47647.28529072136;47751.28373074337;33761.66238337683;33987.66012339944;34067.82966085154;34143.317133657685;34544;33622.495662564594;34032.65967340295;34201.48697769585;34375.656243437246;34850.651493485755;36882.63117368792;38166.427503586914;38473.615263847;38494.42258366183;38679;33349.333013339114;33369.83315083409;33645.49531756977;33787.3242535143;34271.143221418664;23557.882210588836;24967.250982469828;25085;25468.49063018766;25479.745202547736 17:31:07 INFO - PID 29013 | |2;jquery.html;565.4854082784667;570.603430615722;571.548476703404;588.405710232665;593.7684303121782;22356.32931012068;22982;23199.768002319972;23209.651855222186;23216.41958951027;25516.362090947736;25886.482270354627;26073.739262607367;26077.21768346948;26113.608295875576;6522.967385163068;6686.732530698766;6688.832779180535;6690.397864192221;6696.129503164581;6396.552241343108;6470.320616335288;6520.4131628153455;6624.635645039521;6665.200175978865;6599.439047680953;6620.04009418634;6651.634160121192;6655.1348324717965;6656.467482601404;6643.833904152387;6644.568103073285;6645.93354066458;6657.633830139341;6658.9001164982565;6151.692415379258;6158.815235542941;6160.476359509447;6163.876722465526;6166.691665416712;28471.71528284732;29611;29927.40145197084;30034.699653003627;30117.247068823235;2064.721262629541;2096.5597224582857;2114.3656902929215;2121.4908421978766;2122.9893850530802;19288.421347359603;19840.60318793616;19856.70214946777;19857.50356241091;19869.9006504968;2415.2754173747803;2452.3256104571205;2459.6064629659168;2464.6303054541963;2513.6103903894927;138156;142624.28687856495;142688.28655856758;142836;143213.2839335807;14593;14779.852201478063;14847.257637118317;14888.404463821542;15364.769528457082;23188.768112318998;23464.530709386057;23566.764332356455;23571.7642823573;23604.29187124389;9834.409935403899;9945.303828732063;10048.447335396477;10050.64822731201;10166.390016599027;9098.454092754457;9174.67888623895;9210.263178945668;9241.861372079424;9283.860742088875;7802.843943121219;11704.882951170379;11718.589849355401;11830.5859294926;11861.822072668916;4140.958590414118;4165.791710414528;4176.979115104405;4313.719608225455;4363.54556803995;954.022127319503;994.0904072773476;1002.8245057115122;1010.2675560218929;1018.8064267789097;20175;20222.191112355635;20427.897860510602;20813.1674733012;20834.791652083284;1053.710229686827;1054.7943151085617;1067.5356220044305;1067.6103222323952;1069.6951368859993;10991.945040274748;11344.752077271494;11458.140639452075;13361.665958350924;14382.856171438361;504740;506961;529361;535936;543442;116843;123142;126697;132517.3374133123;133190;1200.9819852702042;1249.0881656390886;1269.2194300505123;1270.6823294176456;1274.0826604844312;20608.58782824365;20999.265025724028;21062.57874842525;21433.46416339604;21798.237061702763;59548.70225648844;60325.39674603198;60691;61722.0741688884;61885.38114618796;71208.64395677988;79725.60137199509;80194.59902700449;81654;83499;12298.508059677513;13627.182369057888;14613.85386146125;15064.171470568786;15167.165805880783;22988.310350689506;23697.763022369556;23830.88084559566;23880;23959.52080958406;18380.540486487946;18754.343597974006;18794.966276854357;19004.144813483705;19167.808321916604;15876.52370428889;15998.200089995686;16586.83413165853;16690.4158354457;16887;19133.139008744918;19217.711734324275;19359.3224237151;19442.125104370054;19458.124384403018;14782.926085369505;14804.185769782765;14836.554903352917;14861.479848205694;14876.256187190813;18057.819421805612;18229.908850455664;18475.90762046181;18486.075696214866;18489.81510184881 17:31:07 INFO - PID 29013 | |3;mootools.html;1333.2667033131777;1379.806827044214;1402.8877689784806;1408.6407965968676;1411.4213172599234;12562.623121306364;13167.670808229786;15113.697726045473;15620.687586248268;15632.609184770386;15116.395344186247;15372.231388430562;15374;15380.307886145123;15390.461333853318;2798.566222235557;2804.326961529234;2861.4563232985665;2862.155664079102;2916.927076823086;2843.5734639803986;2872.5403935370346;2872.9569056464065;2874.741273285404;2875.0943452812403;2789.4142230131697;2834.8582570871476;2835.10694131349;2841.5453527435616;2842.189975856881;2759;2805.2145399288233;2806.536921407965;2808;2808.0873716042165;2749.8625068746483;2756.324700448403;2778.499870023395;2779.5413756730113;2791.52544067509;15100.244987750679;15144.621384465367;15158.848411515854;15188.392464301414;15229.695406091927;7905.920940790576;8198.754037378889;8210.425270231086;8217.055038670569;8218.096009438957;5453.509184173444;5692.943070569283;5807.2160258365;5851.736671849777;5873;1884.5382881194196;1904.7428597139346;1918.788933217359;1963.7938016508347;1966.4690533556002;26107.477850443076;26386.868065659743;26428.47143057128;26436.603450948252;26573.73426265732;6702.19573651165;6803.7618683345845;6983.441324694012;7042.183126749342;7083.6458177090935;17111.486655400357;17144.828551714323;17159;17166.828331716773;17176.22706978164;7849.411294152961;8039.678412863537;8049.718259860877;8075.878861817077;8082.797930051678;7327;7441.367483763833;7488.663010164556;7525.661345239478;7560.546367217985;5168.53483186515;5301.920471192935;5321.813736519203;5323.733813309319;5374.381946076173;1533.0954736705398;1535.7926679898294;1538.4384699584796;1551.0848599326453;1551.2786554252102;869.1135042256863;879.4195830751801;889.0753616239168;894.4007514964989;905.7554460295815;7210.315020073084;7221.819454513679;8714.259287960595;9138.451692898447;9260.536973151315;973.1630797514132;979.4857699707568;985.393982700634;993.1756641987133;1006.4615430744517;4844.515548445127;4977.303177555073;4999.3000979862845;5002.674826136362;5026.421961474477;21030.369088927357;22201.666974995387;22229.221977230718;22235.444113897283;22253.221137260443;21153;21434.678479822815;21436.571268574855;21784.891075544838;22058.33824985253;9914.355566888129;11633.59282425128;11858.940705296418;11874.0500759939;11889.108316876269;6934.237233904166;8262.215089566482;8322.833543328978;8695.695645653203;8822.779430514289;17684.381046663304;17811.554711132325;17976.10119493994;18345.449636510926;19599.216031359156;18748.625027499646;19401.51496212606;19480.8051919479;19534.120964556914;19573.804261957197;12047;12209.267443953391;12289.446974885972;12375.195612285173;12437.37813109359;13999.790003149757;14102.858971410154;14130.293485325898;14139.858601413855;14141.787873182117;11281.097512199169;11330;11400.771984560428;11435.59975400857;11621.6513504595;10756.30084044566;10756.784864302826;10822.67531974042;10949.343039417661;11020.889791102307;9540.809183816145;9739.074787895139;9762.414255144715;9767.365121267096;9773.169280611228;6963.338482844122;6965.895511567229;6967.54710943787;6975.372216500539;6997.370236678723;6884.208316043719;6913.51605387618;6917.757878474229;6964.233934267125;7015.123109611299 17:31:07 INFO - PID 29013 | |4;prototype.html;495.8595230968773;502.04110149614246;528.709209934536;531.3225637312423;532.4994505165145;6388.393102655252;6419.9358006419925;6486.156799616049;6516.380943810336;6534.248561415438;6100.969495152529;6182.814515564529;6218.2639638559;6239.500839932806;6262.279837818653;5045.344105266319;5081.339425874631;5091.567216786559;5114.667546609477;5125.205593133071;4965.801367945278;5099.541041306282;5118.181091025418;5128.692278463285;5136.126858434057;4963.677360971544;4999.550040496355;5014.899702005958;5051.393832740058;5069.619778516608;5046.1926091825135;5049.747512624354;5051.696898186121;5071.427857364229;5081.923771143399;4559.224931761609;4572.474165470981;4574.359589657451;4588.701734387254;4604.2633178691585;6275.717592708339;6294.590851594632;6314.589551679126;6367.745290188387;6410.2628197757385;5715.913976344481;5752.0951919280915;5786.594938354275;5828.125781132821;5833.183354330397;6589.835254118638;6623.172103487064;6710.630915299656;6724.899126513057;6764.864702705919;4905.8773530661665;4941.343405879659;4951.232558953368;4952.777125029346;4985.476524964899;6988.44092472601;7040.190378106532;7044.612546309951;7064.611446370499;7083.114610673717;5044.2937988681615;5050.797968081236;5071.264666623319;5109.131447653907;5109.616778741609;5128.1794912813775;5155.175171972542;5158.329417175743;5163;5165.251038599382;5702.372738998707;5713.5714821388565;5804.21643078179;5823.388544202882;5836.095405212199;6604.702788374535;6653.2681405045405;6659.766908158192;6659.833504162338;6710.899336509956;1649.5463747469541;1707.5474999125242;1720.1829131162597;1739.7390391441386;1750.2211515875313;1192.7316353820322;1237.9319137447526;1243.384524660281;1246.8940140088014;1254.1785130739381;5864;5876.1479585459865;5918.822435326947;5933.703314834241;5952.226210592682;6637.159299816131;6738.258791532928;6821.69302381394;6889.345512176335;6903.930960690429;5882.941170588325;5937.882611628843;5959.404059594006;5962.612430192024;5967.1347654589845;3596.7122630189524;3602.7478076534917;3603.56757189139;3621.7102631789394;3667.211549516813;6577.934220657828;6619.5035372347265;6629.303923088103;6659.700313485905;6677.966610166918;7044.577325360495;7048.753293634698;7060.7881763547175;7127.786166414912;7138.678759455837;6618.543920337518;6629.86740265192;6688.792698409513;6696.19645642526;6712.39588437043;6921.2732663071665;6951.756688515878;6959.921212212115;7008.719651213894;7039.577625342496;6754.89274933536;6812.863742725019;6837.418819400208;6875.4155896749335;6911.17065952089;6592.406683398517;6609.1408116944485;6639.6680165992475;6733.4513061996995;6742.730290788313;5023.799048038038;5072.391313042459;5103.974480127724;5117.8720531987;5131.7163862081015;6747.932520674731;6950.409215216763;6965.686544105629;7008.334208250208;7052.435805135679;6712.899306510309;6741.94370716936;6792.864142717217;6799.422049125879;6813.386795188457;6254.937450625617;6627.50293727982;6645.900311495235;6679.699413526306;6702.19573651165;6332.865231710333;6464.935350646433;6469.676516174079;6540.705668244846;6577.473802095917;6631;6648.16897887764;6685.966570167313;6737.3599508046655;6753.86492270142;6343.333949935375;6360.886844802234;6381.3937675920715;6430.131932189094;6467.547271690936 17:31:07 INFO - PID 29013 | |5;yui.html;910.4446287764465;919.3334832246622;928.5403725156049;932.7901222225;941.7457286532639;18248.908755456236;19176.90411547942;19184.232630694754;19212.61574768504;20033.899830500864;20618.793812061875;21454.678179827275;21573.784262157373;21584.676229856566;21597.784022159773;918.4076270805326;941.580996456577;944.8393773058597;947.0671388682142;947.4552132523827;949.4066208619613;978.4080631218118;985.069109691342;989.1098011789411;994.6319861651162;1048.821700310949;1049.1449468683;1050.2070936443013;1050.2858056521563;1050.4590136079926;1049.4280617063719;1049.6431213387484;1049.7165765243417;1050.0811789684026;1050.1651187306072;766.2529034191674;772.5635016215876;772.8840673898904;773.2847116417348;774.3921021997704;19240.422787316264;19636;19937.302194423126;19981.60036799256;20401.183952641877;21107.68338474924;21366.145354185814;21911.890440547853;21937.232196873192;22211.666824997475;16279;16655.16724163799;16716.331346746116;16815.32738690463;16837.66324673512;3799.2401519696173;3814.8664796731982;3831.942520862189;3832.463455116286;3832.827522761482;124025.37987310096;129205.35397322953;133629;133913;138112;16841.747373789403;17025.31898724062;17502.737458938125;17529.386471473437;17581.82418175802;29861.85069074684;30331;30425.391492170034;30488.237794055327;30583;7908.960455197687;8258.669653213805;8808.47149171039;9189.264858811279;9256.7685807854;4303.096349766584;4399.6920215584605;4399.846005389796;4402.163588918095;4404.185225733249;5200.5059519345605;5274.630775845654;5321.3348331458565;5343.091674415358;5350.357957045102;1040.292601031306;1059.9364038157735;1079.4764539198482;1082.1505118482112;1084.4089970965842;698.7938558125365;713.4078714666814;715.2346988722018;730.5470608222936;738.9815254618677;11455.484503197376;11508.654740357802;11512.827307590393;11929.940350298193;12048.939755301168;706.5831159615749;709.925457826931;713.8929160625947;717.9928200717926;727.5707332673747;5684.715764211773;5704.914426283609;5720.799772007959;5929.881402371929;5991.191189189491;102564;104976;107759.46120269349;108081;109998.45000774944;94971;94990.05009949951;95520;95602.52198738961;97123;82594.58702706569;84568.15431845727;85373;87047;88212.5589372049;11417.486213120263;11728.237664551776;11729.765404691687;11995.460204291003;12073.517059317528;39506.802465987486;40323.59676403199;40842.38736419015;41226.79386603048;41715;70995.64502177456;72008.63995679987;72501;73314;73934;16724.58188545296;17000.404985825437;17007.659846803243;17083.402080927604;17307.3942412015;18274;18413.171407286973;18436.631267374847;18498.594142676284;18552.628947421246;14475.710485790436;15590.688186235984;15722.528324150293;15791.763123552926;15968.680626387639;17358.39245626397;17552.82447175512;17615.911920440314;17753.289868405118;17784.644307113525;16267.75598366049;16381.180940953143;16752.916235418747;16816.411425600047;16947.406840761007;11795.174337796272;11871.76256474883;11927.642170734893;12209.145359825083;12327.198732082386;13929.860701392856;14239.715205696035;14302.427902883768;14579.343929522985;14615.780763288773 17:31:07 INFO - PID 29013 | __end_tp_report 17:31:07 INFO - PID 29013 | __start_cc_report 17:31:07 INFO - PID 29013 | _x_x_mozilla_cycle_collect,365 17:31:07 INFO - PID 29013 | __end_cc_report 17:31:07 INFO - PID 29013 | __startTimestamp1504225867291__endTimestamp 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | ------- Summary: start ------- 17:31:07 INFO - PID 29013 | Number of tests: 6 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#0] dojo.html Cycles:165 Average:6331.49 Median:6561.11 stddev:851.22 (13.0%) stddev-sans-first:819.84 17:31:07 INFO - PID 29013 | Values: 3295.7 3333.3 3354.8 3357.6 3372.9 6399.3 6493.0 6495.0 6510.3 6536.8 6358.6 6449.6 6450.9 6472.8 6574.1 5915.3 5991.4 6008.5 6044.8 6047.8 964.2 5917.9 5919.6 5931.5 6085.2 5919.3 5935.5 6004.1 6010.0 6038.1 5926.6 5959.0 5999.5 6022.3 6038.2 5931.8 5946.2 5968.6 5980.1 6015.3 6464.6 6484.9 6524.4 6532.6 6566.8 6772.2 6789.6 6859.5 6873.1 6892.2 6754.0 6767.5 6769.3 6946.7 7033.8 6429.0 6444.0 6453.5 6461.0 6471.3 7072.1 7097.6 7163.1 7166.6 7216.2 6772.1 6792.3 6797.4 6871.2 6898.6 6798.8 6816.9 6867.8 6896.3 6899.0 6872.6 6894.8 6897.5 6903.2 6904.9 6739.5 6832.7 6847.1 6943.0 6956.9 5374.0 5387.7 5389.7 5393.9 5394.5 4730.3 4740.2 4750.6 4801.7 4808.8 6047.8 6118.8 6130.8 6138.5 6158.4 6952.0 6962.3 6976.6 7078.8 7079.2 5858.4 5937.1 6020.1 6072.3 6080.6 5864.1 5918.6 5967.8 5967.8 5990.6 6620.1 6721.2 6725.7 6732.1 6744.2 6911.7 6952.5 7007.1 7007.2 7016.6 6511.5 6622.5 6637.5 6640.2 6730.5 6788.8 6844.9 6845.2 6854.4 6854.5 6979.9 7060.7 7080.9 7084.4 7088.9 6723.2 6753.5 6811.3 6815.0 6848.0 6556.7 6623.6 6633.5 6656.6 6725.5 6530.7 6537.6 6555.1 6561.1 6564.6 6561.1 6588.1 6648.6 6665.1 6677.4 6439.6 6444.8 6472.4 6473.6 6491.0 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#1] ext.html Cycles:180 Average:38408.78 Median:3571.60 stddev:54044.72 (1513.2%) stddev-sans-first:54122.61 17:31:07 INFO - PID 29013 | Values: 814.9 859.3 886.7 888.5 1135.1 30714.7 31093.2 40884.4 41428.6 41443.0 41577.0 41812.4 41822.6 41930.4 41931.8 7691.5 7711.5 7801.9 7893.3 7915.3 7716.5 7797.1 7799.3 7825.3 7840.3 7797.5 7828.3 7852.6 7862.8 7870.9 7830.6 7840.0 7859.8 7862.1 7863.4 7833.8 7839.0 7853.6 7870.3 7876.9 37478.8 37836.8 37849.6 37891.4 37938.2 3549.2 3556.5 3586.7 3595.7 3598.7 30999.7 31016.2 31138.2 31282.4 31295.0 4976.7 5158.8 5247.9 5251.3 5252.9 192278.0 193361.0 193631.0 194226.0 194384.0 47640.8 48232.8 48273.8 48309.3 48344.3 51217.5 51555.7 51581.7 51612.2 51622.5 13399.4 15123.7 15366.8 15367.2 15390.3 11147.4 11780.9 12000.2 12027.6 12060.3 14366.0 14373.2 14412.6 14494.9 14570.3 5705.6 5799.3 5812.7 5966.7 6013.9 1007.7 1021.4 1028.1 1039.8 1046.4 22697.5 23515.8 29125.7 29565.4 30002.5 1081.0 1093.7 1099.7 1110.6 1127.5 12497.9 12565.9 12746.6 12762.5 12818.7 227060.0 229598.0 230753.0 230823.0 230965.0 55967.4 56687.1 56696.0 56713.4 57109.1 1444.2 1455.4 1461.8 1474.6 1476.3 27310.2 27531.0 27847.9 27881.2 28243.4 37591.8 37668.8 37703.8 37718.8 37750.0 199950.0 200100.0 201069.0 201639.0 202606.0 34858.5 37055.4 37681.8 37926.4 37935.4 46699.8 46971.3 47631.8 47647.3 47751.3 33761.7 33987.7 34067.8 34143.3 34544.0 33622.5 34032.7 34201.5 34375.7 34850.7 36882.6 38166.4 38473.6 38494.4 38679.0 33349.3 33369.8 33645.5 33787.3 34271.1 23557.9 24967.3 25085.0 25468.5 25479.7 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#2] jquery.html Cycles:180 Average:36785.98 Median:22669.16 stddev:88359.38 (389.8%) stddev-sans-first:88565.40 17:31:07 INFO - PID 29013 | Values: 565.5 570.6 571.5 588.4 593.8 22356.3 22982.0 23199.8 23209.7 23216.4 25516.4 25886.5 26073.7 26077.2 26113.6 6523.0 6686.7 6688.8 6690.4 6696.1 6396.6 6470.3 6520.4 6624.6 6665.2 6599.4 6620.0 6651.6 6655.1 6656.5 6643.8 6644.6 6645.9 6657.6 6658.9 6151.7 6158.8 6160.5 6163.9 6166.7 28471.7 29611.0 29927.4 30034.7 30117.2 2064.7 2096.6 2114.4 2121.5 2123.0 19288.4 19840.6 19856.7 19857.5 19869.9 2415.3 2452.3 2459.6 2464.6 2513.6 138156.0 142624.3 142688.3 142836.0 143213.3 14593.0 14779.9 14847.3 14888.4 15364.8 23188.8 23464.5 23566.8 23571.8 23604.3 9834.4 9945.3 10048.4 10050.6 10166.4 9098.5 9174.7 9210.3 9241.9 9283.9 7802.8 11704.9 11718.6 11830.6 11861.8 4141.0 4165.8 4177.0 4313.7 4363.5 954.0 994.1 1002.8 1010.3 1018.8 20175.0 20222.2 20427.9 20813.2 20834.8 1053.7 1054.8 1067.5 1067.6 1069.7 10991.9 11344.8 11458.1 13361.7 14382.9 504740.0 506961.0 529361.0 535936.0 543442.0 116843.0 123142.0 126697.0 132517.3 133190.0 1201.0 1249.1 1269.2 1270.7 1274.1 20608.6 20999.3 21062.6 21433.5 21798.2 59548.7 60325.4 60691.0 61722.1 61885.4 71208.6 79725.6 80194.6 81654.0 83499.0 12298.5 13627.2 14613.9 15064.2 15167.2 22988.3 23697.8 23830.9 23880.0 23959.5 18380.5 18754.3 18795.0 19004.1 19167.8 15876.5 15998.2 16586.8 16690.4 16887.0 19133.1 19217.7 19359.3 19442.1 19458.1 14782.9 14804.2 14836.6 14861.5 14876.3 18057.8 18229.9 18475.9 18486.1 18489.8 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#3] mootools.html Cycles:180 Average:9368.99 Median:2790.47 stddev:6666.95 (238.9%) stddev-sans-first:6658.31 17:31:07 INFO - PID 29013 | Values: 1333.3 1379.8 1402.9 1408.6 1411.4 12562.6 13167.7 15113.7 15620.7 15632.6 15116.4 15372.2 15374.0 15380.3 15390.5 2798.6 2804.3 2861.5 2862.2 2916.9 2843.6 2872.5 2873.0 2874.7 2875.1 2789.4 2834.9 2835.1 2841.5 2842.2 2759.0 2805.2 2806.5 2808.0 2808.1 2749.9 2756.3 2778.5 2779.5 2791.5 15100.2 15144.6 15158.8 15188.4 15229.7 7905.9 8198.8 8210.4 8217.1 8218.1 5453.5 5692.9 5807.2 5851.7 5873.0 1884.5 1904.7 1918.8 1963.8 1966.5 26107.5 26386.9 26428.5 26436.6 26573.7 6702.2 6803.8 6983.4 7042.2 7083.6 17111.5 17144.8 17159.0 17166.8 17176.2 7849.4 8039.7 8049.7 8075.9 8082.8 7327.0 7441.4 7488.7 7525.7 7560.5 5168.5 5301.9 5321.8 5323.7 5374.4 1533.1 1535.8 1538.4 1551.1 1551.3 869.1 879.4 889.1 894.4 905.8 7210.3 7221.8 8714.3 9138.5 9260.5 973.2 979.5 985.4 993.2 1006.5 4844.5 4977.3 4999.3 5002.7 5026.4 21030.4 22201.7 22229.2 22235.4 22253.2 21153.0 21434.7 21436.6 21784.9 22058.3 9914.4 11633.6 11858.9 11874.1 11889.1 6934.2 8262.2 8322.8 8695.7 8822.8 17684.4 17811.6 17976.1 18345.4 19599.2 18748.6 19401.5 19480.8 19534.1 19573.8 12047.0 12209.3 12289.4 12375.2 12437.4 13999.8 14102.9 14130.3 14139.9 14141.8 11281.1 11330.0 11400.8 11435.6 11621.7 10756.3 10756.8 10822.7 10949.3 11020.9 9540.8 9739.1 9762.4 9767.4 9773.2 6963.3 6965.9 6967.5 6975.4 6997.4 6884.2 6913.5 6917.8 6964.2 7015.1 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#4] prototype.html Cycles:180 Average:5625.50 Median:6269.00 stddev:1592.56 (25.4%) stddev-sans-first:1549.79 17:31:07 INFO - PID 29013 | Values: 495.9 502.0 528.7 531.3 532.5 6388.4 6419.9 6486.2 6516.4 6534.2 6101.0 6182.8 6218.3 6239.5 6262.3 5045.3 5081.3 5091.6 5114.7 5125.2 4965.8 5099.5 5118.2 5128.7 5136.1 4963.7 4999.6 5014.9 5051.4 5069.6 5046.2 5049.7 5051.7 5071.4 5081.9 4559.2 4572.5 4574.4 4588.7 4604.3 6275.7 6294.6 6314.6 6367.7 6410.3 5715.9 5752.1 5786.6 5828.1 5833.2 6589.8 6623.2 6710.6 6724.9 6764.9 4905.9 4941.3 4951.2 4952.8 4985.5 6988.4 7040.2 7044.6 7064.6 7083.1 5044.3 5050.8 5071.3 5109.1 5109.6 5128.2 5155.2 5158.3 5163.0 5165.3 5702.4 5713.6 5804.2 5823.4 5836.1 6604.7 6653.3 6659.8 6659.8 6710.9 1649.5 1707.5 1720.2 1739.7 1750.2 1192.7 1237.9 1243.4 1246.9 1254.2 5864.0 5876.1 5918.8 5933.7 5952.2 6637.2 6738.3 6821.7 6889.3 6903.9 5882.9 5937.9 5959.4 5962.6 5967.1 3596.7 3602.7 3603.6 3621.7 3667.2 6577.9 6619.5 6629.3 6659.7 6678.0 7044.6 7048.8 7060.8 7127.8 7138.7 6618.5 6629.9 6688.8 6696.2 6712.4 6921.3 6951.8 6959.9 7008.7 7039.6 6754.9 6812.9 6837.4 6875.4 6911.2 6592.4 6609.1 6639.7 6733.5 6742.7 5023.8 5072.4 5104.0 5117.9 5131.7 6747.9 6950.4 6965.7 7008.3 7052.4 6712.9 6741.9 6792.9 6799.4 6813.4 6254.9 6627.5 6645.9 6679.7 6702.2 6332.9 6464.9 6469.7 6540.7 6577.5 6631.0 6648.2 6686.0 6737.4 6753.9 6343.3 6360.9 6381.4 6430.1 6467.5 17:31:07 INFO - PID 29013 | 17:31:07 INFO - PID 29013 | [#5] yui.html Cycles:180 Average:23627.06 Median:20863.24 stddev:32374.86 (155.2%) stddev-sans-first:32420.74 17:31:07 INFO - PID 29013 | Values: 910.4 919.3 928.5 932.8 941.7 18248.9 19176.9 19184.2 19212.6 20033.9 20618.8 21454.7 21573.8 21584.7 21597.8 918.4 941.6 944.8 947.1 947.5 949.4 978.4 985.1 989.1 994.6 1048.8 1049.1 1050.2 1050.3 1050.5 1049.4 1049.6 1049.7 1050.1 1050.2 766.3 772.6 772.9 773.3 774.4 19240.4 19636.0 19937.3 19981.6 20401.2 21107.7 21366.1 21911.9 21937.2 22211.7 16279.0 16655.2 16716.3 16815.3 16837.7 3799.2 3814.9 3831.9 3832.5 3832.8 124025.4 129205.4 133629.0 133913.0 138112.0 16841.7 17025.3 17502.7 17529.4 17581.8 29861.9 30331.0 30425.4 30488.2 30583.0 7909.0 8258.7 8808.5 9189.3 9256.8 4303.1 4399.7 4399.8 4402.2 4404.2 5200.5 5274.6 5321.3 5343.1 5350.4 1040.3 1059.9 1079.5 1082.2 1084.4 698.8 713.4 715.2 730.5 739.0 11455.5 11508.7 11512.8 11929.9 12048.9 706.6 709.9 713.9 718.0 727.6 5684.7 5704.9 5720.8 5929.9 5991.2 102564.0 104976.0 107759.5 108081.0 109998.5 94971.0 94990.1 95520.0 95602.5 97123.0 82594.6 84568.2 85373.0 87047.0 88212.6 11417.5 11728.2 11729.8 11995.5 12073.5 39506.8 40323.6 40842.4 41226.8 41715.0 70995.6 72008.6 72501.0 73314.0 73934.0 16724.6 17000.4 17007.7 17083.4 17307.4 18274.0 18413.2 18436.6 18498.6 18552.6 14475.7 15590.7 15722.5 15791.8 15968.7 17358.4 17552.8 17615.9 17753.3 17784.6 16267.8 16381.2 16752.9 16816.4 16947.4 11795.2 11871.8 11927.6 12209.1 12327.2 13929.9 14239.7 14302.4 14579.3 14615.8 17:31:07 INFO - PID 29013 | -------- Summary: end -------- 17:31:07 INFO - PID 29013 | 17:31:07 INFO - TEST-INFO | 29013: exit 0 17:31:07 INFO - TEST-OK | dromaeo_css | took 1110757ms 17:31:07 INFO - TEST-START | kraken 17:31:07 INFO - Initialising browser for kraken test... 17:31:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45903/getInfo.html -profile /tmp/tmpLxwrIn/profile 17:31:07 INFO - TEST-INFO | started process 29396 (/builds/slave/test/build/application/firefox/firefox http://localhost:45903/getInfo.html) 17:31:12 INFO - TEST-INFO | 29396: exit 0 17:31:12 INFO - Browser initialized. 17:31:12 INFO - Running cycle 1/1 for kraken test... 17:31:12 INFO - Using env: {'DISPLAY': ':0', 17:31:12 INFO - 'HOME': '/home/cltbld', 17:31:12 INFO - 'JSGC_DISABLE_POISONING': '1', 17:31:12 INFO - 'LANG': 'en_US.UTF-8', 17:31:12 INFO - 'LANGUAGE': 'en_US:en', 17:31:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:31:12 INFO - 'LOGNAME': 'cltbld', 17:31:12 INFO - 'MAIL': '/var/mail/cltbld', 17:31:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:31:12 INFO - 'MOZ_CRASHREPORTER': '1', 17:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:31:12 INFO - 'MOZ_NO_REMOTE': '1', 17:31:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:12 INFO - 'NO_EM_RESTART': '1', 17:31:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:12 INFO - 'PWD': '/builds/slave/test', 17:31:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:12 INFO - 'RUST_BACKTRACE': 'full', 17:31:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:31:12 INFO - 'SHELL': '/bin/bash', 17:31:12 INFO - 'SHLVL': '1', 17:31:12 INFO - 'STYLO_FORCE_ENABLED': '1', 17:31:12 INFO - 'STYLO_THREADS': '1', 17:31:12 INFO - 'TERM': 'linux', 17:31:12 INFO - 'TMOUT': '86400', 17:31:12 INFO - 'USER': 'cltbld', 17:31:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259', 17:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:12 INFO - '_': '/tools/buildbot/bin/python'} 17:31:12 INFO - TEST-INFO | started process 29583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxwrIn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:13 INFO - PID 29583 | 17:31:13 INFO - PID 29583 | (/builds/slave/test/build/application/firefox/firefox:29635): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:31:13 INFO - PID 29583 | 17:31:23 INFO - PID 29583 | RSS: Main: 172240896 17:31:23 INFO - PID 29583 | 17:31:26 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45903/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:27 INFO - PID 29583 | RSS: Main: 176898048 17:31:27 INFO - PID 29583 | 17:31:30 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45903/tests/kraken/driver.html?testName=audio-dft) 17:31:30 INFO - PID 29583 | RSS: Main: 180961280 17:31:30 INFO - PID 29583 | 17:31:33 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45903/tests/kraken/driver.html?testName=audio-fft) 17:31:34 INFO - PID 29583 | RSS: Main: 174415872 17:31:34 INFO - PID 29583 | 17:31:36 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45903/tests/kraken/driver.html?testName=audio-oscillator) 17:31:37 INFO - PID 29583 | RSS: Main: 174854144 17:31:37 INFO - PID 29583 | 17:31:39 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:39 INFO - PID 29583 | RSS: Main: 175484928 17:31:39 INFO - PID 29583 | 17:31:43 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45903/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:43 INFO - PID 29583 | RSS: Main: 176324608 17:31:43 INFO - PID 29583 | 17:31:47 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45903/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:47 INFO - PID 29583 | RSS: Main: 176164864 17:31:47 INFO - PID 29583 | 17:31:50 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45903/tests/kraken/driver.html?testName=json-parse-financial) 17:31:51 INFO - PID 29583 | RSS: Main: 176717824 17:31:51 INFO - PID 29583 | 17:31:52 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:53 INFO - PID 29583 | RSS: Main: 177082368 17:31:53 INFO - PID 29583 | 17:31:55 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:55 INFO - PID 29583 | RSS: Main: 177754112 17:31:55 INFO - PID 29583 | 17:31:57 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:58 INFO - PID 29583 | RSS: Main: 173551616 17:31:58 INFO - PID 29583 | 17:32:01 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:02 INFO - PID 29583 | RSS: Main: 174297088 17:32:02 INFO - PID 29583 | 17:32:04 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:05 INFO - PID 29583 | RSS: Main: 174153728 17:32:05 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | Cycle 1(1): loaded http://localhost:45903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45903/tests/kraken/driver.html?testName=ai-astar) 17:32:07 INFO - PID 29583 | RSS: Main: 175558656 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | __start_tp_report 17:32:07 INFO - PID 29583 | _x_x_mozilla_page_load 17:32:07 INFO - PID 29583 | _x_x_mozilla_page_load_details 17:32:07 INFO - PID 29583 | |i|pagename|runs| 17:32:07 INFO - PID 29583 | |0;ai-astar;97;114;100;109;109;113;109;105;107;109 17:32:07 INFO - PID 29583 | |1;audio-beat-detection;145;118;150;183;120;143;142;119;173;120 17:32:07 INFO - PID 29583 | |2;audio-dft;164;162;162;165;162;164;165;170;162;161 17:32:07 INFO - PID 29583 | |3;audio-fft;74;75;73;167;75;74;76;87;101;74 17:32:07 INFO - PID 29583 | |4;audio-oscillator;78;79;134;80;80;80;125;80;80;128 17:32:07 INFO - PID 29583 | |5;imaging-gaussian-blur;114;114;114;113;114;114;114;114;113;115 17:32:07 INFO - PID 29583 | |6;imaging-darkroom;148;148;148;147;148;147;148;148;147;148 17:32:07 INFO - PID 29583 | |7;imaging-desaturate;94;95;94;93;94;94;95;94;94;94 17:32:07 INFO - PID 29583 | |8;json-parse-financial;53;54;53;53;54;53;54;53;54;53 17:32:07 INFO - PID 29583 | |9;json-stringify-tinderbox;38;38;38;38;39;39;38;38;39;39 17:32:07 INFO - PID 29583 | |10;stanford-crypto-aes;75;74;74;79;73;75;73;78;74;75 17:32:07 INFO - PID 29583 | |11;stanford-crypto-ccm;120;131;124;118;126;116;116;115;128;171 17:32:07 INFO - PID 29583 | |12;stanford-crypto-pbkdf2;173;175;170;173;168;170;167;166;180;177 17:32:07 INFO - PID 29583 | |13;stanford-crypto-sha256-iterative;64;63;66;68;62;66;63;64;67;62 17:32:07 INFO - PID 29583 | __end_tp_report 17:32:07 INFO - PID 29583 | __start_cc_report 17:32:07 INFO - PID 29583 | _x_x_mozilla_cycle_collect,945 17:32:07 INFO - PID 29583 | __end_cc_report 17:32:07 INFO - PID 29583 | __startTimestamp1504225927614__endTimestamp 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | ------- Summary: start ------- 17:32:07 INFO - PID 29583 | Number of tests: 14 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:5.31 (4.9%) stddev-sans-first:4.15 17:32:07 INFO - PID 29583 | Values: 97.0 114.0 100.0 109.0 109.0 113.0 109.0 105.0 107.0 109.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:144.00 stddev:23.06 (16.0%) stddev-sans-first:24.42 17:32:07 INFO - PID 29583 | Values: 145.0 118.0 150.0 183.0 120.0 143.0 142.0 119.0 173.0 120.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.63 (1.6%) stddev-sans-first:2.78 17:32:07 INFO - PID 29583 | Values: 164.0 162.0 162.0 165.0 162.0 164.0 165.0 170.0 162.0 161.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.50 stddev:29.26 (39.3%) stddev-sans-first:30.62 17:32:07 INFO - PID 29583 | Values: 74.0 75.0 73.0 167.0 75.0 74.0 76.0 87.0 101.0 74.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:80.00 stddev:23.98 (30.0%) stddev-sans-first:24.69 17:32:07 INFO - PID 29583 | Values: 78.0 79.0 134.0 80.0 80.0 80.0 125.0 80.0 80.0 128.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:32:07 INFO - PID 29583 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 115.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:32:07 INFO - PID 29583 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 147.0 148.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:32:07 INFO - PID 29583 | Values: 94.0 95.0 94.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 17:32:07 INFO - PID 29583 | Values: 53.0 54.0 53.0 53.0 54.0 53.0 54.0 53.0 54.0 53.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.50 stddev:0.52 (1.3%) stddev-sans-first:0.53 17:32:07 INFO - PID 29583 | Values: 38.0 38.0 38.0 38.0 39.0 39.0 38.0 38.0 39.0 39.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:2.00 (2.7%) stddev-sans-first:2.12 17:32:07 INFO - PID 29583 | Values: 75.0 74.0 74.0 79.0 73.0 75.0 73.0 78.0 74.0 75.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:125.00 stddev:16.59 (13.3%) stddev-sans-first:17.43 17:32:07 INFO - PID 29583 | Values: 120.0 131.0 124.0 118.0 126.0 116.0 116.0 115.0 128.0 171.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.00 stddev:4.53 (2.6%) stddev-sans-first:4.79 17:32:07 INFO - PID 29583 | Values: 173.0 175.0 170.0 173.0 168.0 170.0 167.0 166.0 180.0 177.0 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:2.12 (3.3%) stddev-sans-first:2.24 17:32:07 INFO - PID 29583 | Values: 64.0 63.0 66.0 68.0 62.0 66.0 63.0 64.0 67.0 62.0 17:32:07 INFO - PID 29583 | -------- Summary: end -------- 17:32:07 INFO - PID 29583 | 17:32:07 INFO - PID 29583 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:32:08 INFO - TEST-INFO | 29583: exit 0 17:32:08 INFO - TEST-OK | kraken | took 60280ms 17:32:08 INFO - SUITE-END | took 1171s 17:32:08 INFO - Completed test suite (00:19:31) 17:32:08 INFO - javascript benchmark 17:32:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8706.280990425845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.653956334585, 3333.2500187457827, 3354.7987120772773, 3357.6306606273306, 3372.9325413491715, 6399.264084630269, 6493.0, 6494.967525162368, 6510.316416776242, 6536.836579085525, 6358.586691865025, 6449.580777249487, 6450.870982580345, 6472.838179045514, 6574.079628851964, 5915.260592425947, 5991.400859914017, 6008.519318454535, 6044.788432404866, 6047.848803779897, 964.1585332193071, 5917.88164236715, 5919.6152250103605, 5931.466168044875, 6085.178500902388, 5919.289685237756, 5935.525157987372, 6004.09938509225, 6009.969950150265, 6038.0942858571125, 5926.555508336892, 5959.0, 5999.520038396918, 6022.277326720778, 6038.154658347835, 5931.762729490815, 5946.167536544844, 5968.582199246054, 5980.073088671263, 6015.27816661999, 6464.644444555547, 6484.902726459107, 6524.412802847719, 6532.608043517404, 6566.770163044271, 6772.153480814898, 6789.592624442549, 6859.485538584626, 6873.106496155518, 6892.241853396123, 6753.966230168867, 6767.458603311723, 6769.323067693241, 6946.687399067054, 7033.788986330418, 6429.0, 6443.967780161116, 6453.548251622436, 6460.967695161494, 6471.255805582324, 7072.080629518233, 7097.645117744195, 7163.140423149255, 7166.570005799565, 7216.242294559101, 6772.0857684212, 6792.320767923267, 6797.388235058769, 6871.244163142051, 6898.551594146365, 6798.762043328558, 6816.863662726718, 6867.828304292432, 6896.310368963063, 6899.0, 6872.62200578973, 6894.793156205322, 6897.517173797886, 6903.240643529208, 6904.861902762017, 6739.494537909578, 6832.6925288362145, 6847.075644787989, 6943.027976083353, 6956.8956465653055, 5373.973130134403, 5387.676739395649, 5389.7035663038905, 5393.946060539344, 5394.514493695508, 4730.290456431563, 4740.2178640523925, 4750.596199323028, 4801.735904525284, 4808.807647694053, 6047.758089676364, 6118.816435506942, 6130.754769809247, 6138.478229350466, 6158.353372895871, 6952.0, 6962.268961759044, 6976.581405115608, 7078.823029424306, 7079.1505019398, 5858.443447872445, 5937.139114828412, 6020.066889632114, 6072.332043475214, 6080.574359794772, 5864.06175011996, 5918.615290006136, 5967.791127310524, 5967.8209653710455, 5990.580659353804, 6620.073189753439, 6721.1598550181225, 6725.663716814238, 6732.057511948331, 6744.190697116279, 6911.654417279216, 6952.5480843745, 7007.089078419773, 7007.194172670208, 7016.614086225102, 6511.47908167336, 6622.536422450575, 6637.535372523877, 6640.203175618956, 6730.528862979741, 6788.76239331621, 6844.863102738017, 6845.178578570603, 6854.383105520527, 6854.451643868579, 6979.895301570582, 7060.682269297997, 7080.929190708027, 7084.397826184832, 7088.893666594902, 6723.159605049369, 6753.493487988322, 6811.318868113347, 6815.045893574805, 6847.965760171366, 6556.704948277244, 6623.602583844985, 6633.502487313374, 6656.633885136171, 6725.495587830835, 6530.738770449128, 6537.5750576212395, 6555.082288479712, 6561.1470508833545, 6564.606123632598, 6561.114249576246, 6588.077669126422, 6648.5678430901835, 6665.133532640726, 6677.43241824431, 6439.581427207217, 6444.806655800334, 6472.35276472349, 6473.611583305017, 6491.0], "value": 6272.441623428433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9062857771358, 859.312549960032, 886.6852267445059, 888.5468411110336, 1135.1372956553016, 30714.69285307146, 31093.222669433275, 40884.386734198975, 41428.58571414285, 41443.0, 41577.0, 41812.372814407805, 41822.58177418233, 41930.37104443436, 41931.79034104833, 7691.538507689556, 7711.537307761539, 7801.882971755428, 7893.250141236574, 7915.327197188217, 7716.5370077795515, 7797.0643522777345, 7799.259070388304, 7825.295723384894, 7840.255175758322, 7797.532148071134, 7828.256315650033, 7852.568108754016, 7862.842743145134, 7870.881936770953, 7830.6084695764985, 7840.0, 7859.842803143905, 7862.095858976205, 7863.410244231677, 7833.804154896116, 7839.0, 7853.607319633996, 7870.252326029018, 7876.881846772303, 37478.81260593679, 37836.81081594574, 37849.62150378488, 37891.43162852559, 37938.24123517514, 3549.236914063463, 3556.5376501054698, 3586.659267369596, 3595.7482976191677, 3598.6941110005682, 30999.690003099906, 31016.224594385094, 31138.221544461343, 31282.374352512823, 31295.0, 4976.7013979161, 5158.845234642967, 5247.921281180786, 5251.291075704808, 5252.921206181873, 192278.0, 193361.0, 193631.0318448413, 194226.0, 194384.0, 47640.76179619149, 48232.758836206296, 48273.75863120732, 48309.275360869615, 48344.27483587749, 51217.487825122014, 51555.7422212894, 51581.74209128931, 51612.22581661278, 51622.48377516252, 13399.397027133607, 15123.697526049418, 15366.769498457532, 15367.154806485527, 15390.3074361654, 11147.442627868573, 11780.94109529464, 12000.159988800875, 12027.639170824888, 12060.276383417024, 14366.0, 14373.209473479059, 14412.567622971328, 14494.855051449562, 14570.271486425636, 5705.572082093777, 5799.2750906136735, 5812.651240925558, 5966.671833049224, 6013.879722405527, 1007.6573964851839, 1021.4433133942019, 1028.1466382902174, 1039.77644806367, 1046.3930920066343, 22697.546049078926, 23515.764842351356, 29125.7087429123, 29565.408691826044, 30002.549961750592, 1080.989190108089, 1093.6937657455926, 1099.7470581766238, 1110.5502271580024, 1127.5095333529941, 12497.87502124967, 12565.87434125647, 12746.553870614669, 12762.489500420064, 12818.679533011562, 227060.0, 229598.0, 230753.0, 230823.0, 230965.0, 55967.44032559704, 56687.14969275464, 56696.0, 56713.43286567164, 57109.14336284959, 1444.248990524921, 1455.3960106555874, 1461.8245810502808, 1474.5723740115461, 1476.2766244540098, 27310.180694579194, 27531.0, 27847.86076069607, 27881.16356509308, 28243.43513129767, 37591.81204093962, 37668.81165594154, 37703.81148094242, 37718.8114059428, 37750.0, 199950.0, 200100.0, 201069.0, 201639.0, 202606.0, 34858.47712284369, 37055.44416833696, 37681.81159094187, 37926.431103532916, 37935.43096853605, 46699.76650116863, 46971.29543056789, 47631.76184119057, 47647.28529072136, 47751.28373074337, 33761.66238337683, 33987.66012339944, 34067.82966085154, 34143.317133657685, 34544.0, 33622.495662564594, 34032.65967340295, 34201.48697769585, 34375.656243437246, 34850.651493485755, 36882.63117368792, 38166.427503586914, 38473.615263847, 38494.42258366183, 38679.0, 33349.333013339114, 33369.83315083409, 33645.49531756977, 33787.3242535143, 34271.143221418664, 23557.882210588836, 24967.250982469828, 25085.0, 25468.49063018766, 25479.745202547736], "value": 17585.021782752192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4854082784667, 570.603430615722, 571.548476703404, 588.405710232665, 593.7684303121782, 22356.32931012068, 22982.0, 23199.768002319972, 23209.651855222186, 23216.41958951027, 25516.362090947736, 25886.482270354627, 26073.739262607367, 26077.21768346948, 26113.608295875576, 6522.967385163068, 6686.732530698766, 6688.832779180535, 6690.397864192221, 6696.129503164581, 6396.552241343108, 6470.320616335288, 6520.4131628153455, 6624.635645039521, 6665.200175978865, 6599.439047680953, 6620.04009418634, 6651.634160121192, 6655.1348324717965, 6656.467482601404, 6643.833904152387, 6644.568103073285, 6645.93354066458, 6657.633830139341, 6658.9001164982565, 6151.692415379258, 6158.815235542941, 6160.476359509447, 6163.876722465526, 6166.691665416712, 28471.71528284732, 29611.0, 29927.40145197084, 30034.699653003627, 30117.247068823235, 2064.721262629541, 2096.5597224582857, 2114.3656902929215, 2121.4908421978766, 2122.9893850530802, 19288.421347359603, 19840.60318793616, 19856.70214946777, 19857.50356241091, 19869.9006504968, 2415.2754173747803, 2452.3256104571205, 2459.6064629659168, 2464.6303054541963, 2513.6103903894927, 138156.0, 142624.28687856495, 142688.28655856758, 142836.0, 143213.2839335807, 14593.0, 14779.852201478063, 14847.257637118317, 14888.404463821542, 15364.769528457082, 23188.768112318998, 23464.530709386057, 23566.764332356455, 23571.7642823573, 23604.29187124389, 9834.409935403899, 9945.303828732063, 10048.447335396477, 10050.64822731201, 10166.390016599027, 9098.454092754457, 9174.67888623895, 9210.263178945668, 9241.861372079424, 9283.860742088875, 7802.843943121219, 11704.882951170379, 11718.589849355401, 11830.5859294926, 11861.822072668916, 4140.958590414118, 4165.791710414528, 4176.979115104405, 4313.719608225455, 4363.54556803995, 954.022127319503, 994.0904072773476, 1002.8245057115122, 1010.2675560218929, 1018.8064267789097, 20175.0, 20222.191112355635, 20427.897860510602, 20813.1674733012, 20834.791652083284, 1053.710229686827, 1054.7943151085617, 1067.5356220044305, 1067.6103222323952, 1069.6951368859993, 10991.945040274748, 11344.752077271494, 11458.140639452075, 13361.665958350924, 14382.856171438361, 504740.0, 506961.0, 529361.0, 535936.0, 543442.0, 116843.0, 123142.0, 126697.0, 132517.3374133123, 133190.0, 1200.9819852702042, 1249.0881656390886, 1269.2194300505123, 1270.6823294176456, 1274.0826604844312, 20608.58782824365, 20999.265025724028, 21062.57874842525, 21433.46416339604, 21798.237061702763, 59548.70225648844, 60325.39674603198, 60691.0, 61722.0741688884, 61885.38114618796, 71208.64395677988, 79725.60137199509, 80194.59902700449, 81654.0, 83499.0, 12298.508059677513, 13627.182369057888, 14613.85386146125, 15064.171470568786, 15167.165805880783, 22988.310350689506, 23697.763022369556, 23830.88084559566, 23880.0, 23959.52080958406, 18380.540486487946, 18754.343597974006, 18794.966276854357, 19004.144813483705, 19167.808321916604, 15876.52370428889, 15998.200089995686, 16586.83413165853, 16690.4158354457, 16887.0, 19133.139008744918, 19217.711734324275, 19359.3224237151, 19442.125104370054, 19458.124384403018, 14782.926085369505, 14804.185769782765, 14836.554903352917, 14861.479848205694, 14876.256187190813, 18057.819421805612, 18229.908850455664, 18475.90762046181, 18486.075696214866, 18489.81510184881], "value": 12518.188515000878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.2667033131777, 1379.806827044214, 1402.8877689784806, 1408.6407965968676, 1411.4213172599234, 12562.623121306364, 13167.670808229786, 15113.697726045473, 15620.687586248268, 15632.609184770386, 15116.395344186247, 15372.231388430562, 15374.0, 15380.307886145123, 15390.461333853318, 2798.566222235557, 2804.326961529234, 2861.4563232985665, 2862.155664079102, 2916.927076823086, 2843.5734639803986, 2872.5403935370346, 2872.9569056464065, 2874.741273285404, 2875.0943452812403, 2789.4142230131697, 2834.8582570871476, 2835.10694131349, 2841.5453527435616, 2842.189975856881, 2759.0, 2805.2145399288233, 2806.536921407965, 2808.0, 2808.0873716042165, 2749.8625068746483, 2756.324700448403, 2778.499870023395, 2779.5413756730113, 2791.52544067509, 15100.244987750679, 15144.621384465367, 15158.848411515854, 15188.392464301414, 15229.695406091927, 7905.920940790576, 8198.754037378889, 8210.425270231086, 8217.055038670569, 8218.096009438957, 5453.509184173444, 5692.943070569283, 5807.2160258365, 5851.736671849777, 5873.0, 1884.5382881194196, 1904.7428597139346, 1918.788933217359, 1963.7938016508347, 1966.4690533556002, 26107.477850443076, 26386.868065659743, 26428.47143057128, 26436.603450948252, 26573.73426265732, 6702.19573651165, 6803.7618683345845, 6983.441324694012, 7042.183126749342, 7083.6458177090935, 17111.486655400357, 17144.828551714323, 17159.0, 17166.828331716773, 17176.22706978164, 7849.411294152961, 8039.678412863537, 8049.718259860877, 8075.878861817077, 8082.797930051678, 7327.0, 7441.367483763833, 7488.663010164556, 7525.661345239478, 7560.546367217985, 5168.53483186515, 5301.920471192935, 5321.813736519203, 5323.733813309319, 5374.381946076173, 1533.0954736705398, 1535.7926679898294, 1538.4384699584796, 1551.0848599326453, 1551.2786554252102, 869.1135042256863, 879.4195830751801, 889.0753616239168, 894.4007514964989, 905.7554460295815, 7210.315020073084, 7221.819454513679, 8714.259287960595, 9138.451692898447, 9260.536973151315, 973.1630797514132, 979.4857699707568, 985.393982700634, 993.1756641987133, 1006.4615430744517, 4844.515548445127, 4977.303177555073, 4999.3000979862845, 5002.674826136362, 5026.421961474477, 21030.369088927357, 22201.666974995387, 22229.221977230718, 22235.444113897283, 22253.221137260443, 21153.0, 21434.678479822815, 21436.571268574855, 21784.891075544838, 22058.33824985253, 9914.355566888129, 11633.59282425128, 11858.940705296418, 11874.0500759939, 11889.108316876269, 6934.237233904166, 8262.215089566482, 8322.833543328978, 8695.695645653203, 8822.779430514289, 17684.381046663304, 17811.554711132325, 17976.10119493994, 18345.449636510926, 19599.216031359156, 18748.625027499646, 19401.51496212606, 19480.8051919479, 19534.120964556914, 19573.804261957197, 12047.0, 12209.267443953391, 12289.446974885972, 12375.195612285173, 12437.37813109359, 13999.790003149757, 14102.858971410154, 14130.293485325898, 14139.858601413855, 14141.787873182117, 11281.097512199169, 11330.0, 11400.771984560428, 11435.59975400857, 11621.6513504595, 10756.30084044566, 10756.784864302826, 10822.67531974042, 10949.343039417661, 11020.889791102307, 9540.809183816145, 9739.074787895139, 9762.414255144715, 9767.365121267096, 9773.169280611228, 6963.338482844122, 6965.895511567229, 6967.54710943787, 6975.372216500539, 6997.370236678723, 6884.208316043719, 6913.51605387618, 6917.757878474229, 6964.233934267125, 7015.123109611299], "value": 6735.764101805246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.8595230968773, 502.04110149614246, 528.709209934536, 531.3225637312423, 532.4994505165145, 6388.393102655252, 6419.9358006419925, 6486.156799616049, 6516.380943810336, 6534.248561415438, 6100.969495152529, 6182.814515564529, 6218.2639638559, 6239.500839932806, 6262.279837818653, 5045.344105266319, 5081.339425874631, 5091.567216786559, 5114.667546609477, 5125.205593133071, 4965.801367945278, 5099.541041306282, 5118.181091025418, 5128.692278463285, 5136.126858434057, 4963.677360971544, 4999.550040496355, 5014.899702005958, 5051.393832740058, 5069.619778516608, 5046.1926091825135, 5049.747512624354, 5051.696898186121, 5071.427857364229, 5081.923771143399, 4559.224931761609, 4572.474165470981, 4574.359589657451, 4588.701734387254, 4604.2633178691585, 6275.717592708339, 6294.590851594632, 6314.589551679126, 6367.745290188387, 6410.2628197757385, 5715.913976344481, 5752.0951919280915, 5786.594938354275, 5828.125781132821, 5833.183354330397, 6589.835254118638, 6623.172103487064, 6710.630915299656, 6724.899126513057, 6764.864702705919, 4905.8773530661665, 4941.343405879659, 4951.232558953368, 4952.777125029346, 4985.476524964899, 6988.44092472601, 7040.190378106532, 7044.612546309951, 7064.611446370499, 7083.114610673717, 5044.2937988681615, 5050.797968081236, 5071.264666623319, 5109.131447653907, 5109.616778741609, 5128.1794912813775, 5155.175171972542, 5158.329417175743, 5163.0, 5165.251038599382, 5702.372738998707, 5713.5714821388565, 5804.21643078179, 5823.388544202882, 5836.095405212199, 6604.702788374535, 6653.2681405045405, 6659.766908158192, 6659.833504162338, 6710.899336509956, 1649.5463747469541, 1707.5474999125242, 1720.1829131162597, 1739.7390391441386, 1750.2211515875313, 1192.7316353820322, 1237.9319137447526, 1243.384524660281, 1246.8940140088014, 1254.1785130739381, 5864.0, 5876.1479585459865, 5918.822435326947, 5933.703314834241, 5952.226210592682, 6637.159299816131, 6738.258791532928, 6821.69302381394, 6889.345512176335, 6903.930960690429, 5882.941170588325, 5937.882611628843, 5959.404059594006, 5962.612430192024, 5967.1347654589845, 3596.7122630189524, 3602.7478076534917, 3603.56757189139, 3621.7102631789394, 3667.211549516813, 6577.934220657828, 6619.5035372347265, 6629.303923088103, 6659.700313485905, 6677.966610166918, 7044.577325360495, 7048.753293634698, 7060.7881763547175, 7127.786166414912, 7138.678759455837, 6618.543920337518, 6629.86740265192, 6688.792698409513, 6696.19645642526, 6712.39588437043, 6921.2732663071665, 6951.756688515878, 6959.921212212115, 7008.719651213894, 7039.577625342496, 6754.89274933536, 6812.863742725019, 6837.418819400208, 6875.4155896749335, 6911.17065952089, 6592.406683398517, 6609.1408116944485, 6639.6680165992475, 6733.4513061996995, 6742.730290788313, 5023.799048038038, 5072.391313042459, 5103.974480127724, 5117.8720531987, 5131.7163862081015, 6747.932520674731, 6950.409215216763, 6965.686544105629, 7008.334208250208, 7052.435805135679, 6712.899306510309, 6741.94370716936, 6792.864142717217, 6799.422049125879, 6813.386795188457, 6254.937450625617, 6627.50293727982, 6645.900311495235, 6679.699413526306, 6702.19573651165, 6332.865231710333, 6464.935350646433, 6469.676516174079, 6540.705668244846, 6577.473802095917, 6631.0, 6648.16897887764, 6685.966570167313, 6737.3599508046655, 6753.86492270142, 6343.333949935375, 6360.886844802234, 6381.3937675920715, 6430.131932189094, 6467.547271690936], "value": 5152.258692382401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.4446287764465, 919.3334832246622, 928.5403725156049, 932.7901222225, 941.7457286532639, 18248.908755456236, 19176.90411547942, 19184.232630694754, 19212.61574768504, 20033.899830500864, 20618.793812061875, 21454.678179827275, 21573.784262157373, 21584.676229856566, 21597.784022159773, 918.4076270805326, 941.580996456577, 944.8393773058597, 947.0671388682142, 947.4552132523827, 949.4066208619613, 978.4080631218118, 985.069109691342, 989.1098011789411, 994.6319861651162, 1048.821700310949, 1049.1449468683, 1050.2070936443013, 1050.2858056521563, 1050.4590136079926, 1049.4280617063719, 1049.6431213387484, 1049.7165765243417, 1050.0811789684026, 1050.1651187306072, 766.2529034191674, 772.5635016215876, 772.8840673898904, 773.2847116417348, 774.3921021997704, 19240.422787316264, 19636.0, 19937.302194423126, 19981.60036799256, 20401.183952641877, 21107.68338474924, 21366.145354185814, 21911.890440547853, 21937.232196873192, 22211.666824997475, 16279.0, 16655.16724163799, 16716.331346746116, 16815.32738690463, 16837.66324673512, 3799.2401519696173, 3814.8664796731982, 3831.942520862189, 3832.463455116286, 3832.827522761482, 124025.37987310096, 129205.35397322953, 133629.0, 133913.0, 138112.0, 16841.747373789403, 17025.31898724062, 17502.737458938125, 17529.386471473437, 17581.82418175802, 29861.85069074684, 30331.0, 30425.391492170034, 30488.237794055327, 30583.0, 7908.960455197687, 8258.669653213805, 8808.47149171039, 9189.264858811279, 9256.7685807854, 4303.096349766584, 4399.6920215584605, 4399.846005389796, 4402.163588918095, 4404.185225733249, 5200.5059519345605, 5274.630775845654, 5321.3348331458565, 5343.091674415358, 5350.357957045102, 1040.292601031306, 1059.9364038157735, 1079.4764539198482, 1082.1505118482112, 1084.4089970965842, 698.7938558125365, 713.4078714666814, 715.2346988722018, 730.5470608222936, 738.9815254618677, 11455.484503197376, 11508.654740357802, 11512.827307590393, 11929.940350298193, 12048.939755301168, 706.5831159615749, 709.925457826931, 713.8929160625947, 717.9928200717926, 727.5707332673747, 5684.715764211773, 5704.914426283609, 5720.799772007959, 5929.881402371929, 5991.191189189491, 102564.0, 104976.0, 107759.46120269349, 108081.0, 109998.45000774944, 94971.0, 94990.05009949951, 95520.0, 95602.52198738961, 97123.0, 82594.58702706569, 84568.15431845727, 85373.0, 87047.0, 88212.5589372049, 11417.486213120263, 11728.237664551776, 11729.765404691687, 11995.460204291003, 12073.517059317528, 39506.802465987486, 40323.59676403199, 40842.38736419015, 41226.79386603048, 41715.0, 70995.64502177456, 72008.63995679987, 72501.0, 73314.0, 73934.0, 16724.58188545296, 17000.404985825437, 17007.659846803243, 17083.402080927604, 17307.3942412015, 18274.0, 18413.171407286973, 18436.631267374847, 18498.594142676284, 18552.628947421246, 14475.710485790436, 15590.688186235984, 15722.528324150293, 15791.763123552926, 15968.680626387639, 17358.39245626397, 17552.82447175512, 17615.911920440314, 17753.289868405118, 17784.644307113525, 16267.75598366049, 16381.180940953143, 16752.916235418747, 16816.411425600047, 16947.406840761007, 11795.174337796272, 11871.76256474883, 11927.642170734893, 12209.145359825083, 12327.198732082386, 13929.860701392856, 14239.715205696035, 14302.427902883768, 14579.343929522985, 14615.780763288773], "value": 9087.92305030081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 114.0, 100.0, 109.0, 109.0, 113.0, 109.0, 105.0, 107.0, 109.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 150.0, 183.0, 120.0, 143.0, 142.0, 119.0, 173.0, 120.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 165.0, 162.0, 164.0, 165.0, 170.0, 162.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 167.0, 75.0, 74.0, 76.0, 87.0, 101.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 134.0, 80.0, 80.0, 80.0, 125.0, 80.0, 80.0, 128.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0, 39.0, 39.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 79.0, 73.0, 75.0, 73.0, 78.0, 74.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 124.0, 118.0, 126.0, 116.0, 116.0, 115.0, 128.0, 171.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 170.0, 173.0, 168.0, 170.0, 167.0, 166.0, 180.0, 177.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 68.0, 62.0, 66.0, 63.0, 64.0, 67.0, 62.0], "value": 64.5, "unit": "score"}]}]} 17:32:08 INFO - Return code: 0 17:32:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:08 INFO - # TBPL SUCCESS # 17:32:08 INFO - Running post-action listener: _package_coverage_data 17:32:08 INFO - Running post-action listener: _resource_record_post_action 17:32:08 INFO - [mozharness: 2017-09-01 00:32:08.383665Z] Finished run-tests step (success) 17:32:08 INFO - Running post-run listener: _resource_record_post_run 17:32:08 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 16384; Write bytes: 395616256; Read time: 232; Write time: 246520 17:32:08 INFO - TinderboxPrint: CPU usage
13.1% 17:32:08 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 232 17:32:08 INFO - TinderboxPrint: I/O write bytes / time
395,616,256 / 246,520 17:32:08 INFO - TinderboxPrint: CPU idle
8,230.8 (86.9%) 17:32:08 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 17:32:08 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109465600; Read time: 68; Write time: 102100 17:32:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:32:08 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 286150656; Read time: 164; Write time: 144420 17:32:09 INFO - Running post-run listener: _upload_blobber_files 17:32:09 INFO - Blob upload gear active. 17:32:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:32:09 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'] 17:32:09 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 17:32:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:10 INFO - (blobuploader) - INFO - Done attempting. 17:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:17 INFO - (blobuploader) - INFO - Done attempting. 17:32:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:32:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:32:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:18 INFO - (blobuploader) - INFO - Done attempting. 17:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:19 INFO - (blobuploader) - INFO - Done attempting. 17:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:19 INFO - Return code: 0 17:32:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4daf5dd5ff8cfbe4f20eac8a34aec79c95c6987656c19f9edff2a080e18c876b02e955f08d7c41721014d31986827eca387d0477c3a9df105e4f78f7a09e5c68", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87079c97631cbd62e8b3795654c3be9ac25f7ec65b47ed835d1f3d119d63f1a2b58e3d7ba47e79c829f829a78a41d5b46beeaa7bae307a3722b302b555929ed0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7a82159b497ca366a9f4a90a82d02930058923a24626469cf0225acb767a40fcd20cf13a7b7e9f380bad573ababc2543e0f8ebfac9ed7895590d5b0457cef0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c363eaf4386587ddb8c8a918e8b5bd359a46cd5480ea494ac2b8a5ec3b79a985ea855dc3da52fc51ef1ebd4a93ea791c7f2f6d9fbc6f7893fd44f4fcd4f96f4"} 17:32:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:19 INFO - Contents: 17:32:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4daf5dd5ff8cfbe4f20eac8a34aec79c95c6987656c19f9edff2a080e18c876b02e955f08d7c41721014d31986827eca387d0477c3a9df105e4f78f7a09e5c68", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87079c97631cbd62e8b3795654c3be9ac25f7ec65b47ed835d1f3d119d63f1a2b58e3d7ba47e79c829f829a78a41d5b46beeaa7bae307a3722b302b555929ed0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7a82159b497ca366a9f4a90a82d02930058923a24626469cf0225acb767a40fcd20cf13a7b7e9f380bad573ababc2543e0f8ebfac9ed7895590d5b0457cef0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c363eaf4386587ddb8c8a918e8b5bd359a46cd5480ea494ac2b8a5ec3b79a985ea855dc3da52fc51ef1ebd4a93ea791c7f2f6d9fbc6f7893fd44f4fcd4f96f4"} 17:32:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:19 INFO - Copying logs to upload dir... 17:32:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.621067 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-31 17:32:19.821144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 17:32:19.825194) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4daf5dd5ff8cfbe4f20eac8a34aec79c95c6987656c19f9edff2a080e18c876b02e955f08d7c41721014d31986827eca387d0477c3a9df105e4f78f7a09e5c68", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87079c97631cbd62e8b3795654c3be9ac25f7ec65b47ed835d1f3d119d63f1a2b58e3d7ba47e79c829f829a78a41d5b46beeaa7bae307a3722b302b555929ed0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7a82159b497ca366a9f4a90a82d02930058923a24626469cf0225acb767a40fcd20cf13a7b7e9f380bad573ababc2543e0f8ebfac9ed7895590d5b0457cef0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c363eaf4386587ddb8c8a918e8b5bd359a46cd5480ea494ac2b8a5ec3b79a985ea855dc3da52fc51ef1ebd4a93ea791c7f2f6d9fbc6f7893fd44f4fcd4f96f4"} build_url:https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/VwskOH_MSgKsTQf61Zi0cg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4daf5dd5ff8cfbe4f20eac8a34aec79c95c6987656c19f9edff2a080e18c876b02e955f08d7c41721014d31986827eca387d0477c3a9df105e4f78f7a09e5c68", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87079c97631cbd62e8b3795654c3be9ac25f7ec65b47ed835d1f3d119d63f1a2b58e3d7ba47e79c829f829a78a41d5b46beeaa7bae307a3722b302b555929ed0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f7a82159b497ca366a9f4a90a82d02930058923a24626469cf0225acb767a40fcd20cf13a7b7e9f380bad573ababc2543e0f8ebfac9ed7895590d5b0457cef0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c363eaf4386587ddb8c8a918e8b5bd359a46cd5480ea494ac2b8a5ec3b79a985ea855dc3da52fc51ef1ebd4a93ea791c7f2f6d9fbc6f7893fd44f4fcd4f96f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 17:32:19.859940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:32:19.860284) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1504221503.958633-799554259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 17:32:19.942863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 17:32:19.947997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 17:32:19.948508) ========= ========= Total master_lag: 0.32 =========