builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1503267450.7 results: success (0) revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.702380) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.702748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.703020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.760702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.761021) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 15:17:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2017-08-20 15:17:31 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.974817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.975095) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014278 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:31.039256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-20 15:17:31.039578) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --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 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --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=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 15:17:31,189 truncating revision to first 12 chars 2017-08-20 15:17:31,189 Setting DEBUG logging. 2017-08-20 15:17:31,189 attempt 1/10 2017-08-20 15:17:31,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7dddbd85047c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 15:17:31,912 attempt 1/10 2017-08-20 15:17:32,590 current task status: no status available at this point. state: STARTED 2017-08-20 15:17:32,590 sleeping for 10.00s (attempt 1/10) 2017-08-20 15:17:42,600 attempt 2/10 2017-08-20 15:17:43,007 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-20 15:17:43,221 unpacking tar archive at: mozilla-central-7dddbd85047c/testing/mozharness/ program finished with exit code 0 elapsedTime=12.362212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-20 15:17:43.415663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.415954) ========= script_repo_revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.419335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.419604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.431582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-20 15:17:43.431858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:43 INFO - MultiFileLogger online at 20170820 15:17:43 in /builds/slave/test 15:17:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:17:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:43 INFO - {'append_to_log': False, 15:17:43 INFO - 'base_work_dir': '/builds/slave/test', 15:17:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:17:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:43 INFO - 'branch': 'Firefox-Non-PGO', 15:17:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:43 INFO - 'code_coverage': False, 15:17:43 INFO - 'config_files': ('talos/linux_config.py',), 15:17:43 INFO - 'default_actions': ('clobber', 15:17:43 INFO - 'read-buildbot-config', 15:17:43 INFO - 'download-and-extract', 15:17:43 INFO - 'populate-webroot', 15:17:43 INFO - 'create-virtualenv', 15:17:43 INFO - 'install', 15:17:43 INFO - 'setup-mitmproxy', 15:17:43 INFO - 'run-tests'), 15:17:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:43 INFO - 'disable_ccov_upload': False, 15:17:43 INFO - 'download_minidump_stackwalk': True, 15:17:43 INFO - 'download_symbols': 'ondemand', 15:17:43 INFO - 'enable_stylo': False, 15:17:43 INFO - 'enable_webrender': False, 15:17:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:43 INFO - 'gecko_profile': False, 15:17:43 INFO - 'gecko_profile_interval': 0, 15:17:43 INFO - 'installer_path': 'installer.exe', 15:17:43 INFO - 'log_level': 'info', 15:17:43 INFO - 'log_name': 'talos', 15:17:43 INFO - 'log_to_console': True, 15:17:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:43 INFO - 'opt_config_files': (), 15:17:43 INFO - 'pip_index': False, 15:17:43 INFO - 'suite': 'dromaeojs-e10s', 15:17:43 INFO - 'system_bits': '32', 15:17:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:43 INFO - 'title': 'talos-linux64-ix-037', 15:17:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:43 INFO - 'use_talos_json': True, 15:17:43 INFO - 'verify': 'False', 15:17:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:43 INFO - 'work_dir': 'build'} 15:17:43 INFO - [mozharness: 2017-08-20 22:17:43.724124Z] Running clobber step. 15:17:43 INFO - Running pre-action listener: _resource_record_pre_action 15:17:43 INFO - Running main action method: clobber 15:17:43 INFO - rmtree: /builds/slave/test/build 15:17:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:44 INFO - Running post-action listener: _resource_record_post_action 15:17:44 INFO - [mozharness: 2017-08-20 22:17:44.735172Z] Finished clobber step (success) 15:17:44 INFO - [mozharness: 2017-08-20 22:17:44.735270Z] Running read-buildbot-config step. 15:17:44 INFO - Running pre-action listener: _resource_record_pre_action 15:17:44 INFO - Running main action method: read_buildbot_config 15:17:44 INFO - Using buildbot properties: 15:17:44 INFO - { 15:17:44 INFO - "project": "", 15:17:44 INFO - "product": "firefox", 15:17:44 INFO - "who": "archaeopteryx@coole-files.de", 15:17:44 INFO - "installer_path": "public/build/target.tar.bz2", 15:17:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:17:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:17:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:17:44 INFO - "stage_platform": "linux64", 15:17:44 INFO - "basedir": "/builds/slave/test", 15:17:44 INFO - "buildnumber": 780, 15:17:44 INFO - "platform": "ubuntu64_hw", 15:17:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:17:44 INFO - "slavebuilddir": "test", 15:17:44 INFO - "taskId": "cBGg1bayR1OL77xXmdR5TA", 15:17:44 INFO - "branch": "mozilla-central", 15:17:44 INFO - "script_repo_revision": "production", 15:17:44 INFO - "revision": "7dddbd85047c6dc73ddbe1e423cd643a217845b3", 15:17:44 INFO - "slavename": "talos-linux64-ix-037", 15:17:44 INFO - "repo_path": "mozilla-central" 15:17:44 INFO - } 15:17:44 INFO - Finding installer, test and symbols from parent task. 15:17:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBGg1bayR1OL77xXmdR5TA'}, attempt #1 15:17:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBGg1bayR1OL77xXmdR5TA'}, attempt #1 15:17:45 INFO - Task dependencies: W2sfHt0TS8KDAxRbisPdNA 15:17:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA'}, attempt #1 15:17:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:17:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip 15:17:46 INFO - Running post-action listener: _resource_record_post_action 15:17:46 INFO - [mozharness: 2017-08-20 22:17:46.088564Z] Finished read-buildbot-config step (success) 15:17:46 INFO - [mozharness: 2017-08-20 22:17:46.088781Z] Running download-and-extract step. 15:17:46 INFO - Running pre-action listener: _resource_record_pre_action 15:17:46 INFO - Running main action method: download_and_extract 15:17:46 INFO - mkdir: /builds/slave/test/build/tests 15:17:46 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')]} 15:17:46 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:17:46 INFO - Downloaded 989 bytes. 15:17:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:17:46 INFO - Using the following test package requirements: 15:17:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:17:46 INFO - u'common': [u'target.common.tests.zip'], 15:17:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:17:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:17:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:17:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:17:46 INFO - u'mozbase': [u'target.common.tests.zip'], 15:17:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:17:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:17:46 INFO - u'web-platform': [u'target.common.tests.zip', 15:17:46 INFO - u'target.web-platform.tests.tar.gz'], 15:17:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:17:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:17:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:17:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:17:46 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:17:48 INFO - Content-Length response header: 54005757 15:17:48 INFO - Bytes received: 54005757 15:17:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:17:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:17:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:17:58 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:18:00 INFO - Content-Length response header: 54005757 15:18:00 INFO - Bytes received: 54005757 15:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip 15:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip into memory 15:18:13 INFO - Content-Length response header: 14496256 15:18:13 INFO - Bytes received: 14496256 15:18:14 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')]} 15:18:14 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:14 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:18:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:18:15 INFO - Downloaded 62126211 bytes. 15:18:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:15 INFO - mkdir: /builds/slave/test/properties 15:18:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:15 INFO - Contents: 15:18:15 INFO - build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:15 INFO - Running post-action listener: _resource_record_post_action 15:18:15 INFO - Running post-action listener: find_tests_for_verification 15:18:15 INFO - Running post-action listener: set_extra_try_arguments 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.508169Z] Finished download-and-extract step (success) 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.508267Z] Running populate-webroot step. 15:18:15 INFO - Running pre-action listener: _resource_record_pre_action 15:18:15 INFO - Running main action method: populate_webroot 15:18:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:15 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:15 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:15 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['damp', 'tps']}, 15:18:15 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['damp', 'tps']}, 15:18:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:18:15 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:18:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:15 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:15 INFO - 'ts_paint', 15:18:15 INFO - 'tpaint', 15:18:15 INFO - 'sessionrestore', 15:18:15 INFO - 'sessionrestore_many_windows', 15:18:15 INFO - 'sessionrestore_no_auto_restore', 15:18:15 INFO - 'tabpaint']}, 15:18:15 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['a11yr', 15:18:15 INFO - 'ts_paint', 15:18:15 INFO - 'tpaint', 15:18:15 INFO - 'sessionrestore', 15:18:15 INFO - 'sessionrestore_many_windows', 15:18:15 INFO - 'sessionrestore_no_auto_restore', 15:18:15 INFO - 'tabpaint']}, 15:18:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:18:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:18:15 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['bloom_basic_singleton']}, 15:18:15 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['bloom_basic']}, 15:18:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:15 INFO - 'tsvgr_opacity', 15:18:15 INFO - 'tart', 15:18:15 INFO - 'tscrollx', 15:18:15 INFO - 'tsvg_static']}, 15:18:15 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tsvgx', 15:18:15 INFO - 'tsvgr_opacity', 15:18:15 INFO - 'tart', 15:18:15 INFO - 'tscrollx', 15:18:15 INFO - 'tsvg_static']}, 15:18:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:18:15 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tp5o']}, 15:18:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--stylo-threads=1', 15:18:15 INFO - '--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--xperf_path', 15:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:15 INFO - 'tests': ['tp5n']}, 15:18:15 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--xperf_path', 15:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:15 INFO - 'tests': ['tp5n']}}} 15:18:15 INFO - Running post-action listener: _resource_record_post_action 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.522529Z] Finished populate-webroot step (success) 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.522618Z] Running create-virtualenv step. 15:18:15 INFO - Running pre-action listener: _resource_record_pre_action 15:18:15 INFO - Running main action method: create_virtualenv 15:18:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:18:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:18:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:15 INFO - Using real prefix '/usr' 15:18:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:18 INFO - Installing pip.................done. 15:18:18 INFO - Return code: 0 15:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:18:18 INFO - Reading from file tmpfile_stdout 15:18:18 INFO - Output received: 15:18:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18:18 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')]} 15:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:18 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')]} 15:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:18 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:18 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 15:18:18 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 15:18:18 INFO - Using env: {'DISPLAY': ':0', 15:18:18 INFO - 'HOME': '/home/cltbld', 15:18:18 INFO - 'LANG': 'en_US.UTF-8', 15:18:18 INFO - 'LANGUAGE': 'en_US:en', 15:18:18 INFO - 'LOGNAME': 'cltbld', 15:18:18 INFO - 'MAIL': '/var/mail/cltbld', 15:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:18 INFO - 'MOZ_NO_REMOTE': '1', 15:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:18 INFO - 'NO_EM_RESTART': '1', 15:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:18 INFO - 'PWD': '/builds/slave/test', 15:18:18 INFO - 'SHELL': '/bin/bash', 15:18:18 INFO - 'SHLVL': '1', 15:18:18 INFO - 'TERM': 'linux', 15:18:18 INFO - 'TMOUT': '86400', 15:18:18 INFO - 'USER': 'cltbld', 15:18:18 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:18 INFO - '_': '/tools/buildbot/bin/python'} 15:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:18:18 INFO - Cleaning up... 15:18:18 INFO - Return code: 0 15:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18:18 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')]} 15:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:18 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')]} 15:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:18 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:18 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 15:18:18 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 15:18:18 INFO - Using env: {'DISPLAY': ':0', 15:18:18 INFO - 'HOME': '/home/cltbld', 15:18:18 INFO - 'LANG': 'en_US.UTF-8', 15:18:18 INFO - 'LANGUAGE': 'en_US:en', 15:18:18 INFO - 'LOGNAME': 'cltbld', 15:18:18 INFO - 'MAIL': '/var/mail/cltbld', 15:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:18 INFO - 'MOZ_NO_REMOTE': '1', 15:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:18 INFO - 'NO_EM_RESTART': '1', 15:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:18 INFO - 'PWD': '/builds/slave/test', 15:18:18 INFO - 'SHELL': '/bin/bash', 15:18:18 INFO - 'SHLVL': '1', 15:18:18 INFO - 'TERM': 'linux', 15:18:18 INFO - 'TMOUT': '86400', 15:18:18 INFO - 'USER': 'cltbld', 15:18:18 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:18 INFO - '_': '/tools/buildbot/bin/python'} 15:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:18 INFO - Downloading/unpacking psutil>=3.1.1 15:18:18 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 15:18:18 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 15:18:18 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 15:18:18 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 15:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:20 INFO - Installing collected packages: psutil 15:18:20 INFO - Running setup.py install for psutil 15:18:20 INFO - building 'psutil._psutil_linux' extension 15:18:20 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 15:18:20 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 15:18:20 INFO - building 'psutil._psutil_posix' extension 15:18:20 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 15:18:20 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 15:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:20 INFO - Successfully installed psutil 15:18:20 INFO - Cleaning up... 15:18:20 INFO - Return code: 0 15:18:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:20 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:20 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 15:18:20 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 15:18:20 INFO - Using env: {'DISPLAY': ':0', 15:18:20 INFO - 'HOME': '/home/cltbld', 15:18:20 INFO - 'LANG': 'en_US.UTF-8', 15:18:20 INFO - 'LANGUAGE': 'en_US:en', 15:18:20 INFO - 'LOGNAME': 'cltbld', 15:18:20 INFO - 'MAIL': '/var/mail/cltbld', 15:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:20 INFO - 'MOZ_NO_REMOTE': '1', 15:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:20 INFO - 'NO_EM_RESTART': '1', 15:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:20 INFO - 'PWD': '/builds/slave/test', 15:18:20 INFO - 'SHELL': '/bin/bash', 15:18:20 INFO - 'SHLVL': '1', 15:18:20 INFO - 'TERM': 'linux', 15:18:20 INFO - 'TMOUT': '86400', 15:18:20 INFO - 'USER': 'cltbld', 15:18:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:20 INFO - '_': '/tools/buildbot/bin/python'} 15:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:18:20 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 15:18:20 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 15:18:20 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 15:18:20 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 15:18:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:18:22 INFO - Installing collected packages: mozsystemmonitor 15:18:22 INFO - Running setup.py install for mozsystemmonitor 15:18:22 INFO - Successfully installed mozsystemmonitor 15:18:22 INFO - Cleaning up... 15:18:22 INFO - Return code: 0 15:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:18:22 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')]} 15:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:22 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')]} 15:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:22 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:22 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 15:18:22 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 15:18:22 INFO - Using env: {'DISPLAY': ':0', 15:18:22 INFO - 'HOME': '/home/cltbld', 15:18:22 INFO - 'LANG': 'en_US.UTF-8', 15:18:22 INFO - 'LANGUAGE': 'en_US:en', 15:18:22 INFO - 'LOGNAME': 'cltbld', 15:18:22 INFO - 'MAIL': '/var/mail/cltbld', 15:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:22 INFO - 'MOZ_NO_REMOTE': '1', 15:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:22 INFO - 'NO_EM_RESTART': '1', 15:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:22 INFO - 'PWD': '/builds/slave/test', 15:18:22 INFO - 'SHELL': '/bin/bash', 15:18:22 INFO - 'SHLVL': '1', 15:18:22 INFO - 'TERM': 'linux', 15:18:22 INFO - 'TMOUT': '86400', 15:18:22 INFO - 'USER': 'cltbld', 15:18:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:22 INFO - '_': '/tools/buildbot/bin/python'} 15:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:18:22 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 15:18:22 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 15:18:22 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 15:18:22 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 15:18:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:23 INFO - warning: no files found matching '*.txt' 15:18:23 INFO - no previously-included directories found matching 'build' 15:18:23 INFO - no previously-included directories found matching 'dist' 15:18:23 INFO - no previously-included directories found matching '.git*' 15:18:23 INFO - Installing collected packages: jsonschema, functools32 15:18:23 INFO - Running setup.py install for functools32 15:18:23 INFO - warning: no files found matching '*.txt' 15:18:23 INFO - no previously-included directories found matching 'build' 15:18:23 INFO - no previously-included directories found matching 'dist' 15:18:23 INFO - no previously-included directories found matching '.git*' 15:18:23 INFO - Successfully installed jsonschema functools32 15:18:23 INFO - Cleaning up... 15:18:24 INFO - Return code: 0 15:18:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:18:24 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')]} 15:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:24 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')]} 15:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:24 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:24 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 15:18:24 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 15:18:24 INFO - Using env: {'DISPLAY': ':0', 15:18:24 INFO - 'HOME': '/home/cltbld', 15:18:24 INFO - 'LANG': 'en_US.UTF-8', 15:18:24 INFO - 'LANGUAGE': 'en_US:en', 15:18:24 INFO - 'LOGNAME': 'cltbld', 15:18:24 INFO - 'MAIL': '/var/mail/cltbld', 15:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:24 INFO - 'MOZ_NO_REMOTE': '1', 15:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:24 INFO - 'NO_EM_RESTART': '1', 15:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:24 INFO - 'PWD': '/builds/slave/test', 15:18:24 INFO - 'SHELL': '/bin/bash', 15:18:24 INFO - 'SHLVL': '1', 15:18:24 INFO - 'TERM': 'linux', 15:18:24 INFO - 'TMOUT': '86400', 15:18:24 INFO - 'USER': 'cltbld', 15:18:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:24 INFO - '_': '/tools/buildbot/bin/python'} 15:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:18:24 INFO - Cleaning up... 15:18:24 INFO - Return code: 0 15:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:18:24 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')]} 15:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:24 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')]} 15:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:24 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:24 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 15:18:24 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 15:18:24 INFO - Using env: {'DISPLAY': ':0', 15:18:24 INFO - 'HOME': '/home/cltbld', 15:18:24 INFO - 'LANG': 'en_US.UTF-8', 15:18:24 INFO - 'LANGUAGE': 'en_US:en', 15:18:24 INFO - 'LOGNAME': 'cltbld', 15:18:24 INFO - 'MAIL': '/var/mail/cltbld', 15:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:24 INFO - 'MOZ_NO_REMOTE': '1', 15:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:24 INFO - 'NO_EM_RESTART': '1', 15:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:24 INFO - 'PWD': '/builds/slave/test', 15:18:24 INFO - 'SHELL': '/bin/bash', 15:18:24 INFO - 'SHLVL': '1', 15:18:24 INFO - 'TERM': 'linux', 15:18:24 INFO - 'TMOUT': '86400', 15:18:24 INFO - 'USER': 'cltbld', 15:18:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:24 INFO - '_': '/tools/buildbot/bin/python'} 15:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:24 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 15:18:24 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 15:18:24 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 15:18:24 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 15:18:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:18:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:26 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 15:18:26 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 15:18:26 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 15:18:26 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 15:18:26 INFO - Downloading docopt-0.6.1.tar.gz 15:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:26 INFO - Running setup.py install for blobuploader 15:18:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:18:26 INFO - Running setup.py install for requests 15:18:26 INFO - Running setup.py install for docopt 15:18:26 INFO - Successfully installed blobuploader requests docopt 15:18:26 INFO - Cleaning up... 15:18:26 INFO - Return code: 0 15:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:26 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')]} 15:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:26 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')]} 15:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:26 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:26 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 15:18:26 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 15:18:26 INFO - Using env: {'DISPLAY': ':0', 15:18:26 INFO - 'HOME': '/home/cltbld', 15:18:26 INFO - 'LANG': 'en_US.UTF-8', 15:18:26 INFO - 'LANGUAGE': 'en_US:en', 15:18:26 INFO - 'LOGNAME': 'cltbld', 15:18:26 INFO - 'MAIL': '/var/mail/cltbld', 15:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:26 INFO - 'MOZ_NO_REMOTE': '1', 15:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:26 INFO - 'NO_EM_RESTART': '1', 15:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:26 INFO - 'PWD': '/builds/slave/test', 15:18:26 INFO - 'SHELL': '/bin/bash', 15:18:26 INFO - 'SHLVL': '1', 15:18:26 INFO - 'TERM': 'linux', 15:18:26 INFO - 'TMOUT': '86400', 15:18:26 INFO - 'USER': 'cltbld', 15:18:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:26 INFO - '_': '/tools/buildbot/bin/python'} 15:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:27 INFO - Running setup.py (path:/tmp/pip-ecIJcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:27 INFO - Running setup.py (path:/tmp/pip-ESTIKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:27 INFO - Running setup.py (path:/tmp/pip-Mcn67a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:27 INFO - Running setup.py (path:/tmp/pip-HgAjBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:27 INFO - Running setup.py (path:/tmp/pip-2J4Cd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:27 INFO - Running setup.py (path:/tmp/pip-41Uiw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:27 INFO - Running setup.py (path:/tmp/pip-MV4TWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:27 INFO - Running setup.py (path:/tmp/pip-MYLqjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:27 INFO - Running setup.py (path:/tmp/pip-qoCxib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:27 INFO - Running setup.py (path:/tmp/pip-6nHMjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:27 INFO - Running setup.py (path:/tmp/pip-liNNv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:27 INFO - Running setup.py (path:/tmp/pip-kv4OUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:28 INFO - Running setup.py (path:/tmp/pip-xI1naD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:28 INFO - Running setup.py (path:/tmp/pip-IWIGXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:28 INFO - Running setup.py (path:/tmp/pip-bh2YPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:28 INFO - Running setup.py (path:/tmp/pip-mIknqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:28 INFO - Running setup.py (path:/tmp/pip-HH__wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:28 INFO - Running setup.py install for manifestparser 15:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozcrash 15:18:28 INFO - Running setup.py install for mozdebug 15:18:28 INFO - Running setup.py install for mozdevice 15:18:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozfile 15:18:28 INFO - Running setup.py install for mozhttpd 15:18:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozinfo 15:18:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozInstall 15:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozleak 15:18:29 INFO - Running setup.py install for mozlog 15:18:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for moznetwork 15:18:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozprocess 15:18:29 INFO - Running setup.py install for mozprofile 15:18:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozrunner 15:18:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozscreenshot 15:18:29 INFO - Running setup.py install for moztest 15:18:30 INFO - Running setup.py install for mozversion 15:18:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:18:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:30 INFO - Cleaning up... 15:18:30 INFO - Return code: 0 15:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:30 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:30 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 15:18:30 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 15:18:30 INFO - Using env: {'DISPLAY': ':0', 15:18:30 INFO - 'HOME': '/home/cltbld', 15:18:30 INFO - 'LANG': 'en_US.UTF-8', 15:18:30 INFO - 'LANGUAGE': 'en_US:en', 15:18:30 INFO - 'LOGNAME': 'cltbld', 15:18:30 INFO - 'MAIL': '/var/mail/cltbld', 15:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:30 INFO - 'MOZ_NO_REMOTE': '1', 15:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:30 INFO - 'NO_EM_RESTART': '1', 15:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:30 INFO - 'PWD': '/builds/slave/test', 15:18:30 INFO - 'SHELL': '/bin/bash', 15:18:30 INFO - 'SHLVL': '1', 15:18:30 INFO - 'TERM': 'linux', 15:18:30 INFO - 'TMOUT': '86400', 15:18:30 INFO - 'USER': 'cltbld', 15:18:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:30 INFO - '_': '/tools/buildbot/bin/python'} 15:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:30 INFO - Running setup.py (path:/tmp/pip-HR0Owb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:30 INFO - Running setup.py (path:/tmp/pip-sC2lFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:30 INFO - Running setup.py (path:/tmp/pip-RZllKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:30 INFO - Running setup.py (path:/tmp/pip-fP055O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:30 INFO - Running setup.py (path:/tmp/pip-61CbRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:30 INFO - Running setup.py (path:/tmp/pip-NRxDkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:30 INFO - Running setup.py (path:/tmp/pip-MeKUfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:30 INFO - Running setup.py (path:/tmp/pip-J5ejB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:30 INFO - Running setup.py (path:/tmp/pip-F5qDEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:31 INFO - Running setup.py (path:/tmp/pip-8kQELz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:31 INFO - Running setup.py (path:/tmp/pip-_EZORO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:31 INFO - Running setup.py (path:/tmp/pip-kGIkYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:31 INFO - Running setup.py (path:/tmp/pip-_KtU7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:31 INFO - Running setup.py (path:/tmp/pip-kYUmY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:31 INFO - Running setup.py (path:/tmp/pip-IXKmE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:31 INFO - Running setup.py (path:/tmp/pip-naE3rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:31 INFO - Running setup.py (path:/tmp/pip-maebYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:32 INFO - Downloading blessings-1.6.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:32 INFO - Installing collected packages: blessings 15:18:32 INFO - Running setup.py install for blessings 15:18:32 INFO - Successfully installed blessings 15:18:32 INFO - Cleaning up... 15:18:32 INFO - Return code: 0 15:18:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:33 INFO - Reading from file tmpfile_stdout 15:18:33 INFO - Current package versions: 15:18:33 INFO - argparse == 1.2.1 15:18:33 INFO - blessings == 1.6 15:18:33 INFO - blobuploader == 1.2.4 15:18:33 INFO - docopt == 0.6.1 15:18:33 INFO - functools32 == 3.2.3-2 15:18:33 INFO - jsonschema == 2.5.1 15:18:33 INFO - manifestparser == 1.1 15:18:33 INFO - mozInstall == 1.13 15:18:33 INFO - mozcrash == 1.0 15:18:33 INFO - mozdebug == 0.1 15:18:33 INFO - mozdevice == 0.51 15:18:33 INFO - mozfile == 1.2 15:18:33 INFO - mozhttpd == 0.7 15:18:33 INFO - mozinfo == 0.10 15:18:33 INFO - mozleak == 0.1 15:18:33 INFO - mozlog == 3.5 15:18:33 INFO - moznetwork == 0.27 15:18:33 INFO - mozprocess == 0.25 15:18:33 INFO - mozprofile == 0.28 15:18:33 INFO - mozrunner == 6.13 15:18:33 INFO - mozscreenshot == 0.1 15:18:33 INFO - mozsystemmonitor == 0.3 15:18:33 INFO - moztest == 0.8 15:18:33 INFO - mozversion == 1.4 15:18:33 INFO - psutil == 3.1.1 15:18:33 INFO - requests == 1.2.3 15:18:33 INFO - wsgiref == 0.1.2 15:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:33 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')]} 15:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:33 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')]} 15:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:33 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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:33 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 15:18:33 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 15:18:33 INFO - Using env: {'DISPLAY': ':0', 15:18:33 INFO - 'HOME': '/home/cltbld', 15:18:33 INFO - 'LANG': 'en_US.UTF-8', 15:18:33 INFO - 'LANGUAGE': 'en_US:en', 15:18:33 INFO - 'LOGNAME': 'cltbld', 15:18:33 INFO - 'MAIL': '/var/mail/cltbld', 15:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:33 INFO - 'MOZ_NO_REMOTE': '1', 15:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:33 INFO - 'NO_EM_RESTART': '1', 15:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:33 INFO - 'PWD': '/builds/slave/test', 15:18:33 INFO - 'SHELL': '/bin/bash', 15:18:33 INFO - 'SHLVL': '1', 15:18:33 INFO - 'TERM': 'linux', 15:18:33 INFO - 'TMOUT': '86400', 15:18:33 INFO - 'USER': 'cltbld', 15:18:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:33 INFO - '_': '/tools/buildbot/bin/python'} 15:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 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)) 15:18:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:18:33 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 15:18:33 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 15:18:33 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 15:18:33 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 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:18:34 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)) 15:18:34 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)) 15:18:34 INFO - Installing collected packages: simplejson 15:18:34 INFO - Running setup.py install for simplejson 15:18:34 INFO - building 'simplejson._speedups' extension 15:18:34 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 15:18:35 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 15:18:35 INFO - Successfully installed simplejson 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:35 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')]} 15:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:35 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')]} 15:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x21b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2381a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2524f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', '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 15:18:35 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 15:18:35 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 15:18:35 INFO - Using env: {'DISPLAY': ':0', 15:18:35 INFO - 'HOME': '/home/cltbld', 15:18:35 INFO - 'LANG': 'en_US.UTF-8', 15:18:35 INFO - 'LANGUAGE': 'en_US:en', 15:18:35 INFO - 'LOGNAME': 'cltbld', 15:18:35 INFO - 'MAIL': '/var/mail/cltbld', 15:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:35 INFO - 'MOZ_NO_REMOTE': '1', 15:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:35 INFO - 'NO_EM_RESTART': '1', 15:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:35 INFO - 'PWD': '/builds/slave/test', 15:18:35 INFO - 'SHELL': '/bin/bash', 15:18:35 INFO - 'SHLVL': '1', 15:18:35 INFO - 'TERM': 'linux', 15:18:35 INFO - 'TMOUT': '86400', 15:18:35 INFO - 'USER': 'cltbld', 15:18:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:35 INFO - '_': '/tools/buildbot/bin/python'} 15:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Running post-action listener: _resource_record_post_action 15:18:35 INFO - Running post-action listener: _start_resource_monitoring 15:18:35 INFO - Starting resource monitoring. 15:18:35 INFO - [mozharness: 2017-08-20 22:18:35.893992Z] Finished create-virtualenv step (success) 15:18:35 INFO - [mozharness: 2017-08-20 22:18:35.894503Z] Running install step. 15:18:35 INFO - Running pre-action listener: _resource_record_pre_action 15:18:35 INFO - Running main action method: install 15:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:36 INFO - Reading from file tmpfile_stdout 15:18:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:36 INFO - Reading from file tmpfile_stdout 15:18:36 INFO - Output received: 15:18:36 INFO - Usage: mozinstall [options] installer 15:18:36 INFO - Options: 15:18:36 INFO - -h, --help show this help message and exit 15:18:36 INFO - -d DEST, --destination=DEST 15:18:36 INFO - Directory to install application into. [default: 15:18:36 INFO - "/builds/slave/test"] 15:18:36 INFO - --app=APP Application being installed. [default: firefox] 15:18:36 INFO - mkdir: /builds/slave/test/build/application 15:18:36 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'] 15:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:18:54 INFO - Reading from file tmpfile_stdout 15:18:54 INFO - Output received: 15:18:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:54 INFO - Running post-action listener: _resource_record_post_action 15:18:54 INFO - [mozharness: 2017-08-20 22:18:54.258600Z] Finished install step (success) 15:18:54 INFO - [mozharness: 2017-08-20 22:18:54.258749Z] Running setup-mitmproxy step. 15:18:54 INFO - Running pre-action listener: _resource_record_pre_action 15:18:54 INFO - Running main action method: setup_mitmproxy 15:18:54 INFO - Skipping: mitmproxy is not required 15:18:54 INFO - Running post-action listener: _resource_record_post_action 15:18:54 INFO - [mozharness: 2017-08-20 22:18:54.259718Z] Finished setup-mitmproxy step (success) 15:18:54 INFO - [mozharness: 2017-08-20 22:18:54.259936Z] Running run-tests step. 15:18:54 INFO - Running pre-action listener: _resource_record_pre_action 15:18:54 INFO - Running pre-action listener: _set_gcov_prefix 15:18:54 INFO - Running main action method: run_tests 15:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:54 INFO - Python 2.7.3 15:18:54 INFO - Return code: 0 15:18:54 INFO - grabbing minidump binary from tooltool 15:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2522130>, '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 0x2523030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25234c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:18:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:18:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:18:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:54 INFO - Return code: 0 15:18:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:54 INFO - ENV: RUST_BACKTRACE is now full 15:18:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 15:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 15:18:54 INFO - Using env: {'DISPLAY': ':0', 15:18:54 INFO - 'HOME': '/home/cltbld', 15:18:54 INFO - 'LANG': 'en_US.UTF-8', 15:18:54 INFO - 'LANGUAGE': 'en_US:en', 15:18:54 INFO - 'LOGNAME': 'cltbld', 15:18:54 INFO - 'MAIL': '/var/mail/cltbld', 15:18:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:54 INFO - 'MOZ_NO_REMOTE': '1', 15:18:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:54 INFO - 'NO_EM_RESTART': '1', 15:18:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:54 INFO - 'PWD': '/builds/slave/test', 15:18:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:54 INFO - 'RUST_BACKTRACE': 'full', 15:18:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:18:54 INFO - 'SHELL': '/bin/bash', 15:18:54 INFO - 'SHLVL': '1', 15:18:54 INFO - 'TERM': 'linux', 15:18:54 INFO - 'TMOUT': '86400', 15:18:54 INFO - 'USER': 'cltbld', 15:18:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319', 15:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:54 INFO - '_': '/tools/buildbot/bin/python'} 15:18:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 15:18:54 INFO - mozversion application_buildid: 20170820212432 15:18:54 INFO - mozversion application_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:18:54 INFO - mozversion application_display_name: Nightly 15:18:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:54 INFO - mozversion application_name: Firefox 15:18:54 INFO - mozversion application_remotingname: firefox 15:18:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:18:54 INFO - mozversion application_vendor: Mozilla 15:18:54 INFO - mozversion application_version: 57.0a1 15:18:54 INFO - mozversion platform_buildid: 20170820212432 15:18:54 INFO - mozversion platform_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:18:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:18:54 INFO - mozversion platform_version: 57.0a1 15:18:54 INFO - using testdate: 1503267534 15:18:54 INFO - actual date: 1503267534 15:18:54 INFO - starting webserver on 'localhost:55158' 15:18:54 INFO - SUITE-START | Running 2 tests 15:18:54 INFO - TEST-START | dromaeo_css 15:18:54 INFO - Initialising browser for dromaeo_css test... 15:18:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55158/getInfo.html -profile /tmp/tmp6BpAwg/profile 15:18:54 INFO - TEST-INFO | started process 15300 (/builds/slave/test/build/application/firefox/firefox http://localhost:55158/getInfo.html) 15:19:00 INFO - TEST-INFO | 15300: exit 0 15:19:00 INFO - Browser initialized. 15:19:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:00 INFO - TEST-INFO | started process 15473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BpAwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:01 INFO - PID 15473 | 15:19:01 INFO - PID 15473 | (/builds/slave/test/build/application/firefox/firefox:15524): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:01 INFO - PID 15473 | 15:19:02 INFO - PID 15473 | 15:19:02 INFO - PID 15473 | (/builds/slave/test/build/application/firefox/firefox:15578): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:02 INFO - PID 15473 | 15:19:02 INFO - PID 15473 | __metrics Screen width/height:1600/1200 15:19:02 INFO - PID 15473 | colorDepth:24 15:19:02 INFO - PID 15473 | Browser inner width/height: 1024/768 15:19:02 INFO - PID 15473 | __metrics 15:19:11 INFO - PID 15473 | RSS: Main: 171712512 15:19:11 INFO - PID 15473 | 15:22:10 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55158/tests/dromaeo/cssquery-ext.html) 15:22:11 INFO - PID 15473 | RSS: Main: 175652864 15:22:11 INFO - PID 15473 | 15:25:13 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-ext.html (next: http://localhost:55158/tests/dromaeo/cssquery-jquery.html) 15:25:14 INFO - PID 15473 | RSS: Main: 171929600 15:25:14 INFO - PID 15473 | 15:28:16 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55158/tests/dromaeo/cssquery-mootools.html) 15:28:16 INFO - PID 15473 | RSS: Main: 174358528 15:28:16 INFO - PID 15473 | 15:31:18 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55158/tests/dromaeo/cssquery-prototype.html) 15:31:19 INFO - PID 15473 | RSS: Main: 172871680 15:31:19 INFO - PID 15473 | 15:34:22 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55158/tests/dromaeo/cssquery-yui.html) 15:34:22 INFO - PID 15473 | RSS: Main: 174206976 15:34:22 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | Cycle 1(1): loaded http://localhost:55158/tests/dromaeo/cssquery-yui.html (next: http://localhost:55158/tests/dromaeo/cssquery-dojo.html) 15:37:24 INFO - PID 15473 | RSS: Main: 177016832 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | __start_tp_report 15:37:24 INFO - PID 15473 | _x_x_mozilla_page_load 15:37:24 INFO - PID 15473 | _x_x_mozilla_page_load_details 15:37:24 INFO - PID 15473 | |i|pagename|runs| 15:37:24 INFO - PID 15473 | |0;dojo.html;3115.548245504402;3163.240822202672;3166.667499912509;3169.065125787892;3170.1440611035023;6150.969245153768;6197.752089916404;6249.250089989202;6261.906071408933;6264.655443950581;6021.548383871216;6060.878782424349;6086.087086936962;6096.390360963913;6123;5642.971785141079;5705.65766054036;5705.971470142644;5721.084626459768;5723.399043100477;5743.5118014968775;5756.539476841864;5768.5385169186575;5775.191473193756;5884.970575147139;5720.713964301768;5749.655020698771;5793.13103034544;5811.796587119452;5840.182374467557;5514.724263786835;5605.271314729059;5659.60382773206;5682.9147562786175;5742.023855944458;5608.074667679828;5648.265725455705;5678.886422271573;5687.971560142214;5705.74324155414;6022.728977196037;6047.7278522466595;6118.3269840317525;6148.84627884302;6150.50795936324;6480.902786458207;6579.9671001645165;6638.568493047985;6638.701258443381;6642.734290628369;6659.03444000622;6660.467162626978;6664.233613134503;6671.699773510204;6680.86638267232;6163.229596300463;6163.87672246557;6165.044418115244;6169.568130230886;6178.258608966953;6720.798376048726;6799.286074962157;6804.489663275274;6810.8637827244165;6813.693383797741;6485.902711459332;6497.252815926135;6500.804975850732;6526.869462610721;6580.473562115019;6683.7660681875905;6703.363180497845;6757.054012438262;6761.29006454325;6778.93221067783;6646.26891041985;6652.101966234496;6748.122744043341;6749.493787965922;6767.661616919135;6560;6666;6670.366315200048;6680.799576012728;6773.390394864486;5229.843104706865;5366.570674346043;5374.140137577969;5381.48875856793;5413.350397952271;4559.54404559548;4592.058627981256;4631.374764406829;4683.2038553446;4689.62483001359;5737.827865164052;5744.827655170351;5748.281464816898;5748.338941021752;5756.56825738063;6782.830429239309;6789.694463749143;6802;6805.353491418307;6806.727730890709;5722.656640601494;5820.35976042635;5867.061270196748;5891.05743081105;5902.1146827976145;5883.294004719461;5898.911516327258;5903.522015691836;5975.581709280309;5990.700464976734;6366.267879193952;6445.452136568444;6449.806505804833;6453.774117905851;6585.769498067544;6540.934590654033;6605.900911486236;6680.3987641112535;6727.293634168537;6737.393634572716;6474.902876456763;6475.967620161869;6538.378854008862;6556.2788093308745;6570.704318305783;6481.060246264171;6522.445592124533;6543.770968016097;6574.112494813139;6631.6684165792485;6653.9667301663185;6697.899531507129;6703.329667033453;6710.429613482908;6716.764913228014;6458.225012998282;6530.542861999805;6555.344465553407;6573.145491086319;6581;6473.320301368477;6478.611283323015;6539.280679125197;6564.868702625825;6566.409023187936;6271.24745030581;6380.170577824853;6384.3934826191435;6484.935150648622;6486.610803351814;6498.252700939453;6531.934680653323;6616.66916654175;6622.735090596515;6628.635425051669;6326.810195694136;6367.713452894538;6396.904046439214;6438.742450302123;6470.094186813756 15:37:24 INFO - PID 15473 | |1;ext.html;789.7117552093484;855.6748435594474;879.2350654930211;882.8543290357095;1182.6274723462113;29697.999999999975;30386.39227215457;39806.601933980615;40522.7973860131;40747;40700.79649601755;41137.58862411375;41165.17669646605;41166.38250426246;41225.793871030604;7667.539947603133;7749.418793590489;7910.129885712567;7911.011123609549;7922.564258965755;7784.532928024337;7898.605069746518;7902.6048697565175;7902.644381002869;7904.486208396436;7881.645325960346;7898.131205567383;7933;7953.244441778022;7955.323797477221;7852.764417067498;7899.131095579453;7901.762947111567;7913.762587122395;7920.564368959705;7715.7685269441445;7755.8448831023625;7760.922390776076;7772.417068719868;7775.494592851446;37280.25439491222;37371.81314093439;37428.62571374279;37550.81224593859;37576.43635345472;3652.8904132876055;3661.8535258589623;3682.263547290526;3698.3527882620433;3703.166787472824;30912.53631195534;30989.535156972663;31022.689773102207;31045.22386940322;31178.844105779554;4870.269459581055;5072.289879416885;5079.619028572872;5113.923291150636;5125;192515;192942;193141;193244;193879.03060484608;48603.27095093577;48605.270920936215;48610.75694621575;48623.756881216075;48702.512974869795;50317.24524132141;50332.74833625882;50425.747871260406;50472.74763626232;50477.74761126171;13947.302634868216;16435.6712865742;16670.249838757285;16693.666126677643;16715.331386744638;11626.883731162749;13888.166709997433;14048.367823447968;14140.717185656229;14164.504242351468;14185.929070354789;14225.430982760781;14296.928515357356;14431.711365772626;14456.927715361357;5741.85645358861;5753.89119588921;5966.612170208922;6025.78909738157;6033.607815491979;1004.1013293102778;1007.7531004903699;1011.9949400253099;1018.1600179851652;1048.821700310949;22729.545409091726;22944.196953106562;22964.540709185723;23087.653685194735;23109.422264443187;1118.139032944628;1122.3995162587976;1127.1884243344778;1129.1982692288402;1138.772245550893;11943.402829858645;12123.939380303218;12238.34615327101;12271.938640306742;12275.508979640714;234128;238638;239262;239269;239328;55189.44810551843;55255.17117243245;55425.72287138619;55925.72037139788;55986.44013559894;1462.0642788615294;1479.4821812365801;1490.545383657973;1490.6571488557693;1508.351408894164;26198.476030479665;27219.86390068037;27256;27349.453010939273;27363.452730945668;48221.27668085052;48235;48236.75881620569;48275;48373.5162648369;207590;208732;209023;209062;209641;31456.213594660316;31635.20911977127;34455;34693.65306346904;34831.30337393187;42204.36693449662;42452;42504.78747606242;42837.785811070746;42917.356239657056;31821.840890795396;31851.68148318487;32134.517982230755;32245.193870153435;32427.67572324341;31469.05592832219;31643.84178079095;31979.6802031986;32116.518252225767;32445.837770810995;34047.82976085203;34332;34445.31109377849;34558.48162277517;34833.30333393267;30656.386872261985;30715.692843071283;30802.383952321277;31272;31403.52894706627;22861.957730257393;23082;23360.53278934446;23386.76613233846;23522.647160292952 15:37:24 INFO - PID 15473 | |2;jquery.html;569.7635481275271;569.8746275819321;571.8027280588195;578.3464684906055;587.2629849538829;21872.89063554682;22731;22748.31755047351;22758.886205568968;22772.88613556932;26623.866880665617;27233;27288.181354559347;27323.726762732367;27325;6564.638944858031;6711.395974362306;6717.496187785911;6720.798376048726;6721.294264102272;6319.115323854664;6597.571157874723;6598.406143447089;6617.239017512999;6617.702203400859;6575.736970521173;6587;6596.901046484307;6607.5374723769355;6608.570442921219;6570.967145164243;6572.93427065728;6575.473962083021;6580.276169621337;6581.045748366508;6067.939320606782;6087.269527656666;6120.938790612126;6123.8162855114415;6126.050462178325;27278.5908211377;28496.430071398456;28608.14175574736;30500.237494062603;30954.38091238185;1972.3885595465451;2005.458526197933;2012.6075415294024;2018.3440381875948;2022.130483891926;19135.712964305545;19650;20333;20354;20354.796452035585;2480.6899137607797;2489.240781561623;2526.1411120219213;2528.064616092039;2533.8099642526886;129064;132292;139345;141510.29244853812;141887;15011;15513.689726205414;15603.921980390025;15667.84332156664;15681.294341754648;23600.17399391013;23809.404764881016;23865.40336491567;23866.761332386453;23901.163459278843;10735.94632026835;10785.56857725698;10828.78342433147;10862.565497380016;10926.453677316102;8631.870521942175;10101.595936162617;10140;10290.588376464857;10511.57953681844;8329.416940814084;11303.491342889589;11726.94136529312;11816.76366472683;12058.698532536757;3859.864904728321;3931.6213690717277;4162.958370416318;4259.21204577148;4291.206870724559;963.556763888605;987.3335498538602;993.8509223616516;998.3410948773775;1005.9446730429751;19943.800561994485;20229.696554551694;20399.184032638528;20574;21009.68485472719;1059.9682009539727;1061.3260579531898;1061.7451811565168;1071.5713714514256;1080;11106.666799995852;11226.831597526043;11420.600278990196;11505.13711471643;11519.95683388536;489148;490964;516521;530019;534533;118737.40631296962;124429.37785311196;126990.36504817416;127611;127929.36035319764;1266.2782214138037;1268.467243757624;1295.5206573567652;1313.9277339746216;1317.617890811654;20604;20650.896745516176;20857.687134693297;21316.78683213148;21319.720816751043;59885.101723475054;60342.39657603543;61712;62489.687551561954;62794;74998;76181.23818761963;76401;76944.61527692326;77635.61182194053;12312.630621081382;12814.231146131262;14385.712285754436;14669.706605868036;15089.396424142911;23439.179628712915;23878.52242955166;23934.28197154088;24843.751562484144;25070;19414.805851941866;19513.70729439088;19550.804491955467;19610.80389196147;19765;17207.56981075483;17263.654726905643;17463.126843657512;17725;18121.546961326072;19639.60720785605;19811.10850011724;19956.90021549883;20070.39788806338;20197;14758.188299643623;14960.251987400805;15013.474528391454;15066.849331506544;15106.942514023913;18640.90679546648;18809.247630094644;18954.147063381904;19041.238350465825;19059.90470047641 15:37:24 INFO - PID 15473 | |3;mootools.html;1367.5008621853021;1391.09578773797;1413.2439145057397;1416.5750274917523;1416.9504067357639;14036.64908377291;14631.122132672033;14644.633884152901;14657.780133297982;14664.41342346305;14332;14770.11379317239;14786.260686965636;14792.556223313319;14803.33384997675;2683.3425810676363;2757.214193954723;2758.2276962450446;2758.544840101381;2759.296379423244;2600.6099085137284;2690.4350086481863;2772.1683494951535;2773.334399744067;2774.6947835738156;2710.5256580098503;2728.877200525981;2750.7111753265917;2751.380939288664;2759.1722483255044;2675.759181673649;2680.973190268092;2697.029069534966;2720.0071973729646;2725.713800050996;2611.4124322027583;2614.1242683700984;2645.8015648826413;2665.2270841455957;2671.772899303542;14127.15237085778;14154.079984801057;14223.857761422356;14245.430182792676;14256.92871535646;7616.581088040156;7776.300132988002;7868.488548244346;7925.8811117833275;7926.445148839583;5007.474215207423;5126.5642420394315;5248.343957005374;5252.684838909678;5273.34083239595;1844.1516902224992;1876;1916.626257879714;1943.2227109156452;1967.5572996075912;23759;23845.642315365283;24117.39706507334;24612.261632150887;24640.507189856282;6348.460380867586;6700.296468870796;6725.831854203684;6921.653917304115;6927.376536111774;15702.136382499073;15721.056736595841;16052.678946421007;16552.83447165513;16559.337626495046;7757.92242077572;7930.405219608552;7941.324987376138;7948.483348582439;7990.280874721187;7275.636218189069;7344.596047217455;7362.374198193106;7365;7433.591152486557;5036.874078148002;5199.844004679866;5216.217567364925;5262.052830490472;5345.70598617072;1524.618845288678;1540.722669919403;1544.783730277762;1549.4344564233973;1581.9446319378997;881.8633111867671;898.1422741282059;904.9276057915482;915.7298596913927;916.679162293192;7458.701651933862;7499.775006749806;7549.245075492407;7607.315341619281;7631.656575454118;708.8759467093238;719.8020544350345;724.4819953733;726.4116065986568;738.5421038955882;4637.443506779208;4639.744814035193;4660.557247061523;4684.601808846218;4726.881827954328;19852.404427867186;20153.39539813808;20196.192152313743;20241.696374554394;20320.491987700425;19497.610047798964;19773.406797796088;19774.802251977297;19788.802111978985;20940.58118837645;10461.372317660966;10620.362778233177;10625.415602141957;10630.840537391945;10635.149188064936;8048.5975701215875;8123.47197432165;8168.918310817054;8364.832703346021;8478.279346255636;17490.212940417965;17533.561660958578;17580.296788128333;17586.472405827844;17743.29026838912;17768.378106766202;17991.280348785902;18158.27366905309;18772.436826895217;19047.04764761784;10086;10269.97300269967;10274.280800343904;10281.074703276741;10281.17750579937;13192.934035329761;13371.53199638008;13419.127756695783;13454.52909148175;13487.460501579826;10937.726556836144;11103;11137.944310278397;11140.498677559692;11240.325580465198;10578.682639520826;10790.406527641055;10843.67468975932;10965.671029869116;11090.667279981613;9591.808163836544;9738.220942324739;9765.072318129767;9768.56041478121;9771.755706107404;7105.32499412555;7210.783676489714;7239.674214660458;7260.128784545888;7313;7305.634718263959;7508.2867127622785;7548.8490230196185;7563.848723025399;7578.825282081286 15:37:24 INFO - PID 15473 | |4;prototype.html;513.1737901977813;514.6140394703972;524.4440892653787;534.2627174499193;535.7917895146444;6315.652639104847;6331.936680633193;6359.523035772324;6373.311072565768;6378.936210637892;6205.348438413969;6232.875342493158;6237.750489980395;6276.717547710353;6285.371462853713;5210.817621383243;5225.608079394042;5226.634135610509;5233.73831308435;5239.271040556607;4912.0351859256225;5063.696178229318;5185.170372740362;5215.947840521584;5222.686638801665;5030.522100400456;5033.697978121324;5055.6713813602;5063.16457784467;5064.759134012173;5037.395512538501;5046.268291097788;5056.140456122431;5070.898582028376;5087.23691446286;4382.4302840630835;4502.594766471033;4515.571020753023;4534.8866278342975;4551.749653769041;6081.209442772411;6107.847303817396;6131.63210207389;6158.599691020069;6181.443670069715;5753.280839895013;5754.1944127822135;5768.163616275617;5769.163471296639;5790.189373487715;6662.300458451889;6662.5003124765835;6666.267010371077;6674.3325667433355;6676.198856137246;4920.114379411704;4927.950720492785;4958.438092001008;4963.230699241623;4977.352944117278;6698.229703584101;6774.220964589135;6882.793516194522;6888.311168883121;7013.580314791439;5049.318342023853;5065.214891691794;5069.619778516626;5090.261912022736;5090.41460232078;5148.279240906276;5159.922601160985;5173.4826517347965;5178.119719647669;5179.533841954242;5721.22763426932;5723.77104915807;5748.741306641211;5761.711914404263;5763.9135412968835;6655.86688266232;6671.899136642497;6683.365080317362;6694.196696396366;6696.129503164558;1773.3527262549335;1787.6871547479138;1810.6559753646766;1817.6546456173548;1818.1818181818235;1163.4008485629906;1238.993805030987;1239.5311555806397;1248.6441364211157;1253.7304479536942;5775.364709881909;5801.506871915934;5817.214676018768;5828.213191219131;5840.59115861894;6690.899636505456;6741.696623651947;6815.318468153145;6821.590704557742;6867.175938887265;5695.202671625976;5817.825465236049;5818.439886449948;5823.621464604787;5864.2083318752275;3521.6126226115107;3550.3076900004253;3558.62634423387;3567.625399333033;3589.9282014359565;6497.577657452251;6582.111414959015;6618.106555614931;6666.333366663295;6668.733250669919;6892.862142757117;6909.585424874524;6928.653567321614;6944.7222111116;6960.443164546824;6128.938710612837;6393.936060639334;6513.9806659935575;6538.646087408529;6550.344965503412;6677.632730199885;6747;6751.72993080291;6793.694283757144;6809.285025072296;6691.933080669131;6714.294999025032;6717.152782984718;6752.615713778762;6753.594784312957;6475.352464753675;6483.546151769519;6493.525963609446;6555.704993275219;6570.605763654196;4996.425411077773;5011.924821127613;5045.747712614428;5083;5088.516590923857;6478.902816457663;6499.805005849832;6653.268140504638;6743.8988415172835;6822.829429264308;6468.935310646833;6530.346965303432;6532.8366790830605;6556.311587283458;6576.079348891063;6470.805875823733;6498.902516462163;6539.771108011197;6560.343965603402;6561.245456772533;6363.96818015907;6445.970393914852;6450.7097180627925;6451.870922588622;6525.412712855676;6508.902366464602;6572.671366431564;6663.866722665616;6665.5334126612615;6675.599464032173;6386.776462823779;6440.67796610177;6453.709583068867;6472.611643301417;6501.577397469149 15:37:24 INFO - PID 15473 | |5;yui.html;906.388187973118;925.4863550729344;929.2473096791595;939.6664184214603;957.6121670723358;18669.159887805046;19843.305484308035;19881.50296242593;19887.40337789865;21751.45621359467;20955.37133885982;21435.249766258185;21468.355949321507;21480.24819131327;21528.677069843965;1013.2906965124424;1051.7212938571247;1052.7105046112342;1055.9524821383018;1059.0309866472169;1027.1628622672497;1045.3048722599501;1047.010575006619;1052.5263631365879;1054.78376932729;1091.6943255888364;1091.9454027298643;1092.4701519762948;1092.628506307855;1106.25880659958;1081.9729506762314;1083.0415082651832;1086.6033897627387;1089.05796486039;1096.8299913513417;793.714262865368;796.0685997383076;796.9840603187962;801.0747586537558;810.4853418079502;19700.802991970184;19857.50356241091;20039;20101.79898201014;20132.094055767524;21786.673199902016;22196;22275.108995640156;22281.44296392587;22446.663300050513;16844.933137589796;16923.06923119228;16951.321947122102;17031.318747250094;17163.313467461285;3722.553293604785;3743.382341913581;3746.400575907842;3746.850125994957;3748.662620364153;124559;126103;126506;128247;128426.357868211;16658.33366665344;16911.23899424529;17270.654586908193;17492.21285042176;17595.73606395905;30800;31260;31317.217069572987;31551.211219719233;31971.840140799148;7688.884666729891;7912.367010639135;8052.436329456882;8304.335653147733;8474.491530508189;4177.164567086595;4233.555476674905;4263.189993901211;4271.273883439822;4273.273543497613;5284.867878303073;5347.117725575236;5379.757910894019;5412.350517937873;5412.512873841373;1091.858058452396;1112.5104953820294;1116.9218154729092;1135.250734515216;1138.499060413432;676.1176664452838;683.6000939450478;683.9760608378683;687.4500399680236;695.3637421759033;11477.311361318347;11590.13074019435;11888.702782430508;12347.073969452147;12892.419841107172;686.842026333936;687.2783577243874;690.1097584116534;694;700.6251655364356;5620.735334549694;5760.481556659921;5786.942130578725;5809.792278934063;5938.465538101505;108953;111338.44330778456;111992.44003779929;112683.43658281656;118215.40892295484;98108.50945745225;100677;101662;104038.47980760048;104394.4780276109;81970.59014705008;82203.5889820547;87381.5630921854;88880.11119888848;89422.55288723514;12616.432260548114;12918.741625167257;13321.866781332063;13369.26469044212;13549.390277437342;39194;40778.38832417576;40843.795781020905;41296.79351603223;42399.788001059795;69711;69885.65057174681;70237.64881175765;70843.64578177282;74300.62849685717;15608.595226429676;17355.7396639048;17390.913045434692;17490.650186996445;17564.648707026045;20912.37262882116;21173.576528469654;21381;21959.231426899983;22075;18749.6250074995;19463.513412164808;19615.70576441326;20032;20051.799482004993;18115.275388984293;18290.634187316446;18371.265149393876;18477.260909564004;19151.904240479267;17888;18638.34765783191;18680.5462078041;19034.7144792831;19320.516987075436;12979.675508112372;13582.728345432839;13734;14056.226907520184;14196.29018549089;14740.336684849422;15085.47200848009;15163.166025868242;15208;15606.84393156054 15:37:24 INFO - PID 15473 | __end_tp_report 15:37:24 INFO - PID 15473 | __start_cc_report 15:37:24 INFO - PID 15473 | _x_x_mozilla_cycle_collect,383 15:37:24 INFO - PID 15473 | __end_cc_report 15:37:24 INFO - PID 15473 | __startTimestamp1503268644962__endTimestamp 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | ------- Summary: start ------- 15:37:24 INFO - PID 15473 | Number of tests: 6 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#0] dojo.html Cycles:165 Average:6140.17 Median:6438.74 stddev:723.65 (11.2%) stddev-sans-first:685.86 15:37:24 INFO - PID 15473 | Values: 3115.5 3163.2 3166.7 3169.1 3170.1 6151.0 6197.8 6249.3 6261.9 6264.7 6021.5 6060.9 6086.1 6096.4 6123.0 5643.0 5705.7 5706.0 5721.1 5723.4 5743.5 5756.5 5768.5 5775.2 5885.0 5720.7 5749.7 5793.1 5811.8 5840.2 5514.7 5605.3 5659.6 5682.9 5742.0 5608.1 5648.3 5678.9 5688.0 5705.7 6022.7 6047.7 6118.3 6148.8 6150.5 6480.9 6580.0 6638.6 6638.7 6642.7 6659.0 6660.5 6664.2 6671.7 6680.9 6163.2 6163.9 6165.0 6169.6 6178.3 6720.8 6799.3 6804.5 6810.9 6813.7 6485.9 6497.3 6500.8 6526.9 6580.5 6683.8 6703.4 6757.1 6761.3 6778.9 6646.3 6652.1 6748.1 6749.5 6767.7 6560.0 6666.0 6670.4 6680.8 6773.4 5229.8 5366.6 5374.1 5381.5 5413.4 4559.5 4592.1 4631.4 4683.2 4689.6 5737.8 5744.8 5748.3 5748.3 5756.6 6782.8 6789.7 6802.0 6805.4 6806.7 5722.7 5820.4 5867.1 5891.1 5902.1 5883.3 5898.9 5903.5 5975.6 5990.7 6366.3 6445.5 6449.8 6453.8 6585.8 6540.9 6605.9 6680.4 6727.3 6737.4 6474.9 6476.0 6538.4 6556.3 6570.7 6481.1 6522.4 6543.8 6574.1 6631.7 6654.0 6697.9 6703.3 6710.4 6716.8 6458.2 6530.5 6555.3 6573.1 6581.0 6473.3 6478.6 6539.3 6564.9 6566.4 6271.2 6380.2 6384.4 6484.9 6486.6 6498.3 6531.9 6616.7 6622.7 6628.6 6326.8 6367.7 6396.9 6438.7 6470.1 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#1] ext.html Cycles:180 Average:38391.02 Median:34189.91 stddev:55527.77 (162.4%) stddev-sans-first:55611.76 15:37:24 INFO - PID 15473 | Values: 789.7 855.7 879.2 882.9 1182.6 29698.0 30386.4 39806.6 40522.8 40747.0 40700.8 41137.6 41165.2 41166.4 41225.8 7667.5 7749.4 7910.1 7911.0 7922.6 7784.5 7898.6 7902.6 7902.6 7904.5 7881.6 7898.1 7933.0 7953.2 7955.3 7852.8 7899.1 7901.8 7913.8 7920.6 7715.8 7755.8 7760.9 7772.4 7775.5 37280.3 37371.8 37428.6 37550.8 37576.4 3652.9 3661.9 3682.3 3698.4 3703.2 30912.5 30989.5 31022.7 31045.2 31178.8 4870.3 5072.3 5079.6 5113.9 5125.0 192515.0 192942.0 193141.0 193244.0 193879.0 48603.3 48605.3 48610.8 48623.8 48702.5 50317.2 50332.7 50425.7 50472.7 50477.7 13947.3 16435.7 16670.2 16693.7 16715.3 11626.9 13888.2 14048.4 14140.7 14164.5 14185.9 14225.4 14296.9 14431.7 14456.9 5741.9 5753.9 5966.6 6025.8 6033.6 1004.1 1007.8 1012.0 1018.2 1048.8 22729.5 22944.2 22964.5 23087.7 23109.4 1118.1 1122.4 1127.2 1129.2 1138.8 11943.4 12123.9 12238.3 12271.9 12275.5 234128.0 238638.0 239262.0 239269.0 239328.0 55189.4 55255.2 55425.7 55925.7 55986.4 1462.1 1479.5 1490.5 1490.7 1508.4 26198.5 27219.9 27256.0 27349.5 27363.5 48221.3 48235.0 48236.8 48275.0 48373.5 207590.0 208732.0 209023.0 209062.0 209641.0 31456.2 31635.2 34455.0 34693.7 34831.3 42204.4 42452.0 42504.8 42837.8 42917.4 31821.8 31851.7 32134.5 32245.2 32427.7 31469.1 31643.8 31979.7 32116.5 32445.8 34047.8 34332.0 34445.3 34558.5 34833.3 30656.4 30715.7 30802.4 31272.0 31403.5 22862.0 23082.0 23360.5 23386.8 23522.6 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#2] jquery.html Cycles:180 Average:36357.82 Median:20933.69 stddev:86283.59 (412.2%) stddev-sans-first:86483.80 15:37:24 INFO - PID 15473 | Values: 569.8 569.9 571.8 578.3 587.3 21872.9 22731.0 22748.3 22758.9 22772.9 26623.9 27233.0 27288.2 27323.7 27325.0 6564.6 6711.4 6717.5 6720.8 6721.3 6319.1 6597.6 6598.4 6617.2 6617.7 6575.7 6587.0 6596.9 6607.5 6608.6 6571.0 6572.9 6575.5 6580.3 6581.0 6067.9 6087.3 6120.9 6123.8 6126.1 27278.6 28496.4 28608.1 30500.2 30954.4 1972.4 2005.5 2012.6 2018.3 2022.1 19135.7 19650.0 20333.0 20354.0 20354.8 2480.7 2489.2 2526.1 2528.1 2533.8 129064.0 132292.0 139345.0 141510.3 141887.0 15011.0 15513.7 15603.9 15667.8 15681.3 23600.2 23809.4 23865.4 23866.8 23901.2 10735.9 10785.6 10828.8 10862.6 10926.5 8631.9 10101.6 10140.0 10290.6 10511.6 8329.4 11303.5 11726.9 11816.8 12058.7 3859.9 3931.6 4163.0 4259.2 4291.2 963.6 987.3 993.9 998.3 1005.9 19943.8 20229.7 20399.2 20574.0 21009.7 1060.0 1061.3 1061.7 1071.6 1080.0 11106.7 11226.8 11420.6 11505.1 11520.0 489148.0 490964.0 516521.0 530019.0 534533.0 118737.4 124429.4 126990.4 127611.0 127929.4 1266.3 1268.5 1295.5 1313.9 1317.6 20604.0 20650.9 20857.7 21316.8 21319.7 59885.1 60342.4 61712.0 62489.7 62794.0 74998.0 76181.2 76401.0 76944.6 77635.6 12312.6 12814.2 14385.7 14669.7 15089.4 23439.2 23878.5 23934.3 24843.8 25070.0 19414.8 19513.7 19550.8 19610.8 19765.0 17207.6 17263.7 17463.1 17725.0 18121.5 19639.6 19811.1 19956.9 20070.4 20197.0 14758.2 14960.3 15013.5 15066.8 15106.9 18640.9 18809.2 18954.1 19041.2 19059.9 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#3] mootools.html Cycles:180 Average:8919.95 Median:2673.77 stddev:6189.25 (231.5%) stddev-sans-first:6180.60 15:37:24 INFO - PID 15473 | Values: 1367.5 1391.1 1413.2 1416.6 1417.0 14036.6 14631.1 14644.6 14657.8 14664.4 14332.0 14770.1 14786.3 14792.6 14803.3 2683.3 2757.2 2758.2 2758.5 2759.3 2600.6 2690.4 2772.2 2773.3 2774.7 2710.5 2728.9 2750.7 2751.4 2759.2 2675.8 2681.0 2697.0 2720.0 2725.7 2611.4 2614.1 2645.8 2665.2 2671.8 14127.2 14154.1 14223.9 14245.4 14256.9 7616.6 7776.3 7868.5 7925.9 7926.4 5007.5 5126.6 5248.3 5252.7 5273.3 1844.2 1876.0 1916.6 1943.2 1967.6 23759.0 23845.6 24117.4 24612.3 24640.5 6348.5 6700.3 6725.8 6921.7 6927.4 15702.1 15721.1 16052.7 16552.8 16559.3 7757.9 7930.4 7941.3 7948.5 7990.3 7275.6 7344.6 7362.4 7365.0 7433.6 5036.9 5199.8 5216.2 5262.1 5345.7 1524.6 1540.7 1544.8 1549.4 1581.9 881.9 898.1 904.9 915.7 916.7 7458.7 7499.8 7549.2 7607.3 7631.7 708.9 719.8 724.5 726.4 738.5 4637.4 4639.7 4660.6 4684.6 4726.9 19852.4 20153.4 20196.2 20241.7 20320.5 19497.6 19773.4 19774.8 19788.8 20940.6 10461.4 10620.4 10625.4 10630.8 10635.1 8048.6 8123.5 8168.9 8364.8 8478.3 17490.2 17533.6 17580.3 17586.5 17743.3 17768.4 17991.3 18158.3 18772.4 19047.0 10086.0 10270.0 10274.3 10281.1 10281.2 13192.9 13371.5 13419.1 13454.5 13487.5 10937.7 11103.0 11137.9 11140.5 11240.3 10578.7 10790.4 10843.7 10965.7 11090.7 9591.8 9738.2 9765.1 9768.6 9771.8 7105.3 7210.8 7239.7 7260.1 7313.0 7305.6 7508.3 7548.8 7563.8 7578.8 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#4] prototype.html Cycles:180 Average:5564.42 Median:6193.40 stddev:1547.92 (25.0%) stddev-sans-first:1505.11 15:37:24 INFO - PID 15473 | Values: 513.2 514.6 524.4 534.3 535.8 6315.7 6331.9 6359.5 6373.3 6378.9 6205.3 6232.9 6237.8 6276.7 6285.4 5210.8 5225.6 5226.6 5233.7 5239.3 4912.0 5063.7 5185.2 5215.9 5222.7 5030.5 5033.7 5055.7 5063.2 5064.8 5037.4 5046.3 5056.1 5070.9 5087.2 4382.4 4502.6 4515.6 4534.9 4551.7 6081.2 6107.8 6131.6 6158.6 6181.4 5753.3 5754.2 5768.2 5769.2 5790.2 6662.3 6662.5 6666.3 6674.3 6676.2 4920.1 4928.0 4958.4 4963.2 4977.4 6698.2 6774.2 6882.8 6888.3 7013.6 5049.3 5065.2 5069.6 5090.3 5090.4 5148.3 5159.9 5173.5 5178.1 5179.5 5721.2 5723.8 5748.7 5761.7 5763.9 6655.9 6671.9 6683.4 6694.2 6696.1 1773.4 1787.7 1810.7 1817.7 1818.2 1163.4 1239.0 1239.5 1248.6 1253.7 5775.4 5801.5 5817.2 5828.2 5840.6 6690.9 6741.7 6815.3 6821.6 6867.2 5695.2 5817.8 5818.4 5823.6 5864.2 3521.6 3550.3 3558.6 3567.6 3589.9 6497.6 6582.1 6618.1 6666.3 6668.7 6892.9 6909.6 6928.7 6944.7 6960.4 6128.9 6393.9 6514.0 6538.6 6550.3 6677.6 6747.0 6751.7 6793.7 6809.3 6691.9 6714.3 6717.2 6752.6 6753.6 6475.4 6483.5 6493.5 6555.7 6570.6 4996.4 5011.9 5045.7 5083.0 5088.5 6478.9 6499.8 6653.3 6743.9 6822.8 6468.9 6530.3 6532.8 6556.3 6576.1 6470.8 6498.9 6539.8 6560.3 6561.2 6364.0 6446.0 6450.7 6451.9 6525.4 6508.9 6572.7 6663.9 6665.5 6675.6 6386.8 6440.7 6453.7 6472.6 6501.6 15:37:24 INFO - PID 15473 | 15:37:24 INFO - PID 15473 | [#5] yui.html Cycles:180 Average:24258.07 Median:19869.50 stddev:32631.49 (164.2%) stddev-sans-first:32675.91 15:37:24 INFO - PID 15473 | Values: 906.4 925.5 929.2 939.7 957.6 18669.2 19843.3 19881.5 19887.4 21751.5 20955.4 21435.2 21468.4 21480.2 21528.7 1013.3 1051.7 1052.7 1056.0 1059.0 1027.2 1045.3 1047.0 1052.5 1054.8 1091.7 1091.9 1092.5 1092.6 1106.3 1082.0 1083.0 1086.6 1089.1 1096.8 793.7 796.1 797.0 801.1 810.5 19700.8 19857.5 20039.0 20101.8 20132.1 21786.7 22196.0 22275.1 22281.4 22446.7 16844.9 16923.1 16951.3 17031.3 17163.3 3722.6 3743.4 3746.4 3746.9 3748.7 124559.0 126103.0 126506.0 128247.0 128426.4 16658.3 16911.2 17270.7 17492.2 17595.7 30800.0 31260.0 31317.2 31551.2 31971.8 7688.9 7912.4 8052.4 8304.3 8474.5 4177.2 4233.6 4263.2 4271.3 4273.3 5284.9 5347.1 5379.8 5412.4 5412.5 1091.9 1112.5 1116.9 1135.3 1138.5 676.1 683.6 684.0 687.5 695.4 11477.3 11590.1 11888.7 12347.1 12892.4 686.8 687.3 690.1 694.0 700.6 5620.7 5760.5 5786.9 5809.8 5938.5 108953.0 111338.4 111992.4 112683.4 118215.4 98108.5 100677.0 101662.0 104038.5 104394.5 81970.6 82203.6 87381.6 88880.1 89422.6 12616.4 12918.7 13321.9 13369.3 13549.4 39194.0 40778.4 40843.8 41296.8 42399.8 69711.0 69885.7 70237.6 70843.6 74300.6 15608.6 17355.7 17390.9 17490.7 17564.6 20912.4 21173.6 21381.0 21959.2 22075.0 18749.6 19463.5 19615.7 20032.0 20051.8 18115.3 18290.6 18371.3 18477.3 19151.9 17888.0 18638.3 18680.5 19034.7 19320.5 12979.7 13582.7 13734.0 14056.2 14196.3 14740.3 15085.5 15163.2 15208.0 15606.8 15:37:24 INFO - PID 15473 | -------- Summary: end -------- 15:37:24 INFO - PID 15473 | 15:37:25 INFO - TEST-INFO | 15473: exit 0 15:37:25 INFO - TEST-OK | dromaeo_css | took 1111006ms 15:37:25 INFO - TEST-START | kraken 15:37:25 INFO - Initialising browser for kraken test... 15:37:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55158/getInfo.html -profile /tmp/tmpj5xwop/profile 15:37:25 INFO - TEST-INFO | started process 15882 (/builds/slave/test/build/application/firefox/firefox http://localhost:55158/getInfo.html) 15:37:31 INFO - TEST-INFO | 15882: exit 0 15:37:31 INFO - Browser initialized. 15:37:31 INFO - Running cycle 1/1 for kraken test... 15:37:31 INFO - TEST-INFO | started process 16057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj5xwop/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:32 INFO - PID 16057 | 15:37:32 INFO - PID 16057 | (/builds/slave/test/build/application/firefox/firefox:16106): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:32 INFO - PID 16057 | 15:37:32 INFO - PID 16057 | 15:37:32 INFO - PID 16057 | (/builds/slave/test/build/application/firefox/firefox:16162): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:32 INFO - PID 16057 | 15:37:33 INFO - PID 16057 | __metrics Screen width/height:1600/1200 15:37:33 INFO - PID 16057 | colorDepth:24 15:37:33 INFO - PID 16057 | Browser inner width/height: 1024/768 15:37:33 INFO - PID 16057 | __metrics 15:37:42 INFO - PID 16057 | RSS: Main: 171868160 15:37:42 INFO - PID 16057 | 15:37:45 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55158/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:46 INFO - PID 16057 | RSS: Main: 175472640 15:37:46 INFO - PID 16057 | 15:37:48 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55158/tests/kraken/driver.html?testName=audio-dft) 15:37:49 INFO - PID 16057 | RSS: Main: 176316416 15:37:49 INFO - PID 16057 | 15:37:52 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55158/tests/kraken/driver.html?testName=audio-fft) 15:37:53 INFO - PID 16057 | RSS: Main: 170557440 15:37:53 INFO - PID 16057 | 15:37:55 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55158/tests/kraken/driver.html?testName=audio-oscillator) 15:37:55 INFO - PID 16057 | RSS: Main: 171450368 15:37:55 INFO - PID 16057 | 15:37:57 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:58 INFO - PID 16057 | RSS: Main: 171540480 15:37:58 INFO - PID 16057 | 15:38:01 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55158/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:02 INFO - PID 16057 | RSS: Main: 173060096 15:38:02 INFO - PID 16057 | 15:38:05 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55158/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:06 INFO - PID 16057 | RSS: Main: 172752896 15:38:06 INFO - PID 16057 | 15:38:09 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55158/tests/kraken/driver.html?testName=json-parse-financial) 15:38:09 INFO - PID 16057 | RSS: Main: 172797952 15:38:09 INFO - PID 16057 | 15:38:11 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:11 INFO - PID 16057 | RSS: Main: 172453888 15:38:11 INFO - PID 16057 | 15:38:13 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:14 INFO - PID 16057 | RSS: Main: 172666880 15:38:14 INFO - PID 16057 | 15:38:16 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:17 INFO - PID 16057 | RSS: Main: 172707840 15:38:17 INFO - PID 16057 | 15:38:19 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:20 INFO - PID 16057 | RSS: Main: 172945408 15:38:20 INFO - PID 16057 | 15:38:23 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:24 INFO - PID 16057 | RSS: Main: 173215744 15:38:24 INFO - PID 16057 | 15:38:25 INFO - PID 16057 | Cycle 1(1): loaded http://localhost:55158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55158/tests/kraken/driver.html?testName=ai-astar) 15:38:26 INFO - PID 16057 | RSS: Main: 174120960 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | __start_tp_report 15:38:26 INFO - PID 16057 | _x_x_mozilla_page_load 15:38:26 INFO - PID 16057 | _x_x_mozilla_page_load_details 15:38:26 INFO - PID 16057 | |i|pagename|runs| 15:38:26 INFO - PID 16057 | |0;ai-astar;100;107;100;108;109;111;111;99;108;108 15:38:26 INFO - PID 16057 | |1;audio-beat-detection;152;121;141;166;120;152;159;117;166;120 15:38:26 INFO - PID 16057 | |2;audio-dft;166;163;162;163;163;163;163;171;168;166 15:38:26 INFO - PID 16057 | |3;audio-fft;75;75;75;165;75;76;74;74;154;76 15:38:26 INFO - PID 16057 | |4;audio-oscillator;79;79;125;78;78;79;133;78;78;126 15:38:26 INFO - PID 16057 | |5;imaging-gaussian-blur;114;114;114;113;117;114;114;115;113;113 15:38:26 INFO - PID 16057 | |6;imaging-darkroom;151;150;149;149;149;150;151;149;150;151 15:38:26 INFO - PID 16057 | |7;imaging-desaturate;94;94;93;99;94;94;94;93;94;99 15:38:26 INFO - PID 16057 | |8;json-parse-financial;56;55;54;55;55;55;58;53;55;54 15:38:26 INFO - PID 16057 | |9;json-stringify-tinderbox;56;57;55;55;57;54;55;55;54;55 15:38:26 INFO - PID 16057 | |10;stanford-crypto-aes;76;76;76;75;75;77;76;77;74;75 15:38:26 INFO - PID 16057 | |11;stanford-crypto-ccm;129;127;135;121;123;129;121;126;118;163 15:38:26 INFO - PID 16057 | |12;stanford-crypto-pbkdf2;186;173;174;177;180;176;174;174;175;176 15:38:26 INFO - PID 16057 | |13;stanford-crypto-sha256-iterative;70;71;67;70;69;66;72;71;68;69 15:38:26 INFO - PID 16057 | __end_tp_report 15:38:26 INFO - PID 16057 | __start_cc_report 15:38:26 INFO - PID 16057 | _x_x_mozilla_cycle_collect,977 15:38:26 INFO - PID 16057 | __end_cc_report 15:38:26 INFO - PID 16057 | __startTimestamp1503268706112__endTimestamp 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | ------- Summary: start ------- 15:38:26 INFO - PID 16057 | Number of tests: 14 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#0] ai-astar Cycles:10 Average:106.10 Median:108.50 stddev:4.63 (4.3%) stddev-sans-first:4.35 15:38:26 INFO - PID 16057 | Values: 100.0 107.0 100.0 108.0 109.0 111.0 111.0 99.0 108.0 108.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:152.00 stddev:20.20 (13.3%) stddev-sans-first:21.06 15:38:26 INFO - PID 16057 | Values: 152.0 121.0 141.0 166.0 120.0 152.0 159.0 117.0 166.0 120.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.90 (1.8%) stddev-sans-first:3.04 15:38:26 INFO - PID 16057 | Values: 166.0 163.0 162.0 163.0 163.0 163.0 163.0 171.0 168.0 166.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:35.73 (47.6%) stddev-sans-first:37.37 15:38:26 INFO - PID 16057 | Values: 75.0 75.0 75.0 165.0 75.0 76.0 74.0 74.0 154.0 76.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.00 stddev:24.04 (30.8%) stddev-sans-first:24.93 15:38:26 INFO - PID 16057 | Values: 79.0 79.0 125.0 78.0 78.0 79.0 133.0 78.0 78.0 126.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 15:38:26 INFO - PID 16057 | Values: 114.0 114.0 114.0 113.0 117.0 114.0 114.0 115.0 113.0 113.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 15:38:26 INFO - PID 16057 | Values: 151.0 150.0 149.0 149.0 149.0 150.0 151.0 149.0 150.0 151.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.25 (2.4%) stddev-sans-first:2.37 15:38:26 INFO - PID 16057 | Values: 94.0 94.0 93.0 99.0 94.0 94.0 94.0 93.0 94.0 99.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.33 (2.4%) stddev-sans-first:1.36 15:38:26 INFO - PID 16057 | Values: 56.0 55.0 54.0 55.0 55.0 55.0 58.0 53.0 55.0 54.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 15:38:26 INFO - PID 16057 | Values: 56.0 57.0 55.0 55.0 57.0 54.0 55.0 55.0 54.0 55.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 15:38:26 INFO - PID 16057 | Values: 76.0 76.0 76.0 75.0 75.0 77.0 76.0 77.0 74.0 75.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:128.00 stddev:12.87 (10.1%) stddev-sans-first:13.65 15:38:26 INFO - PID 16057 | Values: 129.0 127.0 135.0 121.0 123.0 129.0 121.0 126.0 118.0 163.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:176.00 stddev:3.89 (2.2%) stddev-sans-first:2.13 15:38:26 INFO - PID 16057 | Values: 186.0 173.0 174.0 177.0 180.0 176.0 174.0 174.0 175.0 176.0 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.89 (2.7%) stddev-sans-first:1.99 15:38:26 INFO - PID 16057 | Values: 70.0 71.0 67.0 70.0 69.0 66.0 72.0 71.0 68.0 69.0 15:38:26 INFO - PID 16057 | -------- Summary: end -------- 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:38:26 INFO - PID 16057 | 15:38:26 INFO - PID 16057 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:38:26 INFO - TEST-INFO | 16057: exit 0 15:38:26 INFO - TEST-OK | kraken | took 61197ms 15:38:26 INFO - SUITE-END | took 1172s 15:38:27 INFO - Completed test suite (00:19:32) 15:38:27 INFO - javascript benchmark 15:38:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8629.038181375669, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.548245504402, 3163.240822202672, 3166.667499912509, 3169.065125787892, 3170.1440611035023, 6150.969245153768, 6197.752089916404, 6249.250089989202, 6261.906071408933, 6264.655443950581, 6021.548383871216, 6060.878782424349, 6086.087086936962, 6096.390360963913, 6123.0, 5642.971785141079, 5705.65766054036, 5705.971470142644, 5721.084626459768, 5723.399043100477, 5743.5118014968775, 5756.539476841864, 5768.5385169186575, 5775.191473193756, 5884.970575147139, 5720.713964301768, 5749.655020698771, 5793.13103034544, 5811.796587119452, 5840.182374467557, 5514.724263786835, 5605.271314729059, 5659.60382773206, 5682.9147562786175, 5742.023855944458, 5608.074667679828, 5648.265725455705, 5678.886422271573, 5687.971560142214, 5705.74324155414, 6022.728977196037, 6047.7278522466595, 6118.3269840317525, 6148.84627884302, 6150.50795936324, 6480.902786458207, 6579.9671001645165, 6638.568493047985, 6638.701258443381, 6642.734290628369, 6659.03444000622, 6660.467162626978, 6664.233613134503, 6671.699773510204, 6680.86638267232, 6163.229596300463, 6163.87672246557, 6165.044418115244, 6169.568130230886, 6178.258608966953, 6720.798376048726, 6799.286074962157, 6804.489663275274, 6810.8637827244165, 6813.693383797741, 6485.902711459332, 6497.252815926135, 6500.804975850732, 6526.869462610721, 6580.473562115019, 6683.7660681875905, 6703.363180497845, 6757.054012438262, 6761.29006454325, 6778.93221067783, 6646.26891041985, 6652.101966234496, 6748.122744043341, 6749.493787965922, 6767.661616919135, 6560.0, 6666.0, 6670.366315200048, 6680.799576012728, 6773.390394864486, 5229.843104706865, 5366.570674346043, 5374.140137577969, 5381.48875856793, 5413.350397952271, 4559.54404559548, 4592.058627981256, 4631.374764406829, 4683.2038553446, 4689.62483001359, 5737.827865164052, 5744.827655170351, 5748.281464816898, 5748.338941021752, 5756.56825738063, 6782.830429239309, 6789.694463749143, 6802.0, 6805.353491418307, 6806.727730890709, 5722.656640601494, 5820.35976042635, 5867.061270196748, 5891.05743081105, 5902.1146827976145, 5883.294004719461, 5898.911516327258, 5903.522015691836, 5975.581709280309, 5990.700464976734, 6366.267879193952, 6445.452136568444, 6449.806505804833, 6453.774117905851, 6585.769498067544, 6540.934590654033, 6605.900911486236, 6680.3987641112535, 6727.293634168537, 6737.393634572716, 6474.902876456763, 6475.967620161869, 6538.378854008862, 6556.2788093308745, 6570.704318305783, 6481.060246264171, 6522.445592124533, 6543.770968016097, 6574.112494813139, 6631.6684165792485, 6653.9667301663185, 6697.899531507129, 6703.329667033453, 6710.429613482908, 6716.764913228014, 6458.225012998282, 6530.542861999805, 6555.344465553407, 6573.145491086319, 6581.0, 6473.320301368477, 6478.611283323015, 6539.280679125197, 6564.868702625825, 6566.409023187936, 6271.24745030581, 6380.170577824853, 6384.3934826191435, 6484.935150648622, 6486.610803351814, 6498.252700939453, 6531.934680653323, 6616.66916654175, 6622.735090596515, 6628.635425051669, 6326.810195694136, 6367.713452894538, 6396.904046439214, 6438.742450302123, 6470.094186813756], "value": 6085.925778033167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.7117552093484, 855.6748435594474, 879.2350654930211, 882.8543290357095, 1182.6274723462113, 29697.999999999975, 30386.39227215457, 39806.601933980615, 40522.7973860131, 40747.0, 40700.79649601755, 41137.58862411375, 41165.17669646605, 41166.38250426246, 41225.793871030604, 7667.539947603133, 7749.418793590489, 7910.129885712567, 7911.011123609549, 7922.564258965755, 7784.532928024337, 7898.605069746518, 7902.6048697565175, 7902.644381002869, 7904.486208396436, 7881.645325960346, 7898.131205567383, 7933.0, 7953.244441778022, 7955.323797477221, 7852.764417067498, 7899.131095579453, 7901.762947111567, 7913.762587122395, 7920.564368959705, 7715.7685269441445, 7755.8448831023625, 7760.922390776076, 7772.417068719868, 7775.494592851446, 37280.25439491222, 37371.81314093439, 37428.62571374279, 37550.81224593859, 37576.43635345472, 3652.8904132876055, 3661.8535258589623, 3682.263547290526, 3698.3527882620433, 3703.166787472824, 30912.53631195534, 30989.535156972663, 31022.689773102207, 31045.22386940322, 31178.844105779554, 4870.269459581055, 5072.289879416885, 5079.619028572872, 5113.923291150636, 5125.0, 192515.0, 192942.0, 193141.0, 193244.0, 193879.03060484608, 48603.27095093577, 48605.270920936215, 48610.75694621575, 48623.756881216075, 48702.512974869795, 50317.24524132141, 50332.74833625882, 50425.747871260406, 50472.74763626232, 50477.74761126171, 13947.302634868216, 16435.6712865742, 16670.249838757285, 16693.666126677643, 16715.331386744638, 11626.883731162749, 13888.166709997433, 14048.367823447968, 14140.717185656229, 14164.504242351468, 14185.929070354789, 14225.430982760781, 14296.928515357356, 14431.711365772626, 14456.927715361357, 5741.85645358861, 5753.89119588921, 5966.612170208922, 6025.78909738157, 6033.607815491979, 1004.1013293102778, 1007.7531004903699, 1011.9949400253099, 1018.1600179851652, 1048.821700310949, 22729.545409091726, 22944.196953106562, 22964.540709185723, 23087.653685194735, 23109.422264443187, 1118.139032944628, 1122.3995162587976, 1127.1884243344778, 1129.1982692288402, 1138.772245550893, 11943.402829858645, 12123.939380303218, 12238.34615327101, 12271.938640306742, 12275.508979640714, 234128.0, 238638.0, 239262.0, 239269.0, 239328.0, 55189.44810551843, 55255.17117243245, 55425.72287138619, 55925.72037139788, 55986.44013559894, 1462.0642788615294, 1479.4821812365801, 1490.545383657973, 1490.6571488557693, 1508.351408894164, 26198.476030479665, 27219.86390068037, 27256.0, 27349.453010939273, 27363.452730945668, 48221.27668085052, 48235.0, 48236.75881620569, 48275.0, 48373.5162648369, 207590.0, 208732.0, 209023.0, 209062.0, 209641.0, 31456.213594660316, 31635.20911977127, 34455.0, 34693.65306346904, 34831.30337393187, 42204.36693449662, 42452.0, 42504.78747606242, 42837.785811070746, 42917.356239657056, 31821.840890795396, 31851.68148318487, 32134.517982230755, 32245.193870153435, 32427.67572324341, 31469.05592832219, 31643.84178079095, 31979.6802031986, 32116.518252225767, 32445.837770810995, 34047.82976085203, 34332.0, 34445.31109377849, 34558.48162277517, 34833.30333393267, 30656.386872261985, 30715.692843071283, 30802.383952321277, 31272.0, 31403.52894706627, 22861.957730257393, 23082.0, 23360.53278934446, 23386.76613233846, 23522.647160292952], "value": 17426.648964880205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7635481275271, 569.8746275819321, 571.8027280588195, 578.3464684906055, 587.2629849538829, 21872.89063554682, 22731.0, 22748.31755047351, 22758.886205568968, 22772.88613556932, 26623.866880665617, 27233.0, 27288.181354559347, 27323.726762732367, 27325.0, 6564.638944858031, 6711.395974362306, 6717.496187785911, 6720.798376048726, 6721.294264102272, 6319.115323854664, 6597.571157874723, 6598.406143447089, 6617.239017512999, 6617.702203400859, 6575.736970521173, 6587.0, 6596.901046484307, 6607.5374723769355, 6608.570442921219, 6570.967145164243, 6572.93427065728, 6575.473962083021, 6580.276169621337, 6581.045748366508, 6067.939320606782, 6087.269527656666, 6120.938790612126, 6123.8162855114415, 6126.050462178325, 27278.5908211377, 28496.430071398456, 28608.14175574736, 30500.237494062603, 30954.38091238185, 1972.3885595465451, 2005.458526197933, 2012.6075415294024, 2018.3440381875948, 2022.130483891926, 19135.712964305545, 19650.0, 20333.0, 20354.0, 20354.796452035585, 2480.6899137607797, 2489.240781561623, 2526.1411120219213, 2528.064616092039, 2533.8099642526886, 129064.0, 132292.0, 139345.0, 141510.29244853812, 141887.0, 15011.0, 15513.689726205414, 15603.921980390025, 15667.84332156664, 15681.294341754648, 23600.17399391013, 23809.404764881016, 23865.40336491567, 23866.761332386453, 23901.163459278843, 10735.94632026835, 10785.56857725698, 10828.78342433147, 10862.565497380016, 10926.453677316102, 8631.870521942175, 10101.595936162617, 10140.0, 10290.588376464857, 10511.57953681844, 8329.416940814084, 11303.491342889589, 11726.94136529312, 11816.76366472683, 12058.698532536757, 3859.864904728321, 3931.6213690717277, 4162.958370416318, 4259.21204577148, 4291.206870724559, 963.556763888605, 987.3335498538602, 993.8509223616516, 998.3410948773775, 1005.9446730429751, 19943.800561994485, 20229.696554551694, 20399.184032638528, 20574.0, 21009.68485472719, 1059.9682009539727, 1061.3260579531898, 1061.7451811565168, 1071.5713714514256, 1080.0, 11106.666799995852, 11226.831597526043, 11420.600278990196, 11505.13711471643, 11519.95683388536, 489148.0, 490964.0, 516521.0, 530019.0, 534533.0, 118737.40631296962, 124429.37785311196, 126990.36504817416, 127611.0, 127929.36035319764, 1266.2782214138037, 1268.467243757624, 1295.5206573567652, 1313.9277339746216, 1317.617890811654, 20604.0, 20650.896745516176, 20857.687134693297, 21316.78683213148, 21319.720816751043, 59885.101723475054, 60342.39657603543, 61712.0, 62489.687551561954, 62794.0, 74998.0, 76181.23818761963, 76401.0, 76944.61527692326, 77635.61182194053, 12312.630621081382, 12814.231146131262, 14385.712285754436, 14669.706605868036, 15089.396424142911, 23439.179628712915, 23878.52242955166, 23934.28197154088, 24843.751562484144, 25070.0, 19414.805851941866, 19513.70729439088, 19550.804491955467, 19610.80389196147, 19765.0, 17207.56981075483, 17263.654726905643, 17463.126843657512, 17725.0, 18121.546961326072, 19639.60720785605, 19811.10850011724, 19956.90021549883, 20070.39788806338, 20197.0, 14758.188299643623, 14960.251987400805, 15013.474528391454, 15066.849331506544, 15106.942514023913, 18640.90679546648, 18809.247630094644, 18954.147063381904, 19041.238350465825, 19059.90470047641], "value": 12578.366715413025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.5008621853021, 1391.09578773797, 1413.2439145057397, 1416.5750274917523, 1416.9504067357639, 14036.64908377291, 14631.122132672033, 14644.633884152901, 14657.780133297982, 14664.41342346305, 14332.0, 14770.11379317239, 14786.260686965636, 14792.556223313319, 14803.33384997675, 2683.3425810676363, 2757.214193954723, 2758.2276962450446, 2758.544840101381, 2759.296379423244, 2600.6099085137284, 2690.4350086481863, 2772.1683494951535, 2773.334399744067, 2774.6947835738156, 2710.5256580098503, 2728.877200525981, 2750.7111753265917, 2751.380939288664, 2759.1722483255044, 2675.759181673649, 2680.973190268092, 2697.029069534966, 2720.0071973729646, 2725.713800050996, 2611.4124322027583, 2614.1242683700984, 2645.8015648826413, 2665.2270841455957, 2671.772899303542, 14127.15237085778, 14154.079984801057, 14223.857761422356, 14245.430182792676, 14256.92871535646, 7616.581088040156, 7776.300132988002, 7868.488548244346, 7925.8811117833275, 7926.445148839583, 5007.474215207423, 5126.5642420394315, 5248.343957005374, 5252.684838909678, 5273.34083239595, 1844.1516902224992, 1876.0, 1916.626257879714, 1943.2227109156452, 1967.5572996075912, 23759.0, 23845.642315365283, 24117.39706507334, 24612.261632150887, 24640.507189856282, 6348.460380867586, 6700.296468870796, 6725.831854203684, 6921.653917304115, 6927.376536111774, 15702.136382499073, 15721.056736595841, 16052.678946421007, 16552.83447165513, 16559.337626495046, 7757.92242077572, 7930.405219608552, 7941.324987376138, 7948.483348582439, 7990.280874721187, 7275.636218189069, 7344.596047217455, 7362.374198193106, 7365.0, 7433.591152486557, 5036.874078148002, 5199.844004679866, 5216.217567364925, 5262.052830490472, 5345.70598617072, 1524.618845288678, 1540.722669919403, 1544.783730277762, 1549.4344564233973, 1581.9446319378997, 881.8633111867671, 898.1422741282059, 904.9276057915482, 915.7298596913927, 916.679162293192, 7458.701651933862, 7499.775006749806, 7549.245075492407, 7607.315341619281, 7631.656575454118, 708.8759467093238, 719.8020544350345, 724.4819953733, 726.4116065986568, 738.5421038955882, 4637.443506779208, 4639.744814035193, 4660.557247061523, 4684.601808846218, 4726.881827954328, 19852.404427867186, 20153.39539813808, 20196.192152313743, 20241.696374554394, 20320.491987700425, 19497.610047798964, 19773.406797796088, 19774.802251977297, 19788.802111978985, 20940.58118837645, 10461.372317660966, 10620.362778233177, 10625.415602141957, 10630.840537391945, 10635.149188064936, 8048.5975701215875, 8123.47197432165, 8168.918310817054, 8364.832703346021, 8478.279346255636, 17490.212940417965, 17533.561660958578, 17580.296788128333, 17586.472405827844, 17743.29026838912, 17768.378106766202, 17991.280348785902, 18158.27366905309, 18772.436826895217, 19047.04764761784, 10086.0, 10269.97300269967, 10274.280800343904, 10281.074703276741, 10281.17750579937, 13192.934035329761, 13371.53199638008, 13419.127756695783, 13454.52909148175, 13487.460501579826, 10937.726556836144, 11103.0, 11137.944310278397, 11140.498677559692, 11240.325580465198, 10578.682639520826, 10790.406527641055, 10843.67468975932, 10965.671029869116, 11090.667279981613, 9591.808163836544, 9738.220942324739, 9765.072318129767, 9768.56041478121, 9771.755706107404, 7105.32499412555, 7210.783676489714, 7239.674214660458, 7260.128784545888, 7313.0, 7305.634718263959, 7508.2867127622785, 7548.8490230196185, 7563.848723025399, 7578.825282081286], "value": 6444.193575981229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.1737901977813, 514.6140394703972, 524.4440892653787, 534.2627174499193, 535.7917895146444, 6315.652639104847, 6331.936680633193, 6359.523035772324, 6373.311072565768, 6378.936210637892, 6205.348438413969, 6232.875342493158, 6237.750489980395, 6276.717547710353, 6285.371462853713, 5210.817621383243, 5225.608079394042, 5226.634135610509, 5233.73831308435, 5239.271040556607, 4912.0351859256225, 5063.696178229318, 5185.170372740362, 5215.947840521584, 5222.686638801665, 5030.522100400456, 5033.697978121324, 5055.6713813602, 5063.16457784467, 5064.759134012173, 5037.395512538501, 5046.268291097788, 5056.140456122431, 5070.898582028376, 5087.23691446286, 4382.4302840630835, 4502.594766471033, 4515.571020753023, 4534.8866278342975, 4551.749653769041, 6081.209442772411, 6107.847303817396, 6131.63210207389, 6158.599691020069, 6181.443670069715, 5753.280839895013, 5754.1944127822135, 5768.163616275617, 5769.163471296639, 5790.189373487715, 6662.300458451889, 6662.5003124765835, 6666.267010371077, 6674.3325667433355, 6676.198856137246, 4920.114379411704, 4927.950720492785, 4958.438092001008, 4963.230699241623, 4977.352944117278, 6698.229703584101, 6774.220964589135, 6882.793516194522, 6888.311168883121, 7013.580314791439, 5049.318342023853, 5065.214891691794, 5069.619778516626, 5090.261912022736, 5090.41460232078, 5148.279240906276, 5159.922601160985, 5173.4826517347965, 5178.119719647669, 5179.533841954242, 5721.22763426932, 5723.77104915807, 5748.741306641211, 5761.711914404263, 5763.9135412968835, 6655.86688266232, 6671.899136642497, 6683.365080317362, 6694.196696396366, 6696.129503164558, 1773.3527262549335, 1787.6871547479138, 1810.6559753646766, 1817.6546456173548, 1818.1818181818235, 1163.4008485629906, 1238.993805030987, 1239.5311555806397, 1248.6441364211157, 1253.7304479536942, 5775.364709881909, 5801.506871915934, 5817.214676018768, 5828.213191219131, 5840.59115861894, 6690.899636505456, 6741.696623651947, 6815.318468153145, 6821.590704557742, 6867.175938887265, 5695.202671625976, 5817.825465236049, 5818.439886449948, 5823.621464604787, 5864.2083318752275, 3521.6126226115107, 3550.3076900004253, 3558.62634423387, 3567.625399333033, 3589.9282014359565, 6497.577657452251, 6582.111414959015, 6618.106555614931, 6666.333366663295, 6668.733250669919, 6892.862142757117, 6909.585424874524, 6928.653567321614, 6944.7222111116, 6960.443164546824, 6128.938710612837, 6393.936060639334, 6513.9806659935575, 6538.646087408529, 6550.344965503412, 6677.632730199885, 6747.0, 6751.72993080291, 6793.694283757144, 6809.285025072296, 6691.933080669131, 6714.294999025032, 6717.152782984718, 6752.615713778762, 6753.594784312957, 6475.352464753675, 6483.546151769519, 6493.525963609446, 6555.704993275219, 6570.605763654196, 4996.425411077773, 5011.924821127613, 5045.747712614428, 5083.0, 5088.516590923857, 6478.902816457663, 6499.805005849832, 6653.268140504638, 6743.8988415172835, 6822.829429264308, 6468.935310646833, 6530.346965303432, 6532.8366790830605, 6556.311587283458, 6576.079348891063, 6470.805875823733, 6498.902516462163, 6539.771108011197, 6560.343965603402, 6561.245456772533, 6363.96818015907, 6445.970393914852, 6450.7097180627925, 6451.870922588622, 6525.412712855676, 6508.902366464602, 6572.671366431564, 6663.866722665616, 6665.5334126612615, 6675.599464032173, 6386.776462823779, 6440.67796610177, 6453.709583068867, 6472.611643301417, 6501.577397469149], "value": 5109.918918003727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.388187973118, 925.4863550729344, 929.2473096791595, 939.6664184214603, 957.6121670723358, 18669.159887805046, 19843.305484308035, 19881.50296242593, 19887.40337789865, 21751.45621359467, 20955.37133885982, 21435.249766258185, 21468.355949321507, 21480.24819131327, 21528.677069843965, 1013.2906965124424, 1051.7212938571247, 1052.7105046112342, 1055.9524821383018, 1059.0309866472169, 1027.1628622672497, 1045.3048722599501, 1047.010575006619, 1052.5263631365879, 1054.78376932729, 1091.6943255888364, 1091.9454027298643, 1092.4701519762948, 1092.628506307855, 1106.25880659958, 1081.9729506762314, 1083.0415082651832, 1086.6033897627387, 1089.05796486039, 1096.8299913513417, 793.714262865368, 796.0685997383076, 796.9840603187962, 801.0747586537558, 810.4853418079502, 19700.802991970184, 19857.50356241091, 20039.0, 20101.79898201014, 20132.094055767524, 21786.673199902016, 22196.0, 22275.108995640156, 22281.44296392587, 22446.663300050513, 16844.933137589796, 16923.06923119228, 16951.321947122102, 17031.318747250094, 17163.313467461285, 3722.553293604785, 3743.382341913581, 3746.400575907842, 3746.850125994957, 3748.662620364153, 124559.0, 126103.0, 126506.0, 128247.0, 128426.357868211, 16658.33366665344, 16911.23899424529, 17270.654586908193, 17492.21285042176, 17595.73606395905, 30800.0, 31260.0, 31317.217069572987, 31551.211219719233, 31971.840140799148, 7688.884666729891, 7912.367010639135, 8052.436329456882, 8304.335653147733, 8474.491530508189, 4177.164567086595, 4233.555476674905, 4263.189993901211, 4271.273883439822, 4273.273543497613, 5284.867878303073, 5347.117725575236, 5379.757910894019, 5412.350517937873, 5412.512873841373, 1091.858058452396, 1112.5104953820294, 1116.9218154729092, 1135.250734515216, 1138.499060413432, 676.1176664452838, 683.6000939450478, 683.9760608378683, 687.4500399680236, 695.3637421759033, 11477.311361318347, 11590.13074019435, 11888.702782430508, 12347.073969452147, 12892.419841107172, 686.842026333936, 687.2783577243874, 690.1097584116534, 694.0, 700.6251655364356, 5620.735334549694, 5760.481556659921, 5786.942130578725, 5809.792278934063, 5938.465538101505, 108953.0, 111338.44330778456, 111992.44003779929, 112683.43658281656, 118215.40892295484, 98108.50945745225, 100677.0, 101662.0, 104038.47980760048, 104394.4780276109, 81970.59014705008, 82203.5889820547, 87381.5630921854, 88880.11119888848, 89422.55288723514, 12616.432260548114, 12918.741625167257, 13321.866781332063, 13369.26469044212, 13549.390277437342, 39194.0, 40778.38832417576, 40843.795781020905, 41296.79351603223, 42399.788001059795, 69711.0, 69885.65057174681, 70237.64881175765, 70843.64578177282, 74300.62849685717, 15608.595226429676, 17355.7396639048, 17390.913045434692, 17490.650186996445, 17564.648707026045, 20912.37262882116, 21173.576528469654, 21381.0, 21959.231426899983, 22075.0, 18749.6250074995, 19463.513412164808, 19615.70576441326, 20032.0, 20051.799482004993, 18115.275388984293, 18290.634187316446, 18371.265149393876, 18477.260909564004, 19151.904240479267, 17888.0, 18638.34765783191, 18680.5462078041, 19034.7144792831, 19320.516987075436, 12979.675508112372, 13582.728345432839, 13734.0, 14056.226907520184, 14196.29018549089, 14740.336684849422, 15085.47200848009, 15163.166025868242, 15208.0, 15606.84393156054], "value": 9397.223276435181, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 100.0, 108.0, 109.0, 111.0, 111.0, 99.0, 108.0, 108.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 141.0, 166.0, 120.0, 152.0, 159.0, 117.0, 166.0, 120.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 171.0, 168.0, 166.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 165.0, 75.0, 76.0, 74.0, 74.0, 154.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 125.0, 78.0, 78.0, 79.0, 133.0, 78.0, 78.0, 126.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 117.0, 114.0, 114.0, 115.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 149.0, 149.0, 150.0, 151.0, 149.0, 150.0, 151.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 99.0, 94.0, 94.0, 94.0, 93.0, 94.0, 99.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 55.0, 55.0, 58.0, 53.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 55.0, 57.0, 54.0, 55.0, 55.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 75.0, 77.0, 76.0, 77.0, 74.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 135.0, 121.0, 123.0, 129.0, 121.0, 126.0, 118.0, 163.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 173.0, 174.0, 177.0, 180.0, 176.0, 174.0, 174.0, 175.0, 176.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 67.0, 70.0, 69.0, 66.0, 72.0, 71.0, 68.0, 69.0], "value": 69.3, "unit": "score"}]}]} 15:38:27 INFO - Return code: 0 15:38:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:27 INFO - # TBPL SUCCESS # 15:38:27 INFO - Running post-action listener: _package_coverage_data 15:38:27 INFO - Running post-action listener: _resource_record_post_action 15:38:27 INFO - [mozharness: 2017-08-20 22:38:27.381302Z] Finished run-tests step (success) 15:38:27 INFO - Running post-run listener: _resource_record_post_run 15:38:27 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 339968; Write bytes: 442388480; Read time: 100; Write time: 334280 15:38:27 INFO - TinderboxPrint: CPU usage
13.1% 15:38:27 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 100 15:38:27 INFO - TinderboxPrint: I/O write bytes / time
442,388,480 / 334,280 15:38:27 INFO - TinderboxPrint: CPU idle
8,249.7 (86.9%) 15:38:27 INFO - TinderboxPrint: CPU user
1,197.6 (12.6%) 15:38:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:38:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118235136; Read time: 0; Write time: 105760 15:38:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:38:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 335872; Write bytes: 324153344; Read time: 84; Write time: 228520 15:38:28 INFO - Running post-run listener: _upload_blobber_files 15:38:28 INFO - Blob upload gear active. 15:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:28 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 15:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:38:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:38:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:38:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:29 INFO - (blobuploader) - INFO - Done attempting. 15:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:32 INFO - (blobuploader) - INFO - Done attempting. 15:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:33 INFO - (blobuploader) - INFO - Done attempting. 15:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:33 INFO - (blobuploader) - INFO - Done attempting. 15:38:33 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:33 INFO - Return code: 0 15:38:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ba81f5ffa7626144c0de62d834afc726407632238adf28fd409056327a40ecc8eb30c29517505b2e9963900d81d4d2cab631dda45399479dae9c47a99450784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f26937828ca07cd8fa286d378c2db1f6fa68ab42d9606c580d43e37dc2027f35cb8b9becd26ef01bac63ffc696e2f9374c26e58297681b7d4ff64df9dd645092", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14cc1c34b9461e6c9a1259e391943c0ccd9aaca6338d03fb9537accc636937f85d833ecedb32c3afbd0b6c9f340a290affff7a1c72fe657107b5c4c4f1bbf41e"} 15:38:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:33 INFO - Contents: 15:38:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ba81f5ffa7626144c0de62d834afc726407632238adf28fd409056327a40ecc8eb30c29517505b2e9963900d81d4d2cab631dda45399479dae9c47a99450784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f26937828ca07cd8fa286d378c2db1f6fa68ab42d9606c580d43e37dc2027f35cb8b9becd26ef01bac63ffc696e2f9374c26e58297681b7d4ff64df9dd645092", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14cc1c34b9461e6c9a1259e391943c0ccd9aaca6338d03fb9537accc636937f85d833ecedb32c3afbd0b6c9f340a290affff7a1c72fe657107b5c4c4f1bbf41e"} 15:38:33 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:33 INFO - Copying logs to upload dir... 15:38:33 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.407679 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-20 15:38:33.726265) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:33.733691) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ba81f5ffa7626144c0de62d834afc726407632238adf28fd409056327a40ecc8eb30c29517505b2e9963900d81d4d2cab631dda45399479dae9c47a99450784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f26937828ca07cd8fa286d378c2db1f6fa68ab42d9606c580d43e37dc2027f35cb8b9becd26ef01bac63ffc696e2f9374c26e58297681b7d4ff64df9dd645092", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14cc1c34b9461e6c9a1259e391943c0ccd9aaca6338d03fb9537accc636937f85d833ecedb32c3afbd0b6c9f340a290affff7a1c72fe657107b5c4c4f1bbf41e"} build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ba81f5ffa7626144c0de62d834afc726407632238adf28fd409056327a40ecc8eb30c29517505b2e9963900d81d4d2cab631dda45399479dae9c47a99450784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f26937828ca07cd8fa286d378c2db1f6fa68ab42d9606c580d43e37dc2027f35cb8b9becd26ef01bac63ffc696e2f9374c26e58297681b7d4ff64df9dd645092", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14cc1c34b9461e6c9a1259e391943c0ccd9aaca6338d03fb9537accc636937f85d833ecedb32c3afbd0b6c9f340a290affff7a1c72fe657107b5c4c4f1bbf41e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:33.763124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:33.763435) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1503266640.841794-780068319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:33.843900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:33.844182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:33.847465) ========= ========= Total master_lag: 0.06 =========