builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1503532419.94 results: success (0) revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:39.944574) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:39.945012) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:39.945304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:39.958156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:39.958550) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 16:53:39-- 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% 54.5M=0s 2017-08-23 16:53:40 (54.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:40.071672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:40.072032) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:40.122205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-23 16:53:40.122543) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0abd25e1f4acced652d180c34b7c9eda638deb1 --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 f0abd25e1f4acced652d180c34b7c9eda638deb1 --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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 16:53:40,174 truncating revision to first 12 chars 2017-08-23 16:53:40,174 Setting DEBUG logging. 2017-08-23 16:53:40,174 attempt 1/10 2017-08-23 16:53:40,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0abd25e1f4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 16:53:40,682 attempt 1/10 2017-08-23 16:53:41,314 current task status: no status available at this point. state: STARTED 2017-08-23 16:53:41,315 sleeping for 9.00s (attempt 1/10) 2017-08-23 16:53:50,324 attempt 2/10 2017-08-23 16:53:50,732 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-23 16:53:50,953 unpacking tar archive at: mozilla-central-f0abd25e1f4a/testing/mozharness/ program finished with exit code 0 elapsedTime=11.187177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-23 16:53:51.326462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:51.326793) ========= script_repo_revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:51.327160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:51.327438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 16:53:51.339617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2017-08-23 16:53:51.339951) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:51 INFO - MultiFileLogger online at 20170823 16:53:51 in /builds/slave/test 16:53:51 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 16:53:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:51 INFO - {'append_to_log': False, 16:53:51 INFO - 'base_work_dir': '/builds/slave/test', 16:53:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:53:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:51 INFO - 'branch': 'Firefox-Non-PGO', 16:53:51 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:51 INFO - 'code_coverage': False, 16:53:51 INFO - 'config_files': ('talos/linux_config.py',), 16:53:51 INFO - 'default_actions': ('clobber', 16:53:51 INFO - 'read-buildbot-config', 16:53:51 INFO - 'download-and-extract', 16:53:51 INFO - 'populate-webroot', 16:53:51 INFO - 'create-virtualenv', 16:53:51 INFO - 'install', 16:53:51 INFO - 'setup-mitmproxy', 16:53:51 INFO - 'run-tests'), 16:53:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:51 INFO - 'disable_ccov_upload': False, 16:53:51 INFO - 'download_minidump_stackwalk': True, 16:53:51 INFO - 'download_symbols': 'ondemand', 16:53:51 INFO - 'enable_stylo': False, 16:53:51 INFO - 'enable_webrender': False, 16:53:51 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:53:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:51 INFO - 'gecko_profile': False, 16:53:51 INFO - 'gecko_profile_interval': 0, 16:53:51 INFO - 'installer_path': 'installer.exe', 16:53:51 INFO - 'log_level': 'info', 16:53:51 INFO - 'log_name': 'talos', 16:53:51 INFO - 'log_to_console': True, 16:53:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:51 INFO - 'opt_config_files': (), 16:53:51 INFO - 'pip_index': False, 16:53:51 INFO - 'suite': 'dromaeojs-e10s', 16:53:51 INFO - 'system_bits': '32', 16:53:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:51 INFO - 'title': 'talos-linux64-ix-005', 16:53:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:51 INFO - 'use_talos_json': True, 16:53:51 INFO - 'verify': 'False', 16:53:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:51 INFO - 'work_dir': 'build'} 16:53:51 INFO - [mozharness: 2017-08-23 23:53:51.531477Z] Running clobber step. 16:53:51 INFO - Running pre-action listener: _resource_record_pre_action 16:53:51 INFO - Running main action method: clobber 16:53:51 INFO - rmtree: /builds/slave/test/build 16:53:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:52 INFO - Running post-action listener: _resource_record_post_action 16:53:52 INFO - [mozharness: 2017-08-23 23:53:52.558273Z] Finished clobber step (success) 16:53:52 INFO - [mozharness: 2017-08-23 23:53:52.558372Z] Running read-buildbot-config step. 16:53:52 INFO - Running pre-action listener: _resource_record_pre_action 16:53:52 INFO - Running main action method: read_buildbot_config 16:53:52 INFO - Using buildbot properties: 16:53:52 INFO - { 16:53:52 INFO - "project": "", 16:53:52 INFO - "product": "firefox", 16:53:52 INFO - "who": "kwierso@gmail.com", 16:53:52 INFO - "installer_path": "public/build/target.tar.bz2", 16:53:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:53:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:53:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:53:52 INFO - "stage_platform": "linux64", 16:53:52 INFO - "basedir": "/builds/slave/test", 16:53:52 INFO - "buildnumber": 1097, 16:53:52 INFO - "platform": "ubuntu64_hw", 16:53:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:53:52 INFO - "slavebuilddir": "test", 16:53:52 INFO - "taskId": "PNnkchrNTMaK8LfcSbxk9w", 16:53:52 INFO - "branch": "mozilla-central", 16:53:52 INFO - "script_repo_revision": "production", 16:53:52 INFO - "revision": "f0abd25e1f4acced652d180c34b7c9eda638deb1", 16:53:52 INFO - "slavename": "talos-linux64-ix-005", 16:53:52 INFO - "repo_path": "mozilla-central" 16:53:52 INFO - } 16:53:52 INFO - Finding installer, test and symbols from parent task. 16:53:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNnkchrNTMaK8LfcSbxk9w'}, attempt #1 16:53:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PNnkchrNTMaK8LfcSbxk9w'}, attempt #1 16:53:53 INFO - Task dependencies: OO07YykgQ7SfVQl5pfp5jg 16:53:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg'}, attempt #1 16:53:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:53:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 16:53:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip 16:53:53 INFO - Running post-action listener: _resource_record_post_action 16:53:53 INFO - [mozharness: 2017-08-23 23:53:53.919760Z] Finished read-buildbot-config step (success) 16:53:53 INFO - [mozharness: 2017-08-23 23:53:53.919977Z] Running download-and-extract step. 16:53:53 INFO - Running pre-action listener: _resource_record_pre_action 16:53:53 INFO - Running main action method: download_and_extract 16:53:53 INFO - mkdir: /builds/slave/test/build/tests 16:53:53 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')]} 16:53:53 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 16:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:53:54 INFO - Downloaded 989 bytes. 16:53:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:53:54 INFO - Using the following test package requirements: 16:53:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:53:54 INFO - u'common': [u'target.common.tests.zip'], 16:53:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:53:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:53:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:53:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:53:54 INFO - u'mozbase': [u'target.common.tests.zip'], 16:53:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:53:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:53:54 INFO - u'web-platform': [u'target.common.tests.zip', 16:53:54 INFO - u'target.web-platform.tests.tar.gz'], 16:53:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:53:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:53:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 16:53:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:53:54 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 16:53:56 INFO - Content-Length response header: 54950441 16:53:56 INFO - Bytes received: 54950441 16:54:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:54:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 16:54:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:54:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 16:54:08 INFO - Content-Length response header: 54950441 16:54:08 INFO - Bytes received: 54950441 16:54:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip 16:54:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:54:19 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip into memory 16:54:20 INFO - Content-Length response header: 14496384 16:54:20 INFO - Bytes received: 14496384 16:54:21 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')]} 16:54:21 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:54:21 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:54:23 INFO - Downloaded 61087534 bytes. 16:54:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:54:23 INFO - mkdir: /builds/slave/test/properties 16:54:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:23 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:23 INFO - Contents: 16:54:23 INFO - build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 16:54:23 INFO - Running post-action listener: _resource_record_post_action 16:54:23 INFO - Running post-action listener: find_tests_for_verification 16:54:23 INFO - Running post-action listener: set_extra_try_arguments 16:54:23 INFO - [mozharness: 2017-08-23 23:54:23.576340Z] Finished download-and-extract step (success) 16:54:23 INFO - [mozharness: 2017-08-23 23:54:23.576437Z] Running populate-webroot step. 16:54:23 INFO - Running pre-action listener: _resource_record_pre_action 16:54:23 INFO - Running main action method: populate_webroot 16:54:23 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:23 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:23 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:23 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'tests': ['damp', 'tps']}, 16:54:23 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['damp', 'tps']}, 16:54:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:54:23 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:54:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:54:23 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:54:23 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:23 INFO - 'ts_paint', 16:54:23 INFO - 'tpaint', 16:54:23 INFO - 'sessionrestore', 16:54:23 INFO - 'sessionrestore_many_windows', 16:54:23 INFO - 'sessionrestore_no_auto_restore', 16:54:23 INFO - 'tabpaint']}, 16:54:23 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['a11yr', 16:54:23 INFO - 'ts_paint', 16:54:23 INFO - 'tpaint', 16:54:23 INFO - 'sessionrestore', 16:54:23 INFO - 'sessionrestore_many_windows', 16:54:23 INFO - 'sessionrestore_no_auto_restore', 16:54:23 INFO - 'tabpaint']}, 16:54:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:54:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:54:23 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['bloom_basic_singleton']}, 16:54:23 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['bloom_basic']}, 16:54:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:23 INFO - 'tsvgr_opacity', 16:54:23 INFO - 'tart', 16:54:23 INFO - 'tscrollx', 16:54:23 INFO - 'tsvg_static']}, 16:54:23 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['tsvgx', 16:54:23 INFO - 'tsvgr_opacity', 16:54:23 INFO - 'tart', 16:54:23 INFO - 'tscrollx', 16:54:23 INFO - 'tsvg_static']}, 16:54:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:54:23 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--stylo'], 16:54:23 INFO - 'tests': ['tp5o']}, 16:54:23 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:54:23 INFO - 'talos_options': ['--mitmproxy', 16:54:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:54:23 INFO - '--firstNonBlankPaint'], 16:54:23 INFO - 'tests': ['tp6_google', 16:54:23 INFO - 'tp6_youtube', 16:54:23 INFO - 'tp6_amazon', 16:54:23 INFO - 'tp6_facebook']}, 16:54:23 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:54:23 INFO - 'talos_options': ['--stylo', 16:54:23 INFO - '--mitmproxy', 16:54:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:54:23 INFO - '--firstNonBlankPaint'], 16:54:23 INFO - 'tests': ['tp6_google', 16:54:23 INFO - 'tp6_youtube', 16:54:23 INFO - 'tp6_amazon', 16:54:23 INFO - 'tp6_facebook']}, 16:54:23 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:54:23 INFO - 'talos_options': ['--stylo', 16:54:23 INFO - '--stylo-threads=1', 16:54:23 INFO - '--mitmproxy', 16:54:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:54:23 INFO - '--firstNonBlankPaint'], 16:54:23 INFO - 'tests': ['tp6_google', 16:54:23 INFO - 'tp6_youtube', 16:54:23 INFO - 'tp6_amazon', 16:54:23 INFO - 'tp6_facebook']}, 16:54:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--xperf_path', 16:54:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:23 INFO - 'tests': ['tp5n']}, 16:54:23 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:54:23 INFO - 'talos_options': ['--stylo', 16:54:23 INFO - '--xperf_path', 16:54:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:23 INFO - 'tests': ['tp5n']}}} 16:54:23 INFO - Running post-action listener: _resource_record_post_action 16:54:23 INFO - [mozharness: 2017-08-23 23:54:23.590652Z] Finished populate-webroot step (success) 16:54:23 INFO - [mozharness: 2017-08-23 23:54:23.590741Z] Running create-virtualenv step. 16:54:23 INFO - Running pre-action listener: _resource_record_pre_action 16:54:23 INFO - Running main action method: create_virtualenv 16:54:23 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:23 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:54:23 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:54:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:54:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:24 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:24 INFO - Installing pip...............done. 16:54:24 INFO - Return code: 0 16:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:54:24 INFO - Reading from file tmpfile_stdout 16:54:24 INFO - Output received: 16:54:24 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:54:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54: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')]} 16:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54: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', 'pip>=1.5'] in /builds/slave/test/build 16:54: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 pip>=1.5 16:54:24 INFO - Using env: {'DISPLAY': ':0', 16:54:24 INFO - 'HOME': '/home/cltbld', 16:54:24 INFO - 'LANG': 'en_US.UTF-8', 16:54:24 INFO - 'LANGUAGE': 'en_US:en', 16:54:24 INFO - 'LOGNAME': 'cltbld', 16:54:24 INFO - 'MAIL': '/var/mail/cltbld', 16:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:24 INFO - 'MOZ_NO_REMOTE': '1', 16:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:24 INFO - 'NO_EM_RESTART': '1', 16:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:24 INFO - 'PWD': '/builds/slave/test', 16:54:24 INFO - 'SHELL': '/bin/bash', 16:54:24 INFO - 'SHLVL': '1', 16:54:24 INFO - 'TERM': 'linux', 16:54:24 INFO - 'TMOUT': '86400', 16:54:24 INFO - 'USER': 'cltbld', 16:54:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:24 INFO - '_': '/tools/buildbot/bin/python'} 16:54:25 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:54:25 INFO - Downloading/unpacking pip>=1.5 16:54:25 INFO - Running setup.py egg_info for package pip 16:54:25 INFO - warning: no files found matching 'pip/cacert.pem' 16:54:25 INFO - warning: no files found matching '*.html' under directory 'docs' 16:54:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:54:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:54:25 INFO - Installing collected packages: pip 16:54:25 INFO - Found existing installation: pip 1.1 16:54:25 INFO - Uninstalling pip: 16:54:25 INFO - Successfully uninstalled pip 16:54:25 INFO - Running setup.py install for pip 16:54:25 INFO - warning: no files found matching 'pip/cacert.pem' 16:54:25 INFO - warning: no files found matching '*.html' under directory 'docs' 16:54:25 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:54:25 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:54:25 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:54:25 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:54:25 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:54:25 INFO - Successfully installed pip 16:54:25 INFO - Cleaning up... 16:54:25 INFO - Return code: 0 16:54:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54:25 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')]} 16:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:25 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')]} 16:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:25 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:25 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 16:54:25 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 16:54:25 INFO - Using env: {'DISPLAY': ':0', 16:54:25 INFO - 'HOME': '/home/cltbld', 16:54:25 INFO - 'LANG': 'en_US.UTF-8', 16:54:25 INFO - 'LANGUAGE': 'en_US:en', 16:54:25 INFO - 'LOGNAME': 'cltbld', 16:54:25 INFO - 'MAIL': '/var/mail/cltbld', 16:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:25 INFO - 'MOZ_NO_REMOTE': '1', 16:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:25 INFO - 'NO_EM_RESTART': '1', 16:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:25 INFO - 'PWD': '/builds/slave/test', 16:54:25 INFO - 'SHELL': '/bin/bash', 16:54:25 INFO - 'SHLVL': '1', 16:54:25 INFO - 'TERM': 'linux', 16:54:25 INFO - 'TMOUT': '86400', 16:54:25 INFO - 'USER': 'cltbld', 16:54:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:25 INFO - '_': '/tools/buildbot/bin/python'} 16:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:26 INFO - Downloading/unpacking psutil>=3.1.1 16:54: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 16:54: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 16:54: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 16:54: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 16:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:27 INFO - Installing collected packages: psutil 16:54:27 INFO - Running setup.py install for psutil 16:54:27 INFO - building 'psutil._psutil_linux' extension 16:54:27 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 16:54:27 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 16:54:27 INFO - building 'psutil._psutil_posix' extension 16:54:27 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 16:54:27 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 16:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:27 INFO - Successfully installed psutil 16:54:27 INFO - Cleaning up... 16:54:27 INFO - Return code: 0 16:54:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:27 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')]} 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:27 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')]} 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:27 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:27 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 16:54:27 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 16:54:27 INFO - Using env: {'DISPLAY': ':0', 16:54:27 INFO - 'HOME': '/home/cltbld', 16:54:27 INFO - 'LANG': 'en_US.UTF-8', 16:54:27 INFO - 'LANGUAGE': 'en_US:en', 16:54:27 INFO - 'LOGNAME': 'cltbld', 16:54:27 INFO - 'MAIL': '/var/mail/cltbld', 16:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:27 INFO - 'MOZ_NO_REMOTE': '1', 16:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:27 INFO - 'NO_EM_RESTART': '1', 16:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:27 INFO - 'PWD': '/builds/slave/test', 16:54:27 INFO - 'SHELL': '/bin/bash', 16:54:27 INFO - 'SHLVL': '1', 16:54:27 INFO - 'TERM': 'linux', 16:54:27 INFO - 'TMOUT': '86400', 16:54:27 INFO - 'USER': 'cltbld', 16:54:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:27 INFO - '_': '/tools/buildbot/bin/python'} 16:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:29 INFO - Installing collected packages: mozsystemmonitor 16:54:29 INFO - Running setup.py install for mozsystemmonitor 16:54:29 INFO - Successfully installed mozsystemmonitor 16:54:29 INFO - Cleaning up... 16:54:29 INFO - Return code: 0 16:54:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:29 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:29 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 16:54:29 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 16:54:29 INFO - Using env: {'DISPLAY': ':0', 16:54:29 INFO - 'HOME': '/home/cltbld', 16:54:29 INFO - 'LANG': 'en_US.UTF-8', 16:54:29 INFO - 'LANGUAGE': 'en_US:en', 16:54:29 INFO - 'LOGNAME': 'cltbld', 16:54:29 INFO - 'MAIL': '/var/mail/cltbld', 16:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:29 INFO - 'MOZ_NO_REMOTE': '1', 16:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:29 INFO - 'NO_EM_RESTART': '1', 16:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:29 INFO - 'PWD': '/builds/slave/test', 16:54:29 INFO - 'SHELL': '/bin/bash', 16:54:29 INFO - 'SHLVL': '1', 16:54:29 INFO - 'TERM': 'linux', 16:54:29 INFO - 'TMOUT': '86400', 16:54:29 INFO - 'USER': 'cltbld', 16:54:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:29 INFO - '_': '/tools/buildbot/bin/python'} 16:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:29 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:29 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 16:54:29 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 16:54:29 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 16:54:29 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 16:54:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:31 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:31 INFO - warning: no files found matching '*.txt' 16:54:31 INFO - no previously-included directories found matching 'build' 16:54:31 INFO - no previously-included directories found matching 'dist' 16:54:31 INFO - no previously-included directories found matching '.git*' 16:54:31 INFO - Installing collected packages: jsonschema, functools32 16:54:31 INFO - Running setup.py install for functools32 16:54:31 INFO - warning: no files found matching '*.txt' 16:54:31 INFO - no previously-included directories found matching 'build' 16:54:31 INFO - no previously-included directories found matching 'dist' 16:54:31 INFO - no previously-included directories found matching '.git*' 16:54:31 INFO - Successfully installed jsonschema functools32 16:54:31 INFO - Cleaning up... 16:54:31 INFO - Return code: 0 16:54:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:31 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:31 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 16:54:31 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 16:54:31 INFO - Using env: {'DISPLAY': ':0', 16:54:31 INFO - 'HOME': '/home/cltbld', 16:54:31 INFO - 'LANG': 'en_US.UTF-8', 16:54:31 INFO - 'LANGUAGE': 'en_US:en', 16:54:31 INFO - 'LOGNAME': 'cltbld', 16:54:31 INFO - 'MAIL': '/var/mail/cltbld', 16:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:31 INFO - 'MOZ_NO_REMOTE': '1', 16:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:31 INFO - 'NO_EM_RESTART': '1', 16:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:31 INFO - 'PWD': '/builds/slave/test', 16:54:31 INFO - 'SHELL': '/bin/bash', 16:54:31 INFO - 'SHLVL': '1', 16:54:31 INFO - 'TERM': 'linux', 16:54:31 INFO - 'TMOUT': '86400', 16:54:31 INFO - 'USER': 'cltbld', 16:54:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:31 INFO - '_': '/tools/buildbot/bin/python'} 16:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:31 INFO - Cleaning up... 16:54:31 INFO - Return code: 0 16:54:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:31 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:31 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 16:54:31 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 16:54:31 INFO - Using env: {'DISPLAY': ':0', 16:54:31 INFO - 'HOME': '/home/cltbld', 16:54:31 INFO - 'LANG': 'en_US.UTF-8', 16:54:31 INFO - 'LANGUAGE': 'en_US:en', 16:54:31 INFO - 'LOGNAME': 'cltbld', 16:54:31 INFO - 'MAIL': '/var/mail/cltbld', 16:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:31 INFO - 'MOZ_NO_REMOTE': '1', 16:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:31 INFO - 'NO_EM_RESTART': '1', 16:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:31 INFO - 'PWD': '/builds/slave/test', 16:54:31 INFO - 'SHELL': '/bin/bash', 16:54:31 INFO - 'SHLVL': '1', 16:54:31 INFO - 'TERM': 'linux', 16:54:31 INFO - 'TMOUT': '86400', 16:54:31 INFO - 'USER': 'cltbld', 16:54:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:31 INFO - '_': '/tools/buildbot/bin/python'} 16:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:54: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 16:54: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 16:54: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 16:54: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 16:54:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:32 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 16:54:32 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 16:54:32 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 16:54:32 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 16:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54: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 16:54: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 16:54: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 16:54: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 16:54:33 INFO - Downloading docopt-0.6.1.tar.gz 16:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:33 INFO - Running setup.py install for blobuploader 16:54:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:33 INFO - Running setup.py install for requests 16:54:33 INFO - Running setup.py install for docopt 16:54:33 INFO - Successfully installed blobuploader requests docopt 16:54:33 INFO - Cleaning up... 16:54:33 INFO - Return code: 0 16:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54: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')]} 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:34 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:34 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 16:54:34 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 16:54:34 INFO - Using env: {'DISPLAY': ':0', 16:54:34 INFO - 'HOME': '/home/cltbld', 16:54:34 INFO - 'LANG': 'en_US.UTF-8', 16:54:34 INFO - 'LANGUAGE': 'en_US:en', 16:54:34 INFO - 'LOGNAME': 'cltbld', 16:54:34 INFO - 'MAIL': '/var/mail/cltbld', 16:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:34 INFO - 'MOZ_NO_REMOTE': '1', 16:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:34 INFO - 'NO_EM_RESTART': '1', 16:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:34 INFO - 'PWD': '/builds/slave/test', 16:54:34 INFO - 'SHELL': '/bin/bash', 16:54:34 INFO - 'SHLVL': '1', 16:54:34 INFO - 'TERM': 'linux', 16:54:34 INFO - 'TMOUT': '86400', 16:54:34 INFO - 'USER': 'cltbld', 16:54:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:34 INFO - '_': '/tools/buildbot/bin/python'} 16:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:34 INFO - Running setup.py (path:/tmp/pip-7SoX9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:34 INFO - Running setup.py (path:/tmp/pip-7XML2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:34 INFO - Running setup.py (path:/tmp/pip-qnpdG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:34 INFO - Running setup.py (path:/tmp/pip-GeYWOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:34 INFO - Running setup.py (path:/tmp/pip-Po5pEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:34 INFO - Running setup.py (path:/tmp/pip-AfI0Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:34 INFO - Running setup.py (path:/tmp/pip-S9g7oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:34 INFO - Running setup.py (path:/tmp/pip-ITtmKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:34 INFO - Running setup.py (path:/tmp/pip-RHe9ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:34 INFO - Running setup.py (path:/tmp/pip-qB0LSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Running setup.py (path:/tmp/pip-xmcgNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:35 INFO - Running setup.py (path:/tmp/pip-FeQO5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:35 INFO - Running setup.py (path:/tmp/pip-pZspnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:35 INFO - Running setup.py (path:/tmp/pip-vbC41F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:35 INFO - Running setup.py (path:/tmp/pip-kG4x16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:35 INFO - Running setup.py (path:/tmp/pip-tcirYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:35 INFO - Running setup.py (path:/tmp/pip-Eld6Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:35 INFO - Running setup.py install for manifestparser 16:54:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozcrash 16:54:35 INFO - Running setup.py install for mozdebug 16:54:35 INFO - Running setup.py install for mozdevice 16:54:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozfile 16:54:35 INFO - Running setup.py install for mozhttpd 16:54:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozinfo 16:54:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozInstall 16:54:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozleak 16:54:36 INFO - Running setup.py install for mozlog 16:54:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for moznetwork 16:54:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozprocess 16:54:36 INFO - Running setup.py install for mozprofile 16:54:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozrunner 16:54:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozscreenshot 16:54:36 INFO - Running setup.py install for moztest 16:54:37 INFO - Running setup.py install for mozversion 16:54:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:37 INFO - Cleaning up... 16:54:37 INFO - Return code: 0 16:54:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:37 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')]} 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:37 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')]} 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:37 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:37 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 16:54:37 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 16:54:37 INFO - Using env: {'DISPLAY': ':0', 16:54:37 INFO - 'HOME': '/home/cltbld', 16:54:37 INFO - 'LANG': 'en_US.UTF-8', 16:54:37 INFO - 'LANGUAGE': 'en_US:en', 16:54:37 INFO - 'LOGNAME': 'cltbld', 16:54:37 INFO - 'MAIL': '/var/mail/cltbld', 16:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:37 INFO - 'MOZ_NO_REMOTE': '1', 16:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:37 INFO - 'NO_EM_RESTART': '1', 16:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:37 INFO - 'PWD': '/builds/slave/test', 16:54:37 INFO - 'SHELL': '/bin/bash', 16:54:37 INFO - 'SHLVL': '1', 16:54:37 INFO - 'TERM': 'linux', 16:54:37 INFO - 'TMOUT': '86400', 16:54:37 INFO - 'USER': 'cltbld', 16:54:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:37 INFO - '_': '/tools/buildbot/bin/python'} 16:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 INFO - Running setup.py (path:/tmp/pip-4NYstx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 INFO - Running setup.py (path:/tmp/pip-nw66n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 INFO - Running setup.py (path:/tmp/pip-6RHbZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:37 INFO - Running setup.py (path:/tmp/pip-bqg0WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:37 INFO - Running setup.py (path:/tmp/pip-5k99Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:37 INFO - Running setup.py (path:/tmp/pip-F6pEeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:37 INFO - Running setup.py (path:/tmp/pip-i0yyPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:37 INFO - Running setup.py (path:/tmp/pip-BjB3Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:37 INFO - Running setup.py (path:/tmp/pip-dC96rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:38 INFO - Running setup.py (path:/tmp/pip-ycvaaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:38 INFO - Running setup.py (path:/tmp/pip-HWCvOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 INFO - Running setup.py (path:/tmp/pip-frh2Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:38 INFO - Running setup.py (path:/tmp/pip-R15jt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:38 INFO - Running setup.py (path:/tmp/pip-X9hlUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:38 INFO - Running setup.py (path:/tmp/pip-VZ3Bhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:38 INFO - Running setup.py (path:/tmp/pip-QwLz80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:38 INFO - Running setup.py (path:/tmp/pip-N7Sqvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:38 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)) 16:54:38 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)) 16:54:38 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)) 16:54:38 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)) 16:54:38 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)) 16:54:38 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)) 16:54:38 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)) 16:54:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:39 INFO - Downloading blessings-1.6.tar.gz 16:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:39 INFO - Installing collected packages: blessings 16:54:39 INFO - Running setup.py install for blessings 16:54:39 INFO - Successfully installed blessings 16:54:39 INFO - Cleaning up... 16:54:39 INFO - Return code: 0 16:54:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:40 INFO - Reading from file tmpfile_stdout 16:54:40 INFO - Current package versions: 16:54:40 INFO - argparse == 1.2.1 16:54:40 INFO - blessings == 1.6 16:54:40 INFO - blobuploader == 1.2.4 16:54:40 INFO - docopt == 0.6.1 16:54:40 INFO - functools32 == 3.2.3-2 16:54:40 INFO - jsonschema == 2.5.1 16:54:40 INFO - manifestparser == 1.1 16:54:40 INFO - mozInstall == 1.13 16:54:40 INFO - mozcrash == 1.0 16:54:40 INFO - mozdebug == 0.1 16:54:40 INFO - mozdevice == 0.51 16:54:40 INFO - mozfile == 1.2 16:54:40 INFO - mozhttpd == 0.7 16:54:40 INFO - mozinfo == 0.10 16:54:40 INFO - mozleak == 0.1 16:54:40 INFO - mozlog == 3.5 16:54:40 INFO - moznetwork == 0.27 16:54:40 INFO - mozprocess == 0.25 16:54:40 INFO - mozprofile == 0.28 16:54:40 INFO - mozrunner == 6.13 16:54:40 INFO - mozscreenshot == 0.1 16:54:40 INFO - mozsystemmonitor == 0.3 16:54:40 INFO - moztest == 0.8 16:54:40 INFO - mozversion == 1.4 16:54:40 INFO - psutil == 3.1.1 16:54:40 INFO - requests == 1.2.3 16:54:40 INFO - wsgiref == 0.1.2 16:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:40 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:40 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 16:54:40 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 16:54:40 INFO - Using env: {'DISPLAY': ':0', 16:54:40 INFO - 'HOME': '/home/cltbld', 16:54:40 INFO - 'LANG': 'en_US.UTF-8', 16:54:40 INFO - 'LANGUAGE': 'en_US:en', 16:54:40 INFO - 'LOGNAME': 'cltbld', 16:54:40 INFO - 'MAIL': '/var/mail/cltbld', 16:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:40 INFO - 'MOZ_NO_REMOTE': '1', 16:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:40 INFO - 'NO_EM_RESTART': '1', 16:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:40 INFO - 'PWD': '/builds/slave/test', 16:54:40 INFO - 'SHELL': '/bin/bash', 16:54:40 INFO - 'SHLVL': '1', 16:54:40 INFO - 'TERM': 'linux', 16:54:40 INFO - 'TMOUT': '86400', 16:54:40 INFO - 'USER': 'cltbld', 16:54:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:40 INFO - '_': '/tools/buildbot/bin/python'} 16:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 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)) 16:54:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:54:41 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)) 16:54:41 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)) 16:54:41 INFO - Installing collected packages: simplejson 16:54:41 INFO - Running setup.py install for simplejson 16:54:41 INFO - building 'simplejson._speedups' extension 16:54:41 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 16:54:42 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 16:54:42 INFO - Successfully installed simplejson 16:54:42 INFO - Cleaning up... 16:54:42 INFO - Return code: 0 16:54:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:42 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 0x28c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a92a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c35f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', '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 16:54:42 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 16:54:42 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 16:54:42 INFO - Using env: {'DISPLAY': ':0', 16:54:42 INFO - 'HOME': '/home/cltbld', 16:54:42 INFO - 'LANG': 'en_US.UTF-8', 16:54:42 INFO - 'LANGUAGE': 'en_US:en', 16:54:42 INFO - 'LOGNAME': 'cltbld', 16:54:42 INFO - 'MAIL': '/var/mail/cltbld', 16:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:42 INFO - 'MOZ_NO_REMOTE': '1', 16:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:42 INFO - 'NO_EM_RESTART': '1', 16:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:42 INFO - 'PWD': '/builds/slave/test', 16:54:42 INFO - 'SHELL': '/bin/bash', 16:54:42 INFO - 'SHLVL': '1', 16:54:42 INFO - 'TERM': 'linux', 16:54:42 INFO - 'TMOUT': '86400', 16:54:42 INFO - 'USER': 'cltbld', 16:54:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:42 INFO - '_': '/tools/buildbot/bin/python'} 16:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:42 INFO - Cleaning up... 16:54:42 INFO - Return code: 0 16:54:42 INFO - Running post-action listener: _resource_record_post_action 16:54:42 INFO - Running post-action listener: _start_resource_monitoring 16:54:42 INFO - Starting resource monitoring. 16:54:42 INFO - [mozharness: 2017-08-23 23:54:42.854359Z] Finished create-virtualenv step (success) 16:54:42 INFO - [mozharness: 2017-08-23 23:54:42.854882Z] Running install step. 16:54:42 INFO - Running pre-action listener: _resource_record_pre_action 16:54:42 INFO - Running main action method: install 16:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Output received: 16:54:43 INFO - Usage: mozinstall [options] installer 16:54:43 INFO - Options: 16:54:43 INFO - -h, --help show this help message and exit 16:54:43 INFO - -d DEST, --destination=DEST 16:54:43 INFO - Directory to install application into. [default: 16:54:43 INFO - "/builds/slave/test"] 16:54:43 INFO - --app=APP Application being installed. [default: firefox] 16:54:43 INFO - mkdir: /builds/slave/test/build/application 16:54:43 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'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:55:00 INFO - Reading from file tmpfile_stdout 16:55:00 INFO - Output received: 16:55:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:55:00 INFO - Running post-action listener: _resource_record_post_action 16:55:00 INFO - [mozharness: 2017-08-23 23:55:00.855562Z] Finished install step (success) 16:55:00 INFO - [mozharness: 2017-08-23 23:55:00.855847Z] Running setup-mitmproxy step. 16:55:00 INFO - Running pre-action listener: _resource_record_pre_action 16:55:00 INFO - Running main action method: setup_mitmproxy 16:55:00 INFO - Skipping: mitmproxy is not required 16:55:00 INFO - Running post-action listener: _resource_record_post_action 16:55:00 INFO - [mozharness: 2017-08-23 23:55:00.856983Z] Finished setup-mitmproxy step (success) 16:55:00 INFO - [mozharness: 2017-08-23 23:55:00.857273Z] Running run-tests step. 16:55:00 INFO - Running pre-action listener: _resource_record_pre_action 16:55:00 INFO - Running pre-action listener: _set_gcov_prefix 16:55:00 INFO - Running main action method: run_tests 16:55:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:00 INFO - Python 2.7.3 16:55:00 INFO - Return code: 0 16:55:00 INFO - grabbing minidump binary from tooltool 16:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c33130>, '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 0x2c34030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c344c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:55:00 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:55:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:55:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:00 INFO - Return code: 0 16:55:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:55:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:00 INFO - ENV: RUST_BACKTRACE is now full 16:55:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:55:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:00 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 16:55:00 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 16:55:00 INFO - Using env: {'DISPLAY': ':0', 16:55:00 INFO - 'HOME': '/home/cltbld', 16:55:00 INFO - 'LANG': 'en_US.UTF-8', 16:55:00 INFO - 'LANGUAGE': 'en_US:en', 16:55:00 INFO - 'LOGNAME': 'cltbld', 16:55:00 INFO - 'MAIL': '/var/mail/cltbld', 16:55:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:00 INFO - 'MOZ_NO_REMOTE': '1', 16:55:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:00 INFO - 'NO_EM_RESTART': '1', 16:55:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:00 INFO - 'PWD': '/builds/slave/test', 16:55:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:00 INFO - 'RUST_BACKTRACE': 'full', 16:55:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:55:00 INFO - 'SHELL': '/bin/bash', 16:55:00 INFO - 'SHLVL': '1', 16:55:00 INFO - 'TERM': 'linux', 16:55:00 INFO - 'TMOUT': '86400', 16:55:00 INFO - 'USER': 'cltbld', 16:55:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916', 16:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:00 INFO - '_': '/tools/buildbot/bin/python'} 16:55:00 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 16:55:01 INFO - mozversion application_buildid: 20170823230708 16:55:01 INFO - mozversion application_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 16:55:01 INFO - mozversion application_display_name: Nightly 16:55:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:01 INFO - mozversion application_name: Firefox 16:55:01 INFO - mozversion application_remotingname: firefox 16:55:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:55:01 INFO - mozversion application_vendor: Mozilla 16:55:01 INFO - mozversion application_version: 57.0a1 16:55:01 INFO - mozversion platform_buildid: 20170823230708 16:55:01 INFO - mozversion platform_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 16:55:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:55:01 INFO - mozversion platform_version: 57.0a1 16:55:01 INFO - using testdate: 1503532501 16:55:01 INFO - actual date: 1503532501 16:55:01 INFO - starting webserver on 'localhost:38511' 16:55:01 INFO - SUITE-START | Running 2 tests 16:55:01 INFO - TEST-START | dromaeo_css 16:55:01 INFO - Initialising browser for dromaeo_css test... 16:55:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38511/getInfo.html -profile /tmp/tmpLrQinL/profile 16:55:01 INFO - TEST-INFO | started process 29504 (/builds/slave/test/build/application/firefox/firefox http://localhost:38511/getInfo.html) 16:55:06 INFO - TEST-INFO | 29504: exit 0 16:55:07 INFO - Browser initialized. 16:55:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:07 INFO - TEST-INFO | started process 29721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrQinL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:08 INFO - PID 29721 | 16:55:08 INFO - PID 29721 | (/builds/slave/test/build/application/firefox/firefox:29772): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:55:08 INFO - PID 29721 | 16:55:08 INFO - PID 29721 | 16:55:08 INFO - PID 29721 | (/builds/slave/test/build/application/firefox/firefox:29827): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:55:08 INFO - PID 29721 | 16:55:08 INFO - PID 29721 | __metrics Screen width/height:1600/1200 16:55:08 INFO - PID 29721 | colorDepth:24 16:55:08 INFO - PID 29721 | Browser inner width/height: 1024/768 16:55:08 INFO - PID 29721 | __metrics 16:55:18 INFO - PID 29721 | RSS: Main: 172339200 16:55:18 INFO - PID 29721 | 16:58:17 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38511/tests/dromaeo/cssquery-ext.html) 16:58:17 INFO - PID 29721 | RSS: Main: 175824896 16:58:17 INFO - PID 29721 | 17:01:19 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-ext.html (next: http://localhost:38511/tests/dromaeo/cssquery-jquery.html) 17:01:20 INFO - PID 29721 | RSS: Main: 172802048 17:01:20 INFO - PID 29721 | 17:04:21 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38511/tests/dromaeo/cssquery-mootools.html) 17:04:22 INFO - PID 29721 | RSS: Main: 174800896 17:04:22 INFO - PID 29721 | 17:07:24 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38511/tests/dromaeo/cssquery-prototype.html) 17:07:24 INFO - PID 29721 | RSS: Main: 172863488 17:07:24 INFO - PID 29721 | 17:10:28 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38511/tests/dromaeo/cssquery-yui.html) 17:10:28 INFO - PID 29721 | RSS: Main: 174161920 17:10:28 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | Cycle 1(1): loaded http://localhost:38511/tests/dromaeo/cssquery-yui.html (next: http://localhost:38511/tests/dromaeo/cssquery-dojo.html) 17:13:30 INFO - PID 29721 | RSS: Main: 176979968 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | __start_tp_report 17:13:30 INFO - PID 29721 | _x_x_mozilla_page_load 17:13:30 INFO - PID 29721 | _x_x_mozilla_page_load_details 17:13:30 INFO - PID 29721 | |i|pagename|runs| 17:13:30 INFO - PID 29721 | |0;dojo.html;3237.223066464049;3240.740740740741;3245.870165193392;3273.52533882587;3295.9505607415895;6141.232345956755;6167.475764560007;6171;6219.346968568298;6275.090111933767;6119.571629985903;6168.660723660197;6178.75284988601;6184.536159788011;6213.968930155354;5695.0318445864195;5726.3700992890745;5728.398518155575;5744.626599271055;5755.539556835443;5743.253377060976;5760.308762948431;5781.768729250825;5797.391273916221;5805.129230615399;5764.884702305952;5839.941600584004;5859.091840764689;5863.58954873159;5890.440408161239;5704;5774.220480235156;5783.045797443417;5790.36306006339;5877.500412464924;5518.365387980353;5536.169574563807;5582.86042848928;5617.045102332572;5666.405027472098;6119.816405507842;6202.627842329474;6207.162033125515;6286.591371560834;6324.209473815773;6642.202935647705;6662.6668666566475;6728;6788.72845086196;6792.93207067928;6554.967225163844;6650.966745166292;6681.76613818514;6755;6758.29037951013;6283.5287353448675;6293.653849038301;6324.019776934582;6327.4938004959495;6339.302676705559;6872.140982377203;6874.346937040973;6913.1358580177475;6959.304069593;6972.407345375598;6572.375624315682;6582.703778329891;6614.536982411281;6643.003549467522;6714.764983225661;6740.224874139439;6742.6628668567355;6759.256481787;6785.389314961579;6794.0827988221945;6564.901526477107;6641.900371494431;6744.920812670048;6747.190337159573;6761.121054262914;6659.500537459709;6659.866802664016;6683.298253683391;6754.5947243165565;6765.05289259504;5373.140297552372;5375.704336261465;5379;5380.461953804588;5397.325334333208;4613.008203236321;4691.953080469151;4729.527047295312;4741.502142275081;4742.454617718938;5745.13822926556;5809.128630705428;5816.41835816415;5841.269841269841;5896.292444906639;6639.568428052161;6706.597604143767;6709.6980635871505;6710.362515561014;6711.563748356341;5781.653100813881;5833.533317334688;5852.882942341129;5885.499732522698;5895.616784908967;5795.333536643256;5844.824655260349;5864.648121112747;5888.676122813286;5889.882202355929;6329.715162817776;6350.714217860115;6369.681515924278;6455.354464553507;6457.644829534327;6642.6014439133805;6698.028785826125;6706.161729783777;6773.593584384953;6776.661166941534;6403.679816009274;6474.2878283387845;6487.740490380332;6487.935120648733;6495.025746137928;6577.2436169841085;6589.24223714279;6663.7001334941015;6673.232578253369;6675.899861502178;6701.564398314094;6702.564333318319;6775.695093720696;6779.627120508222;6780.898286525608;6504.544681872224;6529.281779004401;6544.411003009752;6550.934490655032;6551.246606640298;6376.585521941059;6452.290248072614;6535;6542.313057128933;6560;6267.96866015667;6330.177076979963;6360.522960778053;6414.326495718069;6430.228372595318;6464.450521705708;6500.447461965786;6536.150300460909;6550.868982620416;6604.669766511752;6320.810375688737;6334.651594162366;6381.585196962183;6430.099786030053;6443.0335449682925 17:13:30 INFO - PID 29721 | |1;ext.html;825.987610185847;853.5945425922688;873.183573358909;880.6565439478604;1136.624913778452;37804.05489862752;41723.58276417231;41843;41931.16137677252;41978.37032444508;41343.379849302284;41676;42151;42163.367549486786;42186.36720449196;7694.5383277003275;7826.295633392993;7829.33450656692;7830.882536761953;7836.216378362146;7679.232076792304;7816.765497035098;7818.609069546528;7825.765227043198;7827.060752709683;7794;7799.337056350217;7806.570638614874;7809.687612495493;7820.374370050411;7742.8838567421535;7836.216378362175;7841.21587841217;7841.843163136734;7846.646900889474;7653.961730191313;7717.845643087163;7720.922790772077;7725.072991241031;7726.806829829243;38175.04562385962;38197.61802381968;38200;38398;38448.80775596104;3480.9477857832153;3521.383757842393;3548.520949671787;3550.822458877046;3551.0234685461705;31755.682443175505;31816;31842.36315273705;31967.680323196935;31991.360172796412;5042.697438153723;5191.247269145991;5201.947980520222;5238.1618940969265;5276.472352764731;179796;180350;180370;180432;180988;45925;45940.77029614831;46037;46044.30933536;46306;48593.27110093351;48646.513534864906;48695.5130448691;48798.512014879394;48808;13942.442302307794;14184.645383865485;15885.761713574306;15889.28498217583;16241.83758162427;13230.338483075808;13326.466941322433;13349.599512014654;13350.399232034582;13354.732905342033;13283;13291.20252784836;13317.600471985856;13323.467061317633;13452.32738363078;5218.973905130526;5222.686638801684;5312.309399778082;5477.780888764484;5479.808206712746;961.697065424389;985.2708995343394;986.3835103060587;992.3004281981185;998.3560603410905;22278.77721222767;22460.11209575078;22512.437189070406;22696.319110426382;22868.4282892929;1072.855164552791;1074.9677509674723;1075.6127793994156;1089.7874914391775;1100.6697990602788;11887.346195959306;12123.812136782017;12126.636200913987;12145.878541214652;12169.209001415056;229507;232146;232680;232922;233326;55165.1725224122;55458.445415546135;55495.44504554984;55678.16482752762;55823.44176558264;1416.6954104867502;1425.4440768100449;1433.383645032625;1440.1503113163285;1441.142520200479;26686.19941401761;26920.32699182536;27153.86423067872;27385.315367115185;27424;37265.81367093147;37493.62506375011;37510.62489375071;37533.624663754104;37633.2473350537;200510;200924;200965;201568;201605;34637.30725385529;34648.653513464546;37248.81375593105;38422.423663644506;38451.230975379774;44019.33970990374;45295.09409811851;46488.53511464842;46545.53454465412;46584.767076164404;33771;33917.49123763096;34038.48942265918;34048;34106.31787364288;33460.49809252912;33496.49755253722;33932.32135357329;33999.15002124868;34029.31941361109;37359;37372.62627373692;37567.81216093902;37653.81173094117;37709.24581508409;31383.350996819878;31425;31469.132716820794;31771.84114079415;32397.140428935847;24307.756922430548;24373.26880193597;25047.624285635364;25088.74911250864;25284 17:13:30 INFO - PID 29721 | |2;jquery.html;557.420282905778;562.8339639806256;563.1693252452633;565.2369301443055;569.5585920911293;21516.139354425843;21898.23356182534;22706.318810435692;22728.318150455514;22761.203357882456;21563.676544851838;21797.782022179774;21890.343289701334;21977.34067977963;22048.669269960963;6456.22525296965;6592.505562082839;6592.80221593353;6592.80221593353;6593.044008618771;6010.909836352458;6294.527910406715;6594.3075977022445;6599.901001484982;6602.933970660304;6484.092227088211;6507.44686701631;6510.934890651104;6539.77110801122;6555.34446555343;6524.869502609945;6564.04821300911;6573.671316434183;6573.868522629568;6576.835579110512;6082.057281121433;6087.3303936566945;6088.056351265561;6092.786752463687;6101;28140.71859281422;28483.85758071217;28562.428751425065;29563.704362956527;29612.11163665072;2085.7497100348055;2127.181035301405;2128.138104067855;2129;2136.0387825478597;19098.618027639368;20089.397318080482;20092.1963121475;20100.798992010037;20130.496737581532;2420.491696743686;2427.490227052321;2462.544429280571;2486.689163854518;2498.3379404457833;135304;137555.31222343823;137597;140200.29899850435;140319.29840350835;14115.647108822362;14211.715765684628;14630.19533925623;14640.633984150481;14826.406943722346;22216.333509994725;22240.77759222387;22351.44121396978;22353.888230559067;22397.888010560167;9859.556319965619;10106.696799096038;10165.186785057178;10191.7452063699;10245.74385640365;7813.921860781433;9507;9577.281703872237;9584.089511496397;9665.226781857575;8019.959900200462;8957.955210223907;9064.229540489001;9110.316726245557;9157.77105572366;2640.9339766505605;2674.251209661298;2713.6472258606254;2740.5889116632666;2791.8604069796834;943.5329511891521;965.32909627808;972.1930797438109;980.5048450532436;987.5259875259916;18939.723167143773;19243.326483573008;19572.510687232647;19616.313429029917;19908;1031.0771859185986;1036.5646428500047;1042.744527590745;1044.7649278912183;1053.841923711434;10537.051665350002;10569.365838049742;10581.206409519316;10597.41714205726;10885;463320;521373;529945;536445;539154;112635;115978.42010789891;119165;119627.40186299013;120002.3999879995;1082.767205050918;1214.5263347294563;1244.6452760963082;1264.5574049082747;1266.2529107826426;20318.79681203228;20353.694694579295;20404;20448.182072716925;20531.3720800446;54985.1752223725;55331.44668553263;55351.16973245485;55527;56219.718901405235;67906;68010;68425;68597.65701171462;69097;11791;12244.571439999558;13832.723345533233;14065.578032659037;20609.175632974515;23472.76527234774;23814.047438102974;23869;24133.75866241315;24139.275821725376;18299.634007319513;18945.957972311655;19059.047047647284;19085.809141908958;19121.426357209308;16968.74546881773;17042.914785425994;17305.577219189072;17411.8682285651;17931.37240196587;18381.17284722164;19207.51981200481;19391.903040484707;19422.223111075964;19445;20454.488637784176;20657.17371305131;21028.47428814292;21146;21212.681809773174;17767.64464710673;18112.45662630123;18519.166637501614;18765.34321298748;18774.436766897015 17:13:30 INFO - PID 29721 | |3;mootools.html;1323.9867601323988;1346.1922846292225;1375.3673310277272;1378.4486205517785;1379.317237967206;14573.271336433188;14593;15084.17037062961;15103.924480377596;15263.313150908209;14818.777718334233;15083.245837708098;15110.697786044273;15117.244137793094;15261.465848695298;2668.986655066722;2708.5937109433544;2711.945761084777;2712.7016028236876;2718.0350975403744;2460.2619214235747;2554.208195459404;2622.6459427977265;2623.0950322138833;2626.330285777124;2682.222155574881;2685.8388496690163;2710.905118320859;2713.3081064328567;2714.185744276719;2686.449277898026;2695.218386667864;2713.240292718042;2739.8904043838224;2741.4791189674097;2599.6620439342955;2641.6433781439646;2644.35213372723;2648.192301348088;2656.468706258737;14588.489402870955;14644.487442939553;14712.411503539846;14722.705545889023;14730.779038314327;7424.443166762514;7683.7310694126;7701.845963080707;7706.113796913371;7708.113566939762;5137.357830271216;5298.682079075268;5471.124620060811;5492.368377636583;5511.366192887789;1929.5851391950798;1934.1199754111844;1969.832564232042;2002.3392280547384;2014.6071516054376;24924.12765553215;24958.625620615523;24990.250292491255;25114.372140696447;25136.497270054497;6624.337566243337;6647.66761661915;6686.765963191265;6833.760818371333;6848.452123830081;16843.663126737396;16844.157792110345;16861.747073793656;16864.156792160342;16874.903131296673;7695.846083078307;7849.450538462253;7860;7860.371170306362;7861.606919653995;6067.2112625359305;6978.476614253951;7047.048648432498;7080.150381954096;7098.3256590623805;4830.3479030331155;5158.329417175743;5354.277172581729;5373.7850485980125;5393.784248630011;1459.729949959261;1501.8047653804936;1506.7287888180012;1509.4716849102945;1512.6067222522004;914.8536234202496;927.3601215161517;931.3340961212765;936.4194199596294;941.270515350595;8457.281131103802;8561.44350617208;8631.352648551383;8654.697085601974;8721.215090641872;985.1675334342613;993.7614972406715;1000.2348203624233;1012.1245122968726;1018.1396719771781;5137.40919794221;5791.420857914175;5830.7084645767545;5887.558433117533;5894;21004;21180.576388472145;21472.4631884201;21518.56962860734;21620.243291484723;20376.59246815085;21005.68491472629;21308;21321.68017479739;21386.358409247438;10898.509567069501;10980.99999999984;11158.218924675357;11388.405623212757;11389;8291.751247462586;8630.309575234092;8773.692920747742;8804.60379282921;8899.199072083544;17791;17954.640907182045;18219.362322318655;18451.354202602844;18473.16870740793;18203.180856861207;18261.54346141357;18860.434186974413;18877.71683424722;19424;10510.211734120125;12339.13626046168;12340.444679989243;12354.691132721753;12365.505379784709;13449.86550134486;13638.386272617558;13910;13922.791158132839;13943.093698909539;11137.10903127764;11185.552577896793;11196.83204751913;11253.549858005588;11259.549618015188;10610.204234682584;10689.465526723478;10900.291481053706;11032.44837758125;11234.719132021439;10154.847677284994;10170.237232207763;10213.897861021294;10263.692089237335;10296.485175741333;7163;7194.4244460442;7211.567305961659;7256.2743725627015;7281.344678978918;7142.9285707144345;7185;7216.747413840701;7219.278072192738;7246.347828695442 17:13:30 INFO - PID 29721 | |4;prototype.html;497.40808437958805;503.29789943029476;522.5140619224121;529.9364076310843;531.0944839049421;6295.244570651523;6307.180066591337;6369.490440764739;6378.138951241581;6402.167718196633;6032.8190154295335;6148.907766383508;6160.876782464348;6164.938350616492;6236.314005459396;4901;5036.219385995177;5045.142325804603;5065.316182315377;5085.1863701807715;5010.223415370605;5015.498450154973;5025.497450254982;5025.547700706936;5037.420696619899;4794.304825800257;4931.334269873575;4978.925316120261;4986.650934434591;4990.950090499103;4960.826371076995;4991.950080499185;5042.747862606891;5047.167217409123;5088.058709138802;4445.355423463579;4489.663275254369;4494.752788596626;4506.977465112686;4511.323301504768;6129.264488261392;6129.264488261392;6163.691815409212;6198;6219.175207247556;5720.742566584514;5727.427257274281;5732.627379220337;5759.798407055733;5793.594448388614;6580.473562115019;6610.413500759832;6615.834604134935;6641.86716265672;6710.396064354231;4853.95146048542;4879.634027447955;4880.438749543777;4890.413150421937;4900.387451568554;6902.137232845895;6907.930920690779;6950.478714096463;6957.339052789976;6995.650217489156;4925.827596034122;5028.421731500851;5033.84898453047;5033.924491132636;5045.823396181116;4990.126727822617;5022.84931452057;5025.648204625714;5077.263796749525;5111.693298402108;5666.744996475169;5695.345035320908;5714.542836573064;5715.6284841486;5760.164776107525;6585.374389432996;6595.406413422815;6637.900431493532;6648.135742353463;6651.966740166365;1656.5692919840928;1688.915554222284;1740.1908112727642;1742.4685470931488;1756.7277072053853;1135.318808714781;1179.127445690183;1207.0927933864473;1217.7442737025146;1233.1429656388902;5732.111522713986;5764.510016648548;5825.970870145622;5846;5878.941210587839;6552.478789635136;6553.180852393451;6602.60384376939;6674.399304062657;6725.226598941184;5691.743871525791;5775.682337471395;5827.737751801179;5852.7658893643775;5859.296884373817;3575.5173051638217;3599.8380072896257;3614.313280476701;3618.3125206210734;3634.582023067381;6388.744450222032;6401.967990160019;6429.38920802523;6459.128017717642;6468.320826313264;6776.322367763283;6856.108705868305;6888.104546408935;6891.173059232824;6898.551594146365;6352.650604216812;6396.264429590657;6405.935940640627;6423.518236132215;6445.742170313135;6774.661266936732;6788.287229840796;6800.693968771516;6813.182418109858;6822.147231596051;6598.802035938929;6602.40578347951;6622.70197841108;6688.130543029375;6758;6305.432511074026;6306.337834527492;6312.873742525216;6423.29343772194;6452.419282264619;4963.156263435297;4964.131277026579;4971.328870602422;4975.875603109951;5041.117804384291;6576.605403675795;6655.700493477902;6680.899786503303;6718.865622687616;6767.560108592926;6435.871282574416;6485;6569.160635022202;6576.868462630625;6596.901046484402;6544.247411547733;6545.705443254969;6546.607203567801;6554.80335589933;6565.113709649137;5979.880402392015;6374.26695929974;6401.167848179707;6481.157449531531;6482.189726284215;6534.379233972765;6546.738130474728;6587.736490540517;6611.834704132435;6671.566348187353;6295.464885484785;6405.231372235362;6414.390632889868;6428.325025872216;6432.2602900667025 17:13:30 INFO - PID 29721 | |5;yui.html;869.4652788535049;881.1188811188813;887.7958069643981;888.4314039015028;891.8038031633042;17802.554936126588;18735.531611709714;18751.90624046878;18799.342023029214;21588.460288492795;19817.504562385948;19943.900280498576;20289;20415.897920510415;20422.489437764063;921.1111277617098;936.419419959626;939.8120375924808;939.9906000940006;940.4968341937065;915.890093188815;941.4304345870752;947.9905200948006;952.9714108576719;953.9904600953971;987.3532835992437;990.6829814459376;991.2912267728573;991.861139440479;991.9851202231936;970.4419958523877;971.455984648599;971.5093877591771;974.3325821812045;975.3026585991015;718.6801873166443;718.7448455798169;719.2771264878816;721.7149226055678;722.5989575785437;17906.731399029024;17923;18696.626067478574;18834.811651883443;18857.339993100177;18838.434846954475;19204.327848525376;19208.231670733156;19231.615367692568;19552.31566895166;16391.83608163927;16790.076545789976;16843.41048063324;16868.32526698943;16869;3461.7922924624604;3500.334936362083;3517.788932664023;3520.383932811748;3523.823808809575;120002;120522.99999999913;121379;122277;124066;15993.28030238642;16270;16482.175891205392;16501.752473712902;16531.6693666126;25904.481910361686;27028.054018109273;27161.864190679316;27167;27215.727842721717;7914.564698941614;8005.9599702001115;8322.20939010793;8617.310615150773;8682.43564168327;3931.2137572485617;3998.7800670963375;4008.158286759813;4009.859654912064;4010.2781499329817;4985.750712464434;5243.082460569462;5465.180222966507;5470.64440811346;5487.890242195133;992.7766252593253;1011.8836333821705;1026.2559644257854;1029.9433531155707;1031.293563908725;691.5401258163265;707.9716811327489;712.786164150763;716.2157437605813;722.7253643615497;11552.826707599394;11800.350980696145;11977.461014254379;12782.9360853197;12910.160839545399;671.4292851076643;678.9781379024635;682.5938566552992;684.0457561701398;689.7378995981495;5310.389305229871;5422.15956526739;5462.399136095027;5507.476789704971;5511.366192887869;111724;114354;114913;116665;117619.41190294165;100096.49951750194;100147.49926250467;100364.49817750865;102092.48953755184;102578.48710756398;85445.57277213699;87624;87784.5610771942;88676.5566172165;89858.55070724605;9915.25635577349;9948.35335703177;10112.443815590213;10316.742081448025;10442.843357349493;41385.172296554505;41870.1625967485;42273.78863105665;42954;43221.351679725456;51174;51992.480075198764;52004.219936700225;52845.7357713209;53726.19410708764;15271.847281527043;15650.530484085495;15700.900936934306;15745.842541574437;15750.369985200463;16783.244753986342;16855.24151413165;17003.064831433894;17052.48842534726;17138.143092845556;16306.918465407596;16326.183690815174;16334.918325408296;16375.263113159697;16489.752653709966;15117.54647360581;15143.848561514244;15174.165420901514;15238.542843714706;15430;14830.925845370704;15012.6997460048;15264.084154950739;15277.694446111238;15317.157556334509;12150.088743344108;12427.75144497123;12459.314737689514;12486.500539978662;12607.306598137191;12076.698082548006;12080.51677932873;12086.15396922207;12121.515139394325;12240.18935099574 17:13:30 INFO - PID 29721 | __end_tp_report 17:13:30 INFO - PID 29721 | __start_cc_report 17:13:30 INFO - PID 29721 | _x_x_mozilla_cycle_collect,352 17:13:30 INFO - PID 29721 | __end_cc_report 17:13:30 INFO - PID 29721 | __startTimestamp1503533610866__endTimestamp 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | ------- Summary: start ------- 17:13:30 INFO - PID 29721 | Number of tests: 6 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#0] dojo.html Cycles:165 Average:6168.93 Median:6369.68 stddev:710.88 (11.2%) stddev-sans-first:674.83 17:13:30 INFO - PID 29721 | Values: 3237.2 3240.7 3245.9 3273.5 3296.0 6141.2 6167.5 6171.0 6219.3 6275.1 6119.6 6168.7 6178.8 6184.5 6214.0 5695.0 5726.4 5728.4 5744.6 5755.5 5743.3 5760.3 5781.8 5797.4 5805.1 5764.9 5839.9 5859.1 5863.6 5890.4 5704.0 5774.2 5783.0 5790.4 5877.5 5518.4 5536.2 5582.9 5617.0 5666.4 6119.8 6202.6 6207.2 6286.6 6324.2 6642.2 6662.7 6728.0 6788.7 6792.9 6555.0 6651.0 6681.8 6755.0 6758.3 6283.5 6293.7 6324.0 6327.5 6339.3 6872.1 6874.3 6913.1 6959.3 6972.4 6572.4 6582.7 6614.5 6643.0 6714.8 6740.2 6742.7 6759.3 6785.4 6794.1 6564.9 6641.9 6744.9 6747.2 6761.1 6659.5 6659.9 6683.3 6754.6 6765.1 5373.1 5375.7 5379.0 5380.5 5397.3 4613.0 4692.0 4729.5 4741.5 4742.5 5745.1 5809.1 5816.4 5841.3 5896.3 6639.6 6706.6 6709.7 6710.4 6711.6 5781.7 5833.5 5852.9 5885.5 5895.6 5795.3 5844.8 5864.6 5888.7 5889.9 6329.7 6350.7 6369.7 6455.4 6457.6 6642.6 6698.0 6706.2 6773.6 6776.7 6403.7 6474.3 6487.7 6487.9 6495.0 6577.2 6589.2 6663.7 6673.2 6675.9 6701.6 6702.6 6775.7 6779.6 6780.9 6504.5 6529.3 6544.4 6550.9 6551.2 6376.6 6452.3 6535.0 6542.3 6560.0 6268.0 6330.2 6360.5 6414.3 6430.2 6464.5 6500.4 6536.2 6550.9 6604.7 6320.8 6334.7 6381.6 6430.1 6443.0 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#1] ext.html Cycles:180 Average:37773.30 Median:37365.81 stddev:53255.57 (142.5%) stddev-sans-first:53332.70 17:13:30 INFO - PID 29721 | Values: 826.0 853.6 873.2 880.7 1136.6 37804.1 41723.6 41843.0 41931.2 41978.4 41343.4 41676.0 42151.0 42163.4 42186.4 7694.5 7826.3 7829.3 7830.9 7836.2 7679.2 7816.8 7818.6 7825.8 7827.1 7794.0 7799.3 7806.6 7809.7 7820.4 7742.9 7836.2 7841.2 7841.8 7846.6 7654.0 7717.8 7720.9 7725.1 7726.8 38175.0 38197.6 38200.0 38398.0 38448.8 3480.9 3521.4 3548.5 3550.8 3551.0 31755.7 31816.0 31842.4 31967.7 31991.4 5042.7 5191.2 5201.9 5238.2 5276.5 179796.0 180350.0 180370.0 180432.0 180988.0 45925.0 45940.8 46037.0 46044.3 46306.0 48593.3 48646.5 48695.5 48798.5 48808.0 13942.4 14184.6 15885.8 15889.3 16241.8 13230.3 13326.5 13349.6 13350.4 13354.7 13283.0 13291.2 13317.6 13323.5 13452.3 5219.0 5222.7 5312.3 5477.8 5479.8 961.7 985.3 986.4 992.3 998.4 22278.8 22460.1 22512.4 22696.3 22868.4 1072.9 1075.0 1075.6 1089.8 1100.7 11887.3 12123.8 12126.6 12145.9 12169.2 229507.0 232146.0 232680.0 232922.0 233326.0 55165.2 55458.4 55495.4 55678.2 55823.4 1416.7 1425.4 1433.4 1440.2 1441.1 26686.2 26920.3 27153.9 27385.3 27424.0 37265.8 37493.6 37510.6 37533.6 37633.2 200510.0 200924.0 200965.0 201568.0 201605.0 34637.3 34648.7 37248.8 38422.4 38451.2 44019.3 45295.1 46488.5 46545.5 46584.8 33771.0 33917.5 34038.5 34048.0 34106.3 33460.5 33496.5 33932.3 33999.2 34029.3 37359.0 37372.6 37567.8 37653.8 37709.2 31383.4 31425.0 31469.1 31771.8 32397.1 24307.8 24373.3 25047.6 25088.7 25284.0 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#2] jquery.html Cycles:180 Average:35622.14 Median:22132.50 stddev:87013.96 (393.2%) stddev-sans-first:87218.23 17:13:30 INFO - PID 29721 | Values: 557.4 562.8 563.2 565.2 569.6 21516.1 21898.2 22706.3 22728.3 22761.2 21563.7 21797.8 21890.3 21977.3 22048.7 6456.2 6592.5 6592.8 6592.8 6593.0 6010.9 6294.5 6594.3 6599.9 6602.9 6484.1 6507.4 6510.9 6539.8 6555.3 6524.9 6564.0 6573.7 6573.9 6576.8 6082.1 6087.3 6088.1 6092.8 6101.0 28140.7 28483.9 28562.4 29563.7 29612.1 2085.7 2127.2 2128.1 2129.0 2136.0 19098.6 20089.4 20092.2 20100.8 20130.5 2420.5 2427.5 2462.5 2486.7 2498.3 135304.0 137555.3 137597.0 140200.3 140319.3 14115.6 14211.7 14630.2 14640.6 14826.4 22216.3 22240.8 22351.4 22353.9 22397.9 9859.6 10106.7 10165.2 10191.7 10245.7 7813.9 9507.0 9577.3 9584.1 9665.2 8020.0 8958.0 9064.2 9110.3 9157.8 2640.9 2674.3 2713.6 2740.6 2791.9 943.5 965.3 972.2 980.5 987.5 18939.7 19243.3 19572.5 19616.3 19908.0 1031.1 1036.6 1042.7 1044.8 1053.8 10537.1 10569.4 10581.2 10597.4 10885.0 463320.0 521373.0 529945.0 536445.0 539154.0 112635.0 115978.4 119165.0 119627.4 120002.4 1082.8 1214.5 1244.6 1264.6 1266.3 20318.8 20353.7 20404.0 20448.2 20531.4 54985.2 55331.4 55351.2 55527.0 56219.7 67906.0 68010.0 68425.0 68597.7 69097.0 11791.0 12244.6 13832.7 14065.6 20609.2 23472.8 23814.0 23869.0 24133.8 24139.3 18299.6 18946.0 19059.0 19085.8 19121.4 16968.7 17042.9 17305.6 17411.9 17931.4 18381.2 19207.5 19391.9 19422.2 19445.0 20454.5 20657.2 21028.5 21146.0 21212.7 17767.6 18112.5 18519.2 18765.3 18774.4 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#3] mootools.html Cycles:180 Average:9230.96 Median:24974.44 stddev:6468.36 (25.9%) stddev-sans-first:6459.22 17:13:30 INFO - PID 29721 | Values: 1324.0 1346.2 1375.4 1378.4 1379.3 14573.3 14593.0 15084.2 15103.9 15263.3 14818.8 15083.2 15110.7 15117.2 15261.5 2669.0 2708.6 2711.9 2712.7 2718.0 2460.3 2554.2 2622.6 2623.1 2626.3 2682.2 2685.8 2710.9 2713.3 2714.2 2686.4 2695.2 2713.2 2739.9 2741.5 2599.7 2641.6 2644.4 2648.2 2656.5 14588.5 14644.5 14712.4 14722.7 14730.8 7424.4 7683.7 7701.8 7706.1 7708.1 5137.4 5298.7 5471.1 5492.4 5511.4 1929.6 1934.1 1969.8 2002.3 2014.6 24924.1 24958.6 24990.3 25114.4 25136.5 6624.3 6647.7 6686.8 6833.8 6848.5 16843.7 16844.2 16861.7 16864.2 16874.9 7695.8 7849.5 7860.0 7860.4 7861.6 6067.2 6978.5 7047.0 7080.2 7098.3 4830.3 5158.3 5354.3 5373.8 5393.8 1459.7 1501.8 1506.7 1509.5 1512.6 914.9 927.4 931.3 936.4 941.3 8457.3 8561.4 8631.4 8654.7 8721.2 985.2 993.8 1000.2 1012.1 1018.1 5137.4 5791.4 5830.7 5887.6 5894.0 21004.0 21180.6 21472.5 21518.6 21620.2 20376.6 21005.7 21308.0 21321.7 21386.4 10898.5 10981.0 11158.2 11388.4 11389.0 8291.8 8630.3 8773.7 8804.6 8899.2 17791.0 17954.6 18219.4 18451.4 18473.2 18203.2 18261.5 18860.4 18877.7 19424.0 10510.2 12339.1 12340.4 12354.7 12365.5 13449.9 13638.4 13910.0 13922.8 13943.1 11137.1 11185.6 11196.8 11253.5 11259.5 10610.2 10689.5 10900.3 11032.4 11234.7 10154.8 10170.2 10213.9 10263.7 10296.5 7163.0 7194.4 7211.6 7256.3 7281.3 7142.9 7185.0 7216.7 7219.3 7246.3 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#4] prototype.html Cycles:180 Average:5517.23 Median:6162.28 stddev:1548.03 (25.1%) stddev-sans-first:1505.82 17:13:30 INFO - PID 29721 | Values: 497.4 503.3 522.5 529.9 531.1 6295.2 6307.2 6369.5 6378.1 6402.2 6032.8 6148.9 6160.9 6164.9 6236.3 4901.0 5036.2 5045.1 5065.3 5085.2 5010.2 5015.5 5025.5 5025.5 5037.4 4794.3 4931.3 4978.9 4986.7 4991.0 4960.8 4992.0 5042.7 5047.2 5088.1 4445.4 4489.7 4494.8 4507.0 4511.3 6129.3 6129.3 6163.7 6198.0 6219.2 5720.7 5727.4 5732.6 5759.8 5793.6 6580.5 6610.4 6615.8 6641.9 6710.4 4854.0 4879.6 4880.4 4890.4 4900.4 6902.1 6907.9 6950.5 6957.3 6995.7 4925.8 5028.4 5033.8 5033.9 5045.8 4990.1 5022.8 5025.6 5077.3 5111.7 5666.7 5695.3 5714.5 5715.6 5760.2 6585.4 6595.4 6637.9 6648.1 6652.0 1656.6 1688.9 1740.2 1742.5 1756.7 1135.3 1179.1 1207.1 1217.7 1233.1 5732.1 5764.5 5826.0 5846.0 5878.9 6552.5 6553.2 6602.6 6674.4 6725.2 5691.7 5775.7 5827.7 5852.8 5859.3 3575.5 3599.8 3614.3 3618.3 3634.6 6388.7 6402.0 6429.4 6459.1 6468.3 6776.3 6856.1 6888.1 6891.2 6898.6 6352.7 6396.3 6405.9 6423.5 6445.7 6774.7 6788.3 6800.7 6813.2 6822.1 6598.8 6602.4 6622.7 6688.1 6758.0 6305.4 6306.3 6312.9 6423.3 6452.4 4963.2 4964.1 4971.3 4975.9 5041.1 6576.6 6655.7 6680.9 6718.9 6767.6 6435.9 6485.0 6569.2 6576.9 6596.9 6544.2 6545.7 6546.6 6554.8 6565.1 5979.9 6374.3 6401.2 6481.2 6482.2 6534.4 6546.7 6587.7 6611.8 6671.6 6295.5 6405.2 6414.4 6428.3 6432.3 17:13:30 INFO - PID 29721 | 17:13:30 INFO - PID 29721 | [#5] yui.html Cycles:180 Average:22720.73 Median:21005.47 stddev:32001.90 (152.4%) stddev-sans-first:32049.62 17:13:30 INFO - PID 29721 | Values: 869.5 881.1 887.8 888.4 891.8 17802.6 18735.5 18751.9 18799.3 21588.5 19817.5 19943.9 20289.0 20415.9 20422.5 921.1 936.4 939.8 940.0 940.5 915.9 941.4 948.0 953.0 954.0 987.4 990.7 991.3 991.9 992.0 970.4 971.5 971.5 974.3 975.3 718.7 718.7 719.3 721.7 722.6 17906.7 17923.0 18696.6 18834.8 18857.3 18838.4 19204.3 19208.2 19231.6 19552.3 16391.8 16790.1 16843.4 16868.3 16869.0 3461.8 3500.3 3517.8 3520.4 3523.8 120002.0 120523.0 121379.0 122277.0 124066.0 15993.3 16270.0 16482.2 16501.8 16531.7 25904.5 27028.1 27161.9 27167.0 27215.7 7914.6 8006.0 8322.2 8617.3 8682.4 3931.2 3998.8 4008.2 4009.9 4010.3 4985.8 5243.1 5465.2 5470.6 5487.9 992.8 1011.9 1026.3 1029.9 1031.3 691.5 708.0 712.8 716.2 722.7 11552.8 11800.4 11977.5 12782.9 12910.2 671.4 679.0 682.6 684.0 689.7 5310.4 5422.2 5462.4 5507.5 5511.4 111724.0 114354.0 114913.0 116665.0 117619.4 100096.5 100147.5 100364.5 102092.5 102578.5 85445.6 87624.0 87784.6 88676.6 89858.6 9915.3 9948.4 10112.4 10316.7 10442.8 41385.2 41870.2 42273.8 42954.0 43221.4 51174.0 51992.5 52004.2 52845.7 53726.2 15271.8 15650.5 15700.9 15745.8 15750.4 16783.2 16855.2 17003.1 17052.5 17138.1 16306.9 16326.2 16334.9 16375.3 16489.8 15117.5 15143.8 15174.2 15238.5 15430.0 14830.9 15012.7 15264.1 15277.7 15317.2 12150.1 12427.8 12459.3 12486.5 12607.3 12076.7 12080.5 12086.2 12121.5 12240.2 17:13:30 INFO - PID 29721 | -------- Summary: end -------- 17:13:30 INFO - PID 29721 | 17:13:31 INFO - TEST-INFO | 29721: exit 0 17:13:31 INFO - TEST-OK | dromaeo_css | took 1110296ms 17:13:31 INFO - TEST-START | kraken 17:13:31 INFO - Initialising browser for kraken test... 17:13:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38511/getInfo.html -profile /tmp/tmp8EvLol/profile 17:13:31 INFO - TEST-INFO | started process 30129 (/builds/slave/test/build/application/firefox/firefox http://localhost:38511/getInfo.html) 17:13:36 INFO - TEST-INFO | 30129: exit 0 17:13:37 INFO - Browser initialized. 17:13:37 INFO - Running cycle 1/1 for kraken test... 17:13:37 INFO - TEST-INFO | started process 30302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8EvLol/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:37 INFO - PID 30302 | 17:13:37 INFO - PID 30302 | (/builds/slave/test/build/application/firefox/firefox:30352): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:13:37 INFO - PID 30302 | 17:13:38 INFO - PID 30302 | 17:13:38 INFO - PID 30302 | (/builds/slave/test/build/application/firefox/firefox:30406): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:13:38 INFO - PID 30302 | 17:13:38 INFO - PID 30302 | __metrics Screen width/height:1600/1200 17:13:38 INFO - PID 30302 | colorDepth:24 17:13:38 INFO - PID 30302 | Browser inner width/height: 1024/768 17:13:38 INFO - PID 30302 | __metrics 17:13:48 INFO - PID 30302 | RSS: Main: 172183552 17:13:48 INFO - PID 30302 | 17:13:50 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38511/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:51 INFO - PID 30302 | RSS: Main: 176230400 17:13:51 INFO - PID 30302 | 17:13:54 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38511/tests/kraken/driver.html?testName=audio-dft) 17:13:55 INFO - PID 30302 | RSS: Main: 176939008 17:13:55 INFO - PID 30302 | 17:13:58 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38511/tests/kraken/driver.html?testName=audio-fft) 17:13:58 INFO - PID 30302 | RSS: Main: 170876928 17:13:58 INFO - PID 30302 | 17:14:00 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38511/tests/kraken/driver.html?testName=audio-oscillator) 17:14:01 INFO - PID 30302 | RSS: Main: 171454464 17:14:01 INFO - PID 30302 | 17:14:03 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:04 INFO - PID 30302 | RSS: Main: 171950080 17:14:04 INFO - PID 30302 | 17:14:07 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38511/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:08 INFO - PID 30302 | RSS: Main: 172568576 17:14:08 INFO - PID 30302 | 17:14:11 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38511/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:12 INFO - PID 30302 | RSS: Main: 172843008 17:14:12 INFO - PID 30302 | 17:14:15 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38511/tests/kraken/driver.html?testName=json-parse-financial) 17:14:15 INFO - PID 30302 | RSS: Main: 172826624 17:14:15 INFO - PID 30302 | 17:14:17 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:17 INFO - PID 30302 | RSS: Main: 173072384 17:14:17 INFO - PID 30302 | 17:14:19 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:20 INFO - PID 30302 | RSS: Main: 173023232 17:14:20 INFO - PID 30302 | 17:14:22 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:23 INFO - PID 30302 | RSS: Main: 173539328 17:14:23 INFO - PID 30302 | 17:14:25 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:26 INFO - PID 30302 | RSS: Main: 173744128 17:14:26 INFO - PID 30302 | 17:14:29 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:30 INFO - PID 30302 | RSS: Main: 174268416 17:14:30 INFO - PID 30302 | 17:14:31 INFO - PID 30302 | Cycle 1(1): loaded http://localhost:38511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38511/tests/kraken/driver.html?testName=ai-astar) 17:14:32 INFO - PID 30302 | RSS: Main: 175652864 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | __start_tp_report 17:14:32 INFO - PID 30302 | _x_x_mozilla_page_load 17:14:32 INFO - PID 30302 | _x_x_mozilla_page_load_details 17:14:32 INFO - PID 30302 | |i|pagename|runs| 17:14:32 INFO - PID 30302 | |0;ai-astar;96;110;101;106;106;110;111;100;107;111 17:14:32 INFO - PID 30302 | |1;audio-beat-detection;141;128;142;174;120;143;154;126;168;120 17:14:32 INFO - PID 30302 | |2;audio-dft;162;162;162;162;162;162;163;166;171;163 17:14:32 INFO - PID 30302 | |3;audio-fft;73;77;76;192;75;75;73;74;173;75 17:14:32 INFO - PID 30302 | |4;audio-oscillator;79;80;129;80;79;80;129;80;79;132 17:14:32 INFO - PID 30302 | |5;imaging-gaussian-blur;114;114;115;114;114;114;114;113;114;113 17:14:32 INFO - PID 30302 | |6;imaging-darkroom;148;148;148;147;147;148;147;148;149;149 17:14:32 INFO - PID 30302 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;93;94 17:14:32 INFO - PID 30302 | |8;json-parse-financial;54;53;51;52;52;55;52;54;53;53 17:14:32 INFO - PID 30302 | |9;json-stringify-tinderbox;55;56;56;55;56;56;55;56;56;56 17:14:32 INFO - PID 30302 | |10;stanford-crypto-aes;77;74;73;78;77;76;76;77;76;75 17:14:32 INFO - PID 30302 | |11;stanford-crypto-ccm;128;124;115;122;117;128;123;125;122;166 17:14:32 INFO - PID 30302 | |12;stanford-crypto-pbkdf2;169;182;170;181;181;179;169;169;171;177 17:14:32 INFO - PID 30302 | |13;stanford-crypto-sha256-iterative;64;63;63;65;63;65;63;64;64;67 17:14:32 INFO - PID 30302 | __end_tp_report 17:14:32 INFO - PID 30302 | __start_cc_report 17:14:32 INFO - PID 30302 | _x_x_mozilla_cycle_collect,928 17:14:32 INFO - PID 30302 | __end_cc_report 17:14:32 INFO - PID 30302 | __startTimestamp1503533672113__endTimestamp 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | ------- Summary: start ------- 17:14:32 INFO - PID 30302 | Number of tests: 14 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#0] ai-astar Cycles:10 Average:105.80 Median:110.00 stddev:5.20 (4.7%) stddev-sans-first:4.14 17:14:32 INFO - PID 30302 | Values: 96.0 110.0 101.0 106.0 106.0 110.0 111.0 100.0 107.0 111.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:142.50 stddev:19.04 (13.4%) stddev-sans-first:20.20 17:14:32 INFO - PID 30302 | Values: 141.0 128.0 142.0 174.0 120.0 143.0 154.0 126.0 168.0 120.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:2.92 (1.8%) stddev-sans-first:3.04 17:14:32 INFO - PID 30302 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 163.0 166.0 171.0 163.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#3] audio-fft Cycles:10 Average:96.30 Median:75.00 stddev:45.67 (60.9%) stddev-sans-first:47.65 17:14:32 INFO - PID 30302 | Values: 73.0 77.0 76.0 192.0 75.0 75.0 73.0 74.0 173.0 75.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.50 stddev:24.38 (30.7%) stddev-sans-first:25.18 17:14:32 INFO - PID 30302 | Values: 79.0 80.0 129.0 80.0 79.0 80.0 129.0 80.0 79.0 132.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:14:32 INFO - PID 30302 | Values: 114.0 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 17:14:32 INFO - PID 30302 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 149.0 149.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:14:32 INFO - PID 30302 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.20 17:14:32 INFO - PID 30302 | Values: 54.0 53.0 51.0 52.0 52.0 55.0 52.0 54.0 53.0 53.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 17:14:32 INFO - PID 30302 | Values: 55.0 56.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 56.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.50 stddev:1.52 (2.0%) stddev-sans-first:1.56 17:14:32 INFO - PID 30302 | Values: 77.0 74.0 73.0 78.0 77.0 76.0 76.0 77.0 76.0 75.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:124.50 stddev:14.32 (11.5%) stddev-sans-first:15.19 17:14:32 INFO - PID 30302 | Values: 128.0 124.0 115.0 122.0 117.0 128.0 123.0 125.0 122.0 166.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:178.00 stddev:5.67 (3.2%) stddev-sans-first:5.61 17:14:32 INFO - PID 30302 | Values: 169.0 182.0 170.0 181.0 181.0 179.0 169.0 169.0 171.0 177.0 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 17:14:32 INFO - PID 30302 | Values: 64.0 63.0 63.0 65.0 63.0 65.0 63.0 64.0 64.0 67.0 17:14:32 INFO - PID 30302 | -------- Summary: end -------- 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:14:32 INFO - PID 30302 | 17:14:32 INFO - PID 30302 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:14:32 INFO - TEST-INFO | 30302: exit 0 17:14:32 INFO - TEST-OK | kraken | took 61339ms 17:14:32 INFO - SUITE-END | took 1171s 17:14:33 INFO - Completed test suite (00:19:32) 17:14:33 INFO - javascript benchmark 17:14:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8476.329506681812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.223066464049, 3240.740740740741, 3245.870165193392, 3273.52533882587, 3295.9505607415895, 6141.232345956755, 6167.475764560007, 6171.0, 6219.346968568298, 6275.090111933767, 6119.571629985903, 6168.660723660197, 6178.75284988601, 6184.536159788011, 6213.968930155354, 5695.0318445864195, 5726.3700992890745, 5728.398518155575, 5744.626599271055, 5755.539556835443, 5743.253377060976, 5760.308762948431, 5781.768729250825, 5797.391273916221, 5805.129230615399, 5764.884702305952, 5839.941600584004, 5859.091840764689, 5863.58954873159, 5890.440408161239, 5704.0, 5774.220480235156, 5783.045797443417, 5790.36306006339, 5877.500412464924, 5518.365387980353, 5536.169574563807, 5582.86042848928, 5617.045102332572, 5666.405027472098, 6119.816405507842, 6202.627842329474, 6207.162033125515, 6286.591371560834, 6324.209473815773, 6642.202935647705, 6662.6668666566475, 6728.0, 6788.72845086196, 6792.93207067928, 6554.967225163844, 6650.966745166292, 6681.76613818514, 6755.0, 6758.29037951013, 6283.5287353448675, 6293.653849038301, 6324.019776934582, 6327.4938004959495, 6339.302676705559, 6872.140982377203, 6874.346937040973, 6913.1358580177475, 6959.304069593, 6972.407345375598, 6572.375624315682, 6582.703778329891, 6614.536982411281, 6643.003549467522, 6714.764983225661, 6740.224874139439, 6742.6628668567355, 6759.256481787, 6785.389314961579, 6794.0827988221945, 6564.901526477107, 6641.900371494431, 6744.920812670048, 6747.190337159573, 6761.121054262914, 6659.500537459709, 6659.866802664016, 6683.298253683391, 6754.5947243165565, 6765.05289259504, 5373.140297552372, 5375.704336261465, 5379.0, 5380.461953804588, 5397.325334333208, 4613.008203236321, 4691.953080469151, 4729.527047295312, 4741.502142275081, 4742.454617718938, 5745.13822926556, 5809.128630705428, 5816.41835816415, 5841.269841269841, 5896.292444906639, 6639.568428052161, 6706.597604143767, 6709.6980635871505, 6710.362515561014, 6711.563748356341, 5781.653100813881, 5833.533317334688, 5852.882942341129, 5885.499732522698, 5895.616784908967, 5795.333536643256, 5844.824655260349, 5864.648121112747, 5888.676122813286, 5889.882202355929, 6329.715162817776, 6350.714217860115, 6369.681515924278, 6455.354464553507, 6457.644829534327, 6642.6014439133805, 6698.028785826125, 6706.161729783777, 6773.593584384953, 6776.661166941534, 6403.679816009274, 6474.2878283387845, 6487.740490380332, 6487.935120648733, 6495.025746137928, 6577.2436169841085, 6589.24223714279, 6663.7001334941015, 6673.232578253369, 6675.899861502178, 6701.564398314094, 6702.564333318319, 6775.695093720696, 6779.627120508222, 6780.898286525608, 6504.544681872224, 6529.281779004401, 6544.411003009752, 6550.934490655032, 6551.246606640298, 6376.585521941059, 6452.290248072614, 6535.0, 6542.313057128933, 6560.0, 6267.96866015667, 6330.177076979963, 6360.522960778053, 6414.326495718069, 6430.228372595318, 6464.450521705708, 6500.447461965786, 6536.150300460909, 6550.868982620416, 6604.669766511752, 6320.810375688737, 6334.651594162366, 6381.585196962183, 6430.099786030053, 6443.0335449682925], "value": 6117.5211040032655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.987610185847, 853.5945425922688, 873.183573358909, 880.6565439478604, 1136.624913778452, 37804.05489862752, 41723.58276417231, 41843.0, 41931.16137677252, 41978.37032444508, 41343.379849302284, 41676.0, 42151.0, 42163.367549486786, 42186.36720449196, 7694.5383277003275, 7826.295633392993, 7829.33450656692, 7830.882536761953, 7836.216378362146, 7679.232076792304, 7816.765497035098, 7818.609069546528, 7825.765227043198, 7827.060752709683, 7794.0, 7799.337056350217, 7806.570638614874, 7809.687612495493, 7820.374370050411, 7742.8838567421535, 7836.216378362175, 7841.21587841217, 7841.843163136734, 7846.646900889474, 7653.961730191313, 7717.845643087163, 7720.922790772077, 7725.072991241031, 7726.806829829243, 38175.04562385962, 38197.61802381968, 38200.0, 38398.0, 38448.80775596104, 3480.9477857832153, 3521.383757842393, 3548.520949671787, 3550.822458877046, 3551.0234685461705, 31755.682443175505, 31816.0, 31842.36315273705, 31967.680323196935, 31991.360172796412, 5042.697438153723, 5191.247269145991, 5201.947980520222, 5238.1618940969265, 5276.472352764731, 179796.0, 180350.0, 180370.0, 180432.0, 180988.0, 45925.0, 45940.77029614831, 46037.0, 46044.30933536, 46306.0, 48593.27110093351, 48646.513534864906, 48695.5130448691, 48798.512014879394, 48808.0, 13942.442302307794, 14184.645383865485, 15885.761713574306, 15889.28498217583, 16241.83758162427, 13230.338483075808, 13326.466941322433, 13349.599512014654, 13350.399232034582, 13354.732905342033, 13283.0, 13291.20252784836, 13317.600471985856, 13323.467061317633, 13452.32738363078, 5218.973905130526, 5222.686638801684, 5312.309399778082, 5477.780888764484, 5479.808206712746, 961.697065424389, 985.2708995343394, 986.3835103060587, 992.3004281981185, 998.3560603410905, 22278.77721222767, 22460.11209575078, 22512.437189070406, 22696.319110426382, 22868.4282892929, 1072.855164552791, 1074.9677509674723, 1075.6127793994156, 1089.7874914391775, 1100.6697990602788, 11887.346195959306, 12123.812136782017, 12126.636200913987, 12145.878541214652, 12169.209001415056, 229507.0, 232146.0, 232680.0, 232922.0, 233326.0, 55165.1725224122, 55458.445415546135, 55495.44504554984, 55678.16482752762, 55823.44176558264, 1416.6954104867502, 1425.4440768100449, 1433.383645032625, 1440.1503113163285, 1441.142520200479, 26686.19941401761, 26920.32699182536, 27153.86423067872, 27385.315367115185, 27424.0, 37265.81367093147, 37493.62506375011, 37510.62489375071, 37533.624663754104, 37633.2473350537, 200510.0, 200924.0, 200965.0, 201568.0, 201605.0, 34637.30725385529, 34648.653513464546, 37248.81375593105, 38422.423663644506, 38451.230975379774, 44019.33970990374, 45295.09409811851, 46488.53511464842, 46545.53454465412, 46584.767076164404, 33771.0, 33917.49123763096, 34038.48942265918, 34048.0, 34106.31787364288, 33460.49809252912, 33496.49755253722, 33932.32135357329, 33999.15002124868, 34029.31941361109, 37359.0, 37372.62627373692, 37567.81216093902, 37653.81173094117, 37709.24581508409, 31383.350996819878, 31425.0, 31469.132716820794, 31771.84114079415, 32397.140428935847, 24307.756922430548, 24373.26880193597, 25047.624285635364, 25088.74911250864, 25284.0], "value": 17296.82304666684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.420282905778, 562.8339639806256, 563.1693252452633, 565.2369301443055, 569.5585920911293, 21516.139354425843, 21898.23356182534, 22706.318810435692, 22728.318150455514, 22761.203357882456, 21563.676544851838, 21797.782022179774, 21890.343289701334, 21977.34067977963, 22048.669269960963, 6456.22525296965, 6592.505562082839, 6592.80221593353, 6592.80221593353, 6593.044008618771, 6010.909836352458, 6294.527910406715, 6594.3075977022445, 6599.901001484982, 6602.933970660304, 6484.092227088211, 6507.44686701631, 6510.934890651104, 6539.77110801122, 6555.34446555343, 6524.869502609945, 6564.04821300911, 6573.671316434183, 6573.868522629568, 6576.835579110512, 6082.057281121433, 6087.3303936566945, 6088.056351265561, 6092.786752463687, 6101.0, 28140.71859281422, 28483.85758071217, 28562.428751425065, 29563.704362956527, 29612.11163665072, 2085.7497100348055, 2127.181035301405, 2128.138104067855, 2129.0, 2136.0387825478597, 19098.618027639368, 20089.397318080482, 20092.1963121475, 20100.798992010037, 20130.496737581532, 2420.491696743686, 2427.490227052321, 2462.544429280571, 2486.689163854518, 2498.3379404457833, 135304.0, 137555.31222343823, 137597.0, 140200.29899850435, 140319.29840350835, 14115.647108822362, 14211.715765684628, 14630.19533925623, 14640.633984150481, 14826.406943722346, 22216.333509994725, 22240.77759222387, 22351.44121396978, 22353.888230559067, 22397.888010560167, 9859.556319965619, 10106.696799096038, 10165.186785057178, 10191.7452063699, 10245.74385640365, 7813.921860781433, 9507.0, 9577.281703872237, 9584.089511496397, 9665.226781857575, 8019.959900200462, 8957.955210223907, 9064.229540489001, 9110.316726245557, 9157.77105572366, 2640.9339766505605, 2674.251209661298, 2713.6472258606254, 2740.5889116632666, 2791.8604069796834, 943.5329511891521, 965.32909627808, 972.1930797438109, 980.5048450532436, 987.5259875259916, 18939.723167143773, 19243.326483573008, 19572.510687232647, 19616.313429029917, 19908.0, 1031.0771859185986, 1036.5646428500047, 1042.744527590745, 1044.7649278912183, 1053.841923711434, 10537.051665350002, 10569.365838049742, 10581.206409519316, 10597.41714205726, 10885.0, 463320.0, 521373.0, 529945.0, 536445.0, 539154.0, 112635.0, 115978.42010789891, 119165.0, 119627.40186299013, 120002.3999879995, 1082.767205050918, 1214.5263347294563, 1244.6452760963082, 1264.5574049082747, 1266.2529107826426, 20318.79681203228, 20353.694694579295, 20404.0, 20448.182072716925, 20531.3720800446, 54985.1752223725, 55331.44668553263, 55351.16973245485, 55527.0, 56219.718901405235, 67906.0, 68010.0, 68425.0, 68597.65701171462, 69097.0, 11791.0, 12244.571439999558, 13832.723345533233, 14065.578032659037, 20609.175632974515, 23472.76527234774, 23814.047438102974, 23869.0, 24133.75866241315, 24139.275821725376, 18299.634007319513, 18945.957972311655, 19059.047047647284, 19085.809141908958, 19121.426357209308, 16968.74546881773, 17042.914785425994, 17305.577219189072, 17411.8682285651, 17931.37240196587, 18381.17284722164, 19207.51981200481, 19391.903040484707, 19422.223111075964, 19445.0, 20454.488637784176, 20657.17371305131, 21028.47428814292, 21146.0, 21212.681809773174, 17767.64464710673, 18112.45662630123, 18519.166637501614, 18765.34321298748, 18774.436766897015], "value": 12084.598680262441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.9867601323988, 1346.1922846292225, 1375.3673310277272, 1378.4486205517785, 1379.317237967206, 14573.271336433188, 14593.0, 15084.17037062961, 15103.924480377596, 15263.313150908209, 14818.777718334233, 15083.245837708098, 15110.697786044273, 15117.244137793094, 15261.465848695298, 2668.986655066722, 2708.5937109433544, 2711.945761084777, 2712.7016028236876, 2718.0350975403744, 2460.2619214235747, 2554.208195459404, 2622.6459427977265, 2623.0950322138833, 2626.330285777124, 2682.222155574881, 2685.8388496690163, 2710.905118320859, 2713.3081064328567, 2714.185744276719, 2686.449277898026, 2695.218386667864, 2713.240292718042, 2739.8904043838224, 2741.4791189674097, 2599.6620439342955, 2641.6433781439646, 2644.35213372723, 2648.192301348088, 2656.468706258737, 14588.489402870955, 14644.487442939553, 14712.411503539846, 14722.705545889023, 14730.779038314327, 7424.443166762514, 7683.7310694126, 7701.845963080707, 7706.113796913371, 7708.113566939762, 5137.357830271216, 5298.682079075268, 5471.124620060811, 5492.368377636583, 5511.366192887789, 1929.5851391950798, 1934.1199754111844, 1969.832564232042, 2002.3392280547384, 2014.6071516054376, 24924.12765553215, 24958.625620615523, 24990.250292491255, 25114.372140696447, 25136.497270054497, 6624.337566243337, 6647.66761661915, 6686.765963191265, 6833.760818371333, 6848.452123830081, 16843.663126737396, 16844.157792110345, 16861.747073793656, 16864.156792160342, 16874.903131296673, 7695.846083078307, 7849.450538462253, 7860.0, 7860.371170306362, 7861.606919653995, 6067.2112625359305, 6978.476614253951, 7047.048648432498, 7080.150381954096, 7098.3256590623805, 4830.3479030331155, 5158.329417175743, 5354.277172581729, 5373.7850485980125, 5393.784248630011, 1459.729949959261, 1501.8047653804936, 1506.7287888180012, 1509.4716849102945, 1512.6067222522004, 914.8536234202496, 927.3601215161517, 931.3340961212765, 936.4194199596294, 941.270515350595, 8457.281131103802, 8561.44350617208, 8631.352648551383, 8654.697085601974, 8721.215090641872, 985.1675334342613, 993.7614972406715, 1000.2348203624233, 1012.1245122968726, 1018.1396719771781, 5137.40919794221, 5791.420857914175, 5830.7084645767545, 5887.558433117533, 5894.0, 21004.0, 21180.576388472145, 21472.4631884201, 21518.56962860734, 21620.243291484723, 20376.59246815085, 21005.68491472629, 21308.0, 21321.68017479739, 21386.358409247438, 10898.509567069501, 10980.99999999984, 11158.218924675357, 11388.405623212757, 11389.0, 8291.751247462586, 8630.309575234092, 8773.692920747742, 8804.60379282921, 8899.199072083544, 17791.0, 17954.640907182045, 18219.362322318655, 18451.354202602844, 18473.16870740793, 18203.180856861207, 18261.54346141357, 18860.434186974413, 18877.71683424722, 19424.0, 10510.211734120125, 12339.13626046168, 12340.444679989243, 12354.691132721753, 12365.505379784709, 13449.86550134486, 13638.386272617558, 13910.0, 13922.791158132839, 13943.093698909539, 11137.10903127764, 11185.552577896793, 11196.83204751913, 11253.549858005588, 11259.549618015188, 10610.204234682584, 10689.465526723478, 10900.291481053706, 11032.44837758125, 11234.719132021439, 10154.847677284994, 10170.237232207763, 10213.897861021294, 10263.692089237335, 10296.485175741333, 7163.0, 7194.4244460442, 7211.567305961659, 7256.2743725627015, 7281.344678978918, 7142.9285707144345, 7185.0, 7216.747413840701, 7219.278072192738, 7246.347828695442], "value": 6653.88707915161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.40808437958805, 503.29789943029476, 522.5140619224121, 529.9364076310843, 531.0944839049421, 6295.244570651523, 6307.180066591337, 6369.490440764739, 6378.138951241581, 6402.167718196633, 6032.8190154295335, 6148.907766383508, 6160.876782464348, 6164.938350616492, 6236.314005459396, 4901.0, 5036.219385995177, 5045.142325804603, 5065.316182315377, 5085.1863701807715, 5010.223415370605, 5015.498450154973, 5025.497450254982, 5025.547700706936, 5037.420696619899, 4794.304825800257, 4931.334269873575, 4978.925316120261, 4986.650934434591, 4990.950090499103, 4960.826371076995, 4991.950080499185, 5042.747862606891, 5047.167217409123, 5088.058709138802, 4445.355423463579, 4489.663275254369, 4494.752788596626, 4506.977465112686, 4511.323301504768, 6129.264488261392, 6129.264488261392, 6163.691815409212, 6198.0, 6219.175207247556, 5720.742566584514, 5727.427257274281, 5732.627379220337, 5759.798407055733, 5793.594448388614, 6580.473562115019, 6610.413500759832, 6615.834604134935, 6641.86716265672, 6710.396064354231, 4853.95146048542, 4879.634027447955, 4880.438749543777, 4890.413150421937, 4900.387451568554, 6902.137232845895, 6907.930920690779, 6950.478714096463, 6957.339052789976, 6995.650217489156, 4925.827596034122, 5028.421731500851, 5033.84898453047, 5033.924491132636, 5045.823396181116, 4990.126727822617, 5022.84931452057, 5025.648204625714, 5077.263796749525, 5111.693298402108, 5666.744996475169, 5695.345035320908, 5714.542836573064, 5715.6284841486, 5760.164776107525, 6585.374389432996, 6595.406413422815, 6637.900431493532, 6648.135742353463, 6651.966740166365, 1656.5692919840928, 1688.915554222284, 1740.1908112727642, 1742.4685470931488, 1756.7277072053853, 1135.318808714781, 1179.127445690183, 1207.0927933864473, 1217.7442737025146, 1233.1429656388902, 5732.111522713986, 5764.510016648548, 5825.970870145622, 5846.0, 5878.941210587839, 6552.478789635136, 6553.180852393451, 6602.60384376939, 6674.399304062657, 6725.226598941184, 5691.743871525791, 5775.682337471395, 5827.737751801179, 5852.7658893643775, 5859.296884373817, 3575.5173051638217, 3599.8380072896257, 3614.313280476701, 3618.3125206210734, 3634.582023067381, 6388.744450222032, 6401.967990160019, 6429.38920802523, 6459.128017717642, 6468.320826313264, 6776.322367763283, 6856.108705868305, 6888.104546408935, 6891.173059232824, 6898.551594146365, 6352.650604216812, 6396.264429590657, 6405.935940640627, 6423.518236132215, 6445.742170313135, 6774.661266936732, 6788.287229840796, 6800.693968771516, 6813.182418109858, 6822.147231596051, 6598.802035938929, 6602.40578347951, 6622.70197841108, 6688.130543029375, 6758.0, 6305.432511074026, 6306.337834527492, 6312.873742525216, 6423.29343772194, 6452.419282264619, 4963.156263435297, 4964.131277026579, 4971.328870602422, 4975.875603109951, 5041.117804384291, 6576.605403675795, 6655.700493477902, 6680.899786503303, 6718.865622687616, 6767.560108592926, 6435.871282574416, 6485.0, 6569.160635022202, 6576.868462630625, 6596.901046484402, 6544.247411547733, 6545.705443254969, 6546.607203567801, 6554.80335589933, 6565.113709649137, 5979.880402392015, 6374.26695929974, 6401.167848179707, 6481.157449531531, 6482.189726284215, 6534.379233972765, 6546.738130474728, 6587.736490540517, 6611.834704132435, 6671.566348187353, 6295.464885484785, 6405.231372235362, 6414.390632889868, 6428.325025872216, 6432.2602900667025], "value": 5058.841189139532, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.4652788535049, 881.1188811188813, 887.7958069643981, 888.4314039015028, 891.8038031633042, 17802.554936126588, 18735.531611709714, 18751.90624046878, 18799.342023029214, 21588.460288492795, 19817.504562385948, 19943.900280498576, 20289.0, 20415.897920510415, 20422.489437764063, 921.1111277617098, 936.419419959626, 939.8120375924808, 939.9906000940006, 940.4968341937065, 915.890093188815, 941.4304345870752, 947.9905200948006, 952.9714108576719, 953.9904600953971, 987.3532835992437, 990.6829814459376, 991.2912267728573, 991.861139440479, 991.9851202231936, 970.4419958523877, 971.455984648599, 971.5093877591771, 974.3325821812045, 975.3026585991015, 718.6801873166443, 718.7448455798169, 719.2771264878816, 721.7149226055678, 722.5989575785437, 17906.731399029024, 17923.0, 18696.626067478574, 18834.811651883443, 18857.339993100177, 18838.434846954475, 19204.327848525376, 19208.231670733156, 19231.615367692568, 19552.31566895166, 16391.83608163927, 16790.076545789976, 16843.41048063324, 16868.32526698943, 16869.0, 3461.7922924624604, 3500.334936362083, 3517.788932664023, 3520.383932811748, 3523.823808809575, 120002.0, 120522.99999999913, 121379.0, 122277.0, 124066.0, 15993.28030238642, 16270.0, 16482.175891205392, 16501.752473712902, 16531.6693666126, 25904.481910361686, 27028.054018109273, 27161.864190679316, 27167.0, 27215.727842721717, 7914.564698941614, 8005.9599702001115, 8322.20939010793, 8617.310615150773, 8682.43564168327, 3931.2137572485617, 3998.7800670963375, 4008.158286759813, 4009.859654912064, 4010.2781499329817, 4985.750712464434, 5243.082460569462, 5465.180222966507, 5470.64440811346, 5487.890242195133, 992.7766252593253, 1011.8836333821705, 1026.2559644257854, 1029.9433531155707, 1031.293563908725, 691.5401258163265, 707.9716811327489, 712.786164150763, 716.2157437605813, 722.7253643615497, 11552.826707599394, 11800.350980696145, 11977.461014254379, 12782.9360853197, 12910.160839545399, 671.4292851076643, 678.9781379024635, 682.5938566552992, 684.0457561701398, 689.7378995981495, 5310.389305229871, 5422.15956526739, 5462.399136095027, 5507.476789704971, 5511.366192887869, 111724.0, 114354.0, 114913.0, 116665.0, 117619.41190294165, 100096.49951750194, 100147.49926250467, 100364.49817750865, 102092.48953755184, 102578.48710756398, 85445.57277213699, 87624.0, 87784.5610771942, 88676.5566172165, 89858.55070724605, 9915.25635577349, 9948.35335703177, 10112.443815590213, 10316.742081448025, 10442.843357349493, 41385.172296554505, 41870.1625967485, 42273.78863105665, 42954.0, 43221.351679725456, 51174.0, 51992.480075198764, 52004.219936700225, 52845.7357713209, 53726.19410708764, 15271.847281527043, 15650.530484085495, 15700.900936934306, 15745.842541574437, 15750.369985200463, 16783.244753986342, 16855.24151413165, 17003.064831433894, 17052.48842534726, 17138.143092845556, 16306.918465407596, 16326.183690815174, 16334.918325408296, 16375.263113159697, 16489.752653709966, 15117.54647360581, 15143.848561514244, 15174.165420901514, 15238.542843714706, 15430.0, 14830.925845370704, 15012.6997460048, 15264.084154950739, 15277.694446111238, 15317.157556334509, 12150.088743344108, 12427.75144497123, 12459.314737689514, 12486.500539978662, 12607.306598137191, 12076.698082548006, 12080.51677932873, 12086.15396922207, 12121.515139394325, 12240.18935099574], "value": 8616.290363511182, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 110.0, 101.0, 106.0, 106.0, 110.0, 111.0, 100.0, 107.0, 111.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 128.0, 142.0, 174.0, 120.0, 143.0, 154.0, 126.0, 168.0, 120.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 166.0, 171.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 76.0, 192.0, 75.0, 75.0, 73.0, 74.0, 173.0, 75.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 129.0, 80.0, 79.0, 80.0, 129.0, 80.0, 79.0, 132.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 149.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 52.0, 52.0, 55.0, 52.0, 54.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 73.0, 78.0, 77.0, 76.0, 76.0, 77.0, 76.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 115.0, 122.0, 117.0, 128.0, 123.0, 125.0, 122.0, 166.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 182.0, 170.0, 181.0, 181.0, 179.0, 169.0, 169.0, 171.0, 177.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 65.0, 63.0, 65.0, 63.0, 64.0, 64.0, 67.0], "value": 64.1, "unit": "score"}]}]} 17:14:33 INFO - Return code: 0 17:14:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:33 INFO - # TBPL SUCCESS # 17:14:33 INFO - Running post-action listener: _package_coverage_data 17:14:33 INFO - Running post-action listener: _resource_record_post_action 17:14:33 INFO - [mozharness: 2017-08-24 00:14:33.377778Z] Finished run-tests step (success) 17:14:33 INFO - Running post-run listener: _resource_record_post_run 17:14:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431857664; Read time: 8; Write time: 292672 17:14:33 INFO - TinderboxPrint: CPU usage
13.1% 17:14:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:14:33 INFO - TinderboxPrint: I/O write bytes / time
431,857,664 / 292,672 17:14:33 INFO - TinderboxPrint: CPU idle
8,245.0 (86.9%) 17:14:33 INFO - TinderboxPrint: CPU user
1,194.9 (12.6%) 17:14:33 INFO - TinderboxPrint: Swap in / out
0 / 0 17:14:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105193472; Read time: 0; Write time: 87420 17:14:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:14:33 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326664192; Read time: 8; Write time: 205252 17:14:34 INFO - Running post-run listener: _upload_blobber_files 17:14:34 INFO - Blob upload gear active. 17:14:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:14:34 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'] 17:14:34 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 17:14:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:14:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:35 INFO - (blobuploader) - INFO - Done attempting. 17:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:36 INFO - (blobuploader) - INFO - Done attempting. 17:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:39 INFO - (blobuploader) - INFO - Done attempting. 17:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:39 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 17:15:39 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 17:15:39 INFO - (blobuploader) - INFO - Done attempting. 17:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:39 INFO - Return code: 0 17:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72a098e6a6510f48e858130518c3011e044eebe22cad3a2f8ac0b2f17ba0977e1af5f863c3ac5e3b04334eca0f5cb1ad7183d30b8273631364ff94fc3df6c47f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ca55e6e0a07b291fae99f9eef430c5a310f85aa97cb5adcba49e6362a538c8d0c9bd314edf063f678d333473f3a104487c693d4b01b5af092ffb486c456f42", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/993ddb1d856bea504759dd1d40cb24d6b8bb58b4970f4f21a9a1aa5aaaa84c0699d4bd9811881552fdb5fe379b6e21778518df61004604f1b29b98afa9421905", "perfherder-data.json": null} 17:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:39 INFO - Contents: 17:15:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72a098e6a6510f48e858130518c3011e044eebe22cad3a2f8ac0b2f17ba0977e1af5f863c3ac5e3b04334eca0f5cb1ad7183d30b8273631364ff94fc3df6c47f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ca55e6e0a07b291fae99f9eef430c5a310f85aa97cb5adcba49e6362a538c8d0c9bd314edf063f678d333473f3a104487c693d4b01b5af092ffb486c456f42", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/993ddb1d856bea504759dd1d40cb24d6b8bb58b4970f4f21a9a1aa5aaaa84c0699d4bd9811881552fdb5fe379b6e21778518df61004604f1b29b98afa9421905", "perfherder-data.json": null} 17:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:39 INFO - Copying logs to upload dir... 17:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.103759 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2017-08-23 17:15:39.458972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:15:39.462597) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72a098e6a6510f48e858130518c3011e044eebe22cad3a2f8ac0b2f17ba0977e1af5f863c3ac5e3b04334eca0f5cb1ad7183d30b8273631364ff94fc3df6c47f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ca55e6e0a07b291fae99f9eef430c5a310f85aa97cb5adcba49e6362a538c8d0c9bd314edf063f678d333473f3a104487c693d4b01b5af092ffb486c456f42", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/993ddb1d856bea504759dd1d40cb24d6b8bb58b4970f4f21a9a1aa5aaaa84c0699d4bd9811881552fdb5fe379b6e21778518df61004604f1b29b98afa9421905", "perfherder-data.json": null} build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011833 build_url: 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72a098e6a6510f48e858130518c3011e044eebe22cad3a2f8ac0b2f17ba0977e1af5f863c3ac5e3b04334eca0f5cb1ad7183d30b8273631364ff94fc3df6c47f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ca55e6e0a07b291fae99f9eef430c5a310f85aa97cb5adcba49e6362a538c8d0c9bd314edf063f678d333473f3a104487c693d4b01b5af092ffb486c456f42", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/993ddb1d856bea504759dd1d40cb24d6b8bb58b4970f4f21a9a1aa5aaaa84c0699d4bd9811881552fdb5fe379b6e21778518df61004604f1b29b98afa9421905", "perfherder-data.json": null}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:15:39.490363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:15:39.490670) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503532410.888685-562930916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:15:39.578026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:15:39.578335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:15:39.578625) ========= ========= Total master_lag: 0.18 =========