builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1503081814.86 results: success (0) revision: 978f68c17245c37283a3635629efff66d2cdcba9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:34.859148) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:34.859689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:34.860017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:34.876439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:34.876768) ========= 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=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 11:43:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.5M=0s 2017-08-18 11:43:35 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.028463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.028802) ========= 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=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017686 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.079790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.080344) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 978f68c17245c37283a3635629efff66d2cdcba9 --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 978f68c17245c37283a3635629efff66d2cdcba9 --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=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 11:43:35,138 truncating revision to first 12 chars 2017-08-18 11:43:35,138 Setting DEBUG logging. 2017-08-18 11:43:35,138 attempt 1/10 2017-08-18 11:43:35,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/978f68c17245?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 11:43:35,549 unpacking tar archive at: mozilla-central-978f68c17245/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.838470) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.838818) ========= script_repo_revision: 978f68c17245c37283a3635629efff66d2cdcba9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.839228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.839525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 11:43:35.850363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-18 11:43:35.850680) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:43:36 INFO - MultiFileLogger online at 20170818 11:43:36 in /builds/slave/test 11:43:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:43:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:43:36 INFO - {'append_to_log': False, 11:43:36 INFO - 'base_work_dir': '/builds/slave/test', 11:43:36 INFO - 'blob_upload_branch': 'Firefox', 11:43:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:43:36 INFO - 'branch': 'Firefox', 11:43:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:43:36 INFO - 'code_coverage': False, 11:43:36 INFO - 'config_files': ('talos/linux_config.py',), 11:43:36 INFO - 'default_actions': ('clobber', 11:43:36 INFO - 'read-buildbot-config', 11:43:36 INFO - 'download-and-extract', 11:43:36 INFO - 'populate-webroot', 11:43:36 INFO - 'create-virtualenv', 11:43:36 INFO - 'install', 11:43:36 INFO - 'setup-mitmproxy', 11:43:36 INFO - 'run-tests'), 11:43:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:43:36 INFO - 'disable_ccov_upload': False, 11:43:36 INFO - 'download_minidump_stackwalk': True, 11:43:36 INFO - 'download_symbols': 'ondemand', 11:43:36 INFO - 'enable_stylo': False, 11:43:36 INFO - 'enable_webrender': False, 11:43:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:43:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:43:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:43:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:43:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:43:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:43:36 INFO - 'gecko_profile': False, 11:43:36 INFO - 'gecko_profile_interval': 0, 11:43:36 INFO - 'installer_path': 'installer.exe', 11:43:36 INFO - 'log_level': 'info', 11:43:36 INFO - 'log_name': 'talos', 11:43:36 INFO - 'log_to_console': True, 11:43:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:43:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:43:36 INFO - 'opt_config_files': (), 11:43:36 INFO - 'pip_index': False, 11:43:36 INFO - 'suite': 'dromaeojs-e10s', 11:43:36 INFO - 'system_bits': '32', 11:43:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:43:36 INFO - 'title': 'talos-linux64-ix-055', 11:43:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:43:36 INFO - 'use_talos_json': True, 11:43:36 INFO - 'verify': 'False', 11:43:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:43:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:43:36 INFO - 'work_dir': 'build'} 11:43:36 INFO - [mozharness: 2017-08-18 18:43:36.045401Z] Running clobber step. 11:43:36 INFO - Running pre-action listener: _resource_record_pre_action 11:43:36 INFO - Running main action method: clobber 11:43:36 INFO - rmtree: /builds/slave/test/build 11:43:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:43:37 INFO - Running post-action listener: _resource_record_post_action 11:43:37 INFO - [mozharness: 2017-08-18 18:43:37.061365Z] Finished clobber step (success) 11:43:37 INFO - [mozharness: 2017-08-18 18:43:37.061463Z] Running read-buildbot-config step. 11:43:37 INFO - Running pre-action listener: _resource_record_pre_action 11:43:37 INFO - Running main action method: read_buildbot_config 11:43:37 INFO - Using buildbot properties: 11:43:37 INFO - { 11:43:37 INFO - "project": "", 11:43:37 INFO - "product": "firefox", 11:43:37 INFO - "who": "ffxbld@noreply.mozilla.org", 11:43:37 INFO - "installer_path": "public/build/target.tar.bz2", 11:43:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:43:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:43:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:43:37 INFO - "stage_platform": "linux64-pgo", 11:43:37 INFO - "basedir": "/builds/slave/test", 11:43:37 INFO - "buildnumber": 127, 11:43:37 INFO - "platform": "ubuntu64_hw", 11:43:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:43:37 INFO - "slavebuilddir": "test", 11:43:37 INFO - "taskId": "WtAkxrMfS2-cPQ7RyM8PBw", 11:43:37 INFO - "branch": "mozilla-central", 11:43:37 INFO - "script_repo_revision": "production", 11:43:37 INFO - "revision": "978f68c17245c37283a3635629efff66d2cdcba9", 11:43:37 INFO - "slavename": "talos-linux64-ix-055", 11:43:37 INFO - "repo_path": "mozilla-central" 11:43:37 INFO - } 11:43:37 INFO - Finding installer, test and symbols from parent task. 11:43:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtAkxrMfS2-cPQ7RyM8PBw'}, attempt #1 11:43:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WtAkxrMfS2-cPQ7RyM8PBw'}, attempt #1 11:43:38 INFO - Task dependencies: XiW5Eyh5TGG8fP6P6_2IWA 11:43:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA'}, attempt #1 11:43:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 11:43:38 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.test_packages.json 11:43:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.crashreporter-symbols.zip 11:43:38 INFO - Running post-action listener: _resource_record_post_action 11:43:38 INFO - [mozharness: 2017-08-18 18:43:38.445356Z] Finished read-buildbot-config step (success) 11:43:38 INFO - [mozharness: 2017-08-18 18:43:38.445615Z] Running download-and-extract step. 11:43:38 INFO - Running pre-action listener: _resource_record_pre_action 11:43:38 INFO - Running main action method: download_and_extract 11:43:38 INFO - mkdir: /builds/slave/test/build/tests 11:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:43:38 INFO - trying https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.test_packages.json 11:43:38 INFO - Downloading https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:43:38 INFO - Downloaded 989 bytes. 11:43:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:43:38 INFO - Using the following test package requirements: 11:43:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:43:38 INFO - u'common': [u'target.common.tests.zip'], 11:43:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:43:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:43:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:43:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:43:38 INFO - u'mozbase': [u'target.common.tests.zip'], 11:43:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:43:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:43:38 INFO - u'web-platform': [u'target.common.tests.zip', 11:43:38 INFO - u'target.web-platform.tests.tar.gz'], 11:43:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:43:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:43:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip 11:43:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:43:38 INFO - Fetch https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip into memory 11:43:40 INFO - Content-Length response header: 54613369 11:43:40 INFO - Bytes received: 54613369 11:43:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:43:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip 11:43:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:43:51 INFO - Fetch https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.common.tests.zip into memory 11:43:52 INFO - Content-Length response header: 54613369 11:43:52 INFO - Bytes received: 54613369 11:44:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.talos.tests.zip 11:44:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:44:04 INFO - Fetch https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.talos.tests.zip into memory 11:44:04 INFO - Content-Length response header: 14496161 11:44:04 INFO - Bytes received: 14496161 11:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:05 INFO - trying https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 11:44:05 INFO - Downloading https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:44:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:44:06 INFO - Downloaded 62983832 bytes. 11:44:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 11:44:06 INFO - mkdir: /builds/slave/test/properties 11:44:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:06 INFO - Contents: 11:44:06 INFO - build_url:https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 11:44:06 INFO - Running post-action listener: _resource_record_post_action 11:44:06 INFO - Running post-action listener: find_tests_for_verification 11:44:06 INFO - Running post-action listener: set_extra_try_arguments 11:44:06 INFO - [mozharness: 2017-08-18 18:44:06.337738Z] Finished download-and-extract step (success) 11:44:06 INFO - [mozharness: 2017-08-18 18:44:06.337835Z] Running populate-webroot step. 11:44:06 INFO - Running pre-action listener: _resource_record_pre_action 11:44:06 INFO - Running main action method: populate_webroot 11:44:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:06 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:06 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:44:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:06 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'tests': ['damp', 'tps']}, 11:44:06 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['damp', 'tps']}, 11:44:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:44:06 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:44:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:44:06 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:44:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:06 INFO - 'ts_paint', 11:44:06 INFO - 'tpaint', 11:44:06 INFO - 'sessionrestore', 11:44:06 INFO - 'sessionrestore_many_windows', 11:44:06 INFO - 'sessionrestore_no_auto_restore', 11:44:06 INFO - 'tabpaint']}, 11:44:06 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['a11yr', 11:44:06 INFO - 'ts_paint', 11:44:06 INFO - 'tpaint', 11:44:06 INFO - 'sessionrestore', 11:44:06 INFO - 'sessionrestore_many_windows', 11:44:06 INFO - 'sessionrestore_no_auto_restore', 11:44:06 INFO - 'tabpaint']}, 11:44:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:44:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:44:06 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['bloom_basic_singleton']}, 11:44:06 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['bloom_basic']}, 11:44:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:06 INFO - 'tsvgr_opacity', 11:44:06 INFO - 'tart', 11:44:06 INFO - 'tscrollx', 11:44:06 INFO - 'tsvg_static']}, 11:44:06 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['tsvgx', 11:44:06 INFO - 'tsvgr_opacity', 11:44:06 INFO - 'tart', 11:44:06 INFO - 'tscrollx', 11:44:06 INFO - 'tsvg_static']}, 11:44:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:44:06 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--stylo'], 11:44:06 INFO - 'tests': ['tp5o']}, 11:44:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:06 INFO - 'talos_options': ['--mitmproxy', 11:44:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:06 INFO - '--firstNonBlankPaint'], 11:44:06 INFO - 'tests': ['tp6_google', 11:44:06 INFO - 'tp6_youtube', 11:44:06 INFO - 'tp6_amazon', 11:44:06 INFO - 'tp6_facebook']}, 11:44:06 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:06 INFO - 'talos_options': ['--stylo', 11:44:06 INFO - '--mitmproxy', 11:44:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:06 INFO - '--firstNonBlankPaint'], 11:44:06 INFO - 'tests': ['tp6_google', 11:44:06 INFO - 'tp6_youtube', 11:44:06 INFO - 'tp6_amazon', 11:44:06 INFO - 'tp6_facebook']}, 11:44:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:06 INFO - 'talos_options': ['--stylo', 11:44:06 INFO - '--stylo-threads=1', 11:44:06 INFO - '--mitmproxy', 11:44:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:06 INFO - '--firstNonBlankPaint'], 11:44:06 INFO - 'tests': ['tp6_google', 11:44:06 INFO - 'tp6_youtube', 11:44:06 INFO - 'tp6_amazon', 11:44:06 INFO - 'tp6_facebook']}, 11:44:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--xperf_path', 11:44:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:06 INFO - 'tests': ['tp5n']}, 11:44:06 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:44:06 INFO - 'talos_options': ['--stylo', 11:44:06 INFO - '--xperf_path', 11:44:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:06 INFO - 'tests': ['tp5n']}}} 11:44:06 INFO - Running post-action listener: _resource_record_post_action 11:44:06 INFO - [mozharness: 2017-08-18 18:44:06.351968Z] Finished populate-webroot step (success) 11:44:06 INFO - [mozharness: 2017-08-18 18:44:06.352057Z] Running create-virtualenv step. 11:44:06 INFO - Running pre-action listener: _resource_record_pre_action 11:44:06 INFO - Running main action method: create_virtualenv 11:44:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:44:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:44:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:06 INFO - Using real prefix '/usr' 11:44:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:08 INFO - Installing pip.................done. 11:44:08 INFO - Return code: 0 11:44:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:44:09 INFO - Reading from file tmpfile_stdout 11:44:09 INFO - Output received: 11:44:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:44:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:09 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')]} 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:09 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')]} 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:09 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:09 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 11:44:09 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 11:44:09 INFO - Using env: {'DISPLAY': ':0', 11:44:09 INFO - 'HOME': '/home/cltbld', 11:44:09 INFO - 'LANG': 'en_US.UTF-8', 11:44:09 INFO - 'LANGUAGE': 'en_US:en', 11:44:09 INFO - 'LOGNAME': 'cltbld', 11:44:09 INFO - 'MAIL': '/var/mail/cltbld', 11:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:09 INFO - 'MOZ_NO_REMOTE': '1', 11:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:09 INFO - 'NO_EM_RESTART': '1', 11:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:09 INFO - 'PWD': '/builds/slave/test', 11:44:09 INFO - 'SHELL': '/bin/bash', 11:44:09 INFO - 'SHLVL': '1', 11:44:09 INFO - 'TERM': 'linux', 11:44:09 INFO - 'TMOUT': '86400', 11:44:09 INFO - 'USER': 'cltbld', 11:44:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:09 INFO - '_': '/tools/buildbot/bin/python'} 11:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:44:09 INFO - Cleaning up... 11:44:09 INFO - Return code: 0 11:44:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44:09 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')]} 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:09 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')]} 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:09 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:09 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 11:44:09 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 11:44:09 INFO - Using env: {'DISPLAY': ':0', 11:44:09 INFO - 'HOME': '/home/cltbld', 11:44:09 INFO - 'LANG': 'en_US.UTF-8', 11:44:09 INFO - 'LANGUAGE': 'en_US:en', 11:44:09 INFO - 'LOGNAME': 'cltbld', 11:44:09 INFO - 'MAIL': '/var/mail/cltbld', 11:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:09 INFO - 'MOZ_NO_REMOTE': '1', 11:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:09 INFO - 'NO_EM_RESTART': '1', 11:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:09 INFO - 'PWD': '/builds/slave/test', 11:44:09 INFO - 'SHELL': '/bin/bash', 11:44:09 INFO - 'SHLVL': '1', 11:44:09 INFO - 'TERM': 'linux', 11:44:09 INFO - 'TMOUT': '86400', 11:44:09 INFO - 'USER': 'cltbld', 11:44:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:09 INFO - '_': '/tools/buildbot/bin/python'} 11:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:09 INFO - Downloading/unpacking psutil>=3.1.1 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:10 INFO - Installing collected packages: psutil 11:44:10 INFO - Running setup.py install for psutil 11:44:10 INFO - building 'psutil._psutil_linux' extension 11:44:10 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 11:44:11 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 11:44:11 INFO - building 'psutil._psutil_posix' extension 11:44:11 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 11:44:11 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 11:44:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:11 INFO - Successfully installed psutil 11:44:11 INFO - Cleaning up... 11:44:11 INFO - Return code: 0 11:44:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:44:11 INFO - Using env: {'DISPLAY': ':0', 11:44:11 INFO - 'HOME': '/home/cltbld', 11:44:11 INFO - 'LANG': 'en_US.UTF-8', 11:44:11 INFO - 'LANGUAGE': 'en_US:en', 11:44:11 INFO - 'LOGNAME': 'cltbld', 11:44:11 INFO - 'MAIL': '/var/mail/cltbld', 11:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:11 INFO - 'MOZ_NO_REMOTE': '1', 11:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:11 INFO - 'NO_EM_RESTART': '1', 11:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:11 INFO - 'PWD': '/builds/slave/test', 11:44:11 INFO - 'SHELL': '/bin/bash', 11:44:11 INFO - 'SHLVL': '1', 11:44:11 INFO - 'TERM': 'linux', 11:44:11 INFO - 'TMOUT': '86400', 11:44:11 INFO - 'USER': 'cltbld', 11:44:11 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:11 INFO - '_': '/tools/buildbot/bin/python'} 11:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:11 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 11:44:11 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 11:44:11 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 11:44:11 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 11:44:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:12 INFO - Installing collected packages: mozsystemmonitor 11:44:12 INFO - Running setup.py install for mozsystemmonitor 11:44:12 INFO - Successfully installed mozsystemmonitor 11:44:12 INFO - Cleaning up... 11:44:12 INFO - Return code: 0 11:44:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:44:12 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')]} 11:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:12 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')]} 11:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:12 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:12 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 11:44:12 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 11:44:12 INFO - Using env: {'DISPLAY': ':0', 11:44:12 INFO - 'HOME': '/home/cltbld', 11:44:12 INFO - 'LANG': 'en_US.UTF-8', 11:44:12 INFO - 'LANGUAGE': 'en_US:en', 11:44:12 INFO - 'LOGNAME': 'cltbld', 11:44:12 INFO - 'MAIL': '/var/mail/cltbld', 11:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:12 INFO - 'MOZ_NO_REMOTE': '1', 11:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:12 INFO - 'NO_EM_RESTART': '1', 11:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:12 INFO - 'PWD': '/builds/slave/test', 11:44:12 INFO - 'SHELL': '/bin/bash', 11:44:12 INFO - 'SHLVL': '1', 11:44:12 INFO - 'TERM': 'linux', 11:44:12 INFO - 'TMOUT': '86400', 11:44:12 INFO - 'USER': 'cltbld', 11:44:12 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:12 INFO - '_': '/tools/buildbot/bin/python'} 11:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:13 INFO - Downloading/unpacking jsonschema==2.5.1 11:44:13 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 11:44:13 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 11:44:13 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 11:44:13 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 11:44:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:14 INFO - warning: no files found matching '*.txt' 11:44:14 INFO - no previously-included directories found matching 'build' 11:44:14 INFO - no previously-included directories found matching 'dist' 11:44:14 INFO - no previously-included directories found matching '.git*' 11:44:14 INFO - Installing collected packages: jsonschema, functools32 11:44:14 INFO - Running setup.py install for functools32 11:44:14 INFO - warning: no files found matching '*.txt' 11:44:14 INFO - no previously-included directories found matching 'build' 11:44:14 INFO - no previously-included directories found matching 'dist' 11:44:14 INFO - no previously-included directories found matching '.git*' 11:44:14 INFO - Successfully installed jsonschema functools32 11:44:14 INFO - Cleaning up... 11:44:14 INFO - Return code: 0 11:44:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:14 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:14 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 11:44:14 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 11:44:14 INFO - Using env: {'DISPLAY': ':0', 11:44:14 INFO - 'HOME': '/home/cltbld', 11:44:14 INFO - 'LANG': 'en_US.UTF-8', 11:44:14 INFO - 'LANGUAGE': 'en_US:en', 11:44:14 INFO - 'LOGNAME': 'cltbld', 11:44:14 INFO - 'MAIL': '/var/mail/cltbld', 11:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:14 INFO - 'MOZ_NO_REMOTE': '1', 11:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:14 INFO - 'NO_EM_RESTART': '1', 11:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:14 INFO - 'PWD': '/builds/slave/test', 11:44:14 INFO - 'SHELL': '/bin/bash', 11:44:14 INFO - 'SHLVL': '1', 11:44:14 INFO - 'TERM': 'linux', 11:44:14 INFO - 'TMOUT': '86400', 11:44:14 INFO - 'USER': 'cltbld', 11:44:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:14 INFO - '_': '/tools/buildbot/bin/python'} 11:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:14 INFO - Cleaning up... 11:44:14 INFO - Return code: 0 11:44:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:14 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:14 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 11:44:14 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 11:44:14 INFO - Using env: {'DISPLAY': ':0', 11:44:14 INFO - 'HOME': '/home/cltbld', 11:44:14 INFO - 'LANG': 'en_US.UTF-8', 11:44:14 INFO - 'LANGUAGE': 'en_US:en', 11:44:14 INFO - 'LOGNAME': 'cltbld', 11:44:14 INFO - 'MAIL': '/var/mail/cltbld', 11:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:14 INFO - 'MOZ_NO_REMOTE': '1', 11:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:14 INFO - 'NO_EM_RESTART': '1', 11:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:14 INFO - 'PWD': '/builds/slave/test', 11:44:14 INFO - 'SHELL': '/bin/bash', 11:44:14 INFO - 'SHLVL': '1', 11:44:14 INFO - 'TERM': 'linux', 11:44:14 INFO - 'TMOUT': '86400', 11:44:14 INFO - 'USER': 'cltbld', 11:44:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:14 INFO - '_': '/tools/buildbot/bin/python'} 11:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:16 INFO - Downloading docopt-0.6.1.tar.gz 11:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:16 INFO - Running setup.py install for blobuploader 11:44:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:16 INFO - Running setup.py install for requests 11:44:17 INFO - Running setup.py install for docopt 11:44:17 INFO - Successfully installed blobuploader requests docopt 11:44:17 INFO - Cleaning up... 11:44:17 INFO - Return code: 0 11:44:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:17 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')]} 11:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:17 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')]} 11:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:17 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:17 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 11:44:17 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 11:44:17 INFO - Using env: {'DISPLAY': ':0', 11:44:17 INFO - 'HOME': '/home/cltbld', 11:44:17 INFO - 'LANG': 'en_US.UTF-8', 11:44:17 INFO - 'LANGUAGE': 'en_US:en', 11:44:17 INFO - 'LOGNAME': 'cltbld', 11:44:17 INFO - 'MAIL': '/var/mail/cltbld', 11:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:17 INFO - 'MOZ_NO_REMOTE': '1', 11:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:17 INFO - 'NO_EM_RESTART': '1', 11:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:17 INFO - 'PWD': '/builds/slave/test', 11:44:17 INFO - 'SHELL': '/bin/bash', 11:44:17 INFO - 'SHLVL': '1', 11:44:17 INFO - 'TERM': 'linux', 11:44:17 INFO - 'TMOUT': '86400', 11:44:17 INFO - 'USER': 'cltbld', 11:44:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:17 INFO - '_': '/tools/buildbot/bin/python'} 11:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:17 INFO - Running setup.py (path:/tmp/pip-DsGCYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:17 INFO - Running setup.py (path:/tmp/pip-NAfe0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:17 INFO - Running setup.py (path:/tmp/pip-9vhAMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:17 INFO - Running setup.py (path:/tmp/pip-kYiDCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:17 INFO - Running setup.py (path:/tmp/pip-q7W4oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:17 INFO - Running setup.py (path:/tmp/pip-21OtPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:17 INFO - Running setup.py (path:/tmp/pip-ag7XL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:17 INFO - Running setup.py (path:/tmp/pip-scplZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:18 INFO - Running setup.py (path:/tmp/pip-fj6Zop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:18 INFO - Running setup.py (path:/tmp/pip-YhX5Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:18 INFO - Running setup.py (path:/tmp/pip-Eiz7Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:18 INFO - Running setup.py (path:/tmp/pip-XGCVQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:18 INFO - Running setup.py (path:/tmp/pip-l5u7ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:18 INFO - Running setup.py (path:/tmp/pip-aZWKoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:18 INFO - Running setup.py (path:/tmp/pip-hVRf9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:18 INFO - Running setup.py (path:/tmp/pip-ICnjMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:18 INFO - Running setup.py (path:/tmp/pip-b54cOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:18 INFO - Running setup.py install for manifestparser 11:44:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:18 INFO - Running setup.py install for mozcrash 11:44:18 INFO - Running setup.py install for mozdebug 11:44:19 INFO - Running setup.py install for mozdevice 11:44:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for mozfile 11:44:19 INFO - Running setup.py install for mozhttpd 11:44:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for mozinfo 11:44:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for mozInstall 11:44:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for mozleak 11:44:19 INFO - Running setup.py install for mozlog 11:44:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for moznetwork 11:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:19 INFO - Running setup.py install for mozprocess 11:44:19 INFO - Running setup.py install for mozprofile 11:44:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:20 INFO - Running setup.py install for mozrunner 11:44:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:20 INFO - Running setup.py install for mozscreenshot 11:44:20 INFO - Running setup.py install for moztest 11:44:20 INFO - Running setup.py install for mozversion 11:44:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:20 INFO - Cleaning up... 11:44:20 INFO - Return code: 0 11:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:20 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:20 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 11:44:20 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 11:44:20 INFO - Using env: {'DISPLAY': ':0', 11:44:20 INFO - 'HOME': '/home/cltbld', 11:44:20 INFO - 'LANG': 'en_US.UTF-8', 11:44:20 INFO - 'LANGUAGE': 'en_US:en', 11:44:20 INFO - 'LOGNAME': 'cltbld', 11:44:20 INFO - 'MAIL': '/var/mail/cltbld', 11:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:20 INFO - 'MOZ_NO_REMOTE': '1', 11:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:20 INFO - 'NO_EM_RESTART': '1', 11:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:20 INFO - 'PWD': '/builds/slave/test', 11:44:20 INFO - 'SHELL': '/bin/bash', 11:44:20 INFO - 'SHLVL': '1', 11:44:20 INFO - 'TERM': 'linux', 11:44:20 INFO - 'TMOUT': '86400', 11:44:20 INFO - 'USER': 'cltbld', 11:44:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:20 INFO - '_': '/tools/buildbot/bin/python'} 11:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:20 INFO - Running setup.py (path:/tmp/pip-sBSSZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:20 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)) 11:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:20 INFO - Running setup.py (path:/tmp/pip-Pc44kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:20 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)) 11:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:20 INFO - Running setup.py (path:/tmp/pip-855clq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:20 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)) 11:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:20 INFO - Running setup.py (path:/tmp/pip-A5dCG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:21 INFO - Running setup.py (path:/tmp/pip-Ve8FKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:21 INFO - Running setup.py (path:/tmp/pip-b13dHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:21 INFO - Running setup.py (path:/tmp/pip-6xiLxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:21 INFO - Running setup.py (path:/tmp/pip-YzLD08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:21 INFO - Running setup.py (path:/tmp/pip-pBxbwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:21 INFO - Running setup.py (path:/tmp/pip-5pFpPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:21 INFO - Running setup.py (path:/tmp/pip-YVAAtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:21 INFO - Running setup.py (path:/tmp/pip-x7OiUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:21 INFO - Running setup.py (path:/tmp/pip-GMDfqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:21 INFO - Running setup.py (path:/tmp/pip-2vBZJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:21 INFO - Running setup.py (path:/tmp/pip-Ktbc76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:21 INFO - Running setup.py (path:/tmp/pip-mIzYa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:21 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)) 11:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:21 INFO - Running setup.py (path:/tmp/pip-XgqCcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:21 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)) 11:44:21 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)) 11:44:21 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)) 11:44:21 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)) 11:44:21 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)) 11:44:21 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)) 11:44:21 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)) 11:44:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:21 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 11:44:21 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 11:44:21 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 11:44:21 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 11:44:23 INFO - Downloading blessings-1.6.tar.gz 11:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:23 INFO - Installing collected packages: blessings 11:44:23 INFO - Running setup.py install for blessings 11:44:23 INFO - Successfully installed blessings 11:44:23 INFO - Cleaning up... 11:44:23 INFO - Return code: 0 11:44:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:23 INFO - Reading from file tmpfile_stdout 11:44:23 INFO - Current package versions: 11:44:23 INFO - argparse == 1.2.1 11:44:23 INFO - blessings == 1.6 11:44:23 INFO - blobuploader == 1.2.4 11:44:23 INFO - docopt == 0.6.1 11:44:23 INFO - functools32 == 3.2.3-2 11:44:23 INFO - jsonschema == 2.5.1 11:44:23 INFO - manifestparser == 1.1 11:44:23 INFO - mozInstall == 1.13 11:44:23 INFO - mozcrash == 1.0 11:44:23 INFO - mozdebug == 0.1 11:44:23 INFO - mozdevice == 0.51 11:44:23 INFO - mozfile == 1.2 11:44:23 INFO - mozhttpd == 0.7 11:44:23 INFO - mozinfo == 0.10 11:44:23 INFO - mozleak == 0.1 11:44:23 INFO - mozlog == 3.5 11:44:23 INFO - moznetwork == 0.27 11:44:23 INFO - mozprocess == 0.25 11:44:23 INFO - mozprofile == 0.28 11:44:23 INFO - mozrunner == 6.13 11:44:23 INFO - mozscreenshot == 0.1 11:44:23 INFO - mozsystemmonitor == 0.3 11:44:23 INFO - moztest == 0.8 11:44:23 INFO - mozversion == 1.4 11:44:23 INFO - psutil == 3.1.1 11:44:23 INFO - requests == 1.2.3 11:44:23 INFO - wsgiref == 0.1.2 11:44:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:23 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')]} 11:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:23 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')]} 11:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:23 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 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44:23 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 11:44:23 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 11:44:23 INFO - Using env: {'DISPLAY': ':0', 11:44:23 INFO - 'HOME': '/home/cltbld', 11:44:23 INFO - 'LANG': 'en_US.UTF-8', 11:44:23 INFO - 'LANGUAGE': 'en_US:en', 11:44:23 INFO - 'LOGNAME': 'cltbld', 11:44:23 INFO - 'MAIL': '/var/mail/cltbld', 11:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:23 INFO - 'MOZ_NO_REMOTE': '1', 11:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:23 INFO - 'NO_EM_RESTART': '1', 11:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:23 INFO - 'PWD': '/builds/slave/test', 11:44:23 INFO - 'SHELL': '/bin/bash', 11:44:23 INFO - 'SHLVL': '1', 11:44:23 INFO - 'TERM': 'linux', 11:44:23 INFO - 'TMOUT': '86400', 11:44:23 INFO - 'USER': 'cltbld', 11:44:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:23 INFO - '_': '/tools/buildbot/bin/python'} 11:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 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)) 11:44:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:44:24 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)) 11:44:24 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)) 11:44:24 INFO - Installing collected packages: simplejson 11:44:24 INFO - Running setup.py install for simplejson 11:44:24 INFO - building 'simplejson._speedups' extension 11:44:24 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 11:44:25 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 11:44:25 INFO - Successfully installed simplejson 11:44:25 INFO - Cleaning up... 11:44:25 INFO - Return code: 0 11:44:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44: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')]} 11:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1360ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', '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 11:44: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', 'jsonschema'] in /builds/slave/test/build 11:44: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 jsonschema 11:44:25 INFO - Using env: {'DISPLAY': ':0', 11:44:25 INFO - 'HOME': '/home/cltbld', 11:44:25 INFO - 'LANG': 'en_US.UTF-8', 11:44:25 INFO - 'LANGUAGE': 'en_US:en', 11:44:25 INFO - 'LOGNAME': 'cltbld', 11:44:25 INFO - 'MAIL': '/var/mail/cltbld', 11:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:25 INFO - 'MOZ_NO_REMOTE': '1', 11:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:25 INFO - 'NO_EM_RESTART': '1', 11:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:25 INFO - 'PWD': '/builds/slave/test', 11:44:25 INFO - 'SHELL': '/bin/bash', 11:44:25 INFO - 'SHLVL': '1', 11:44:25 INFO - 'TERM': 'linux', 11:44:25 INFO - 'TMOUT': '86400', 11:44:25 INFO - 'USER': 'cltbld', 11:44:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:25 INFO - '_': '/tools/buildbot/bin/python'} 11:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:44:26 INFO - Cleaning up... 11:44:26 INFO - Return code: 0 11:44:26 INFO - Running post-action listener: _resource_record_post_action 11:44:26 INFO - Running post-action listener: _start_resource_monitoring 11:44:26 INFO - Starting resource monitoring. 11:44:26 INFO - [mozharness: 2017-08-18 18:44:26.186680Z] Finished create-virtualenv step (success) 11:44:26 INFO - [mozharness: 2017-08-18 18:44:26.187202Z] Running install step. 11:44:26 INFO - Running pre-action listener: _resource_record_pre_action 11:44:26 INFO - Running main action method: install 11:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:26 INFO - Reading from file tmpfile_stdout 11:44:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:44:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:44:26 INFO - Reading from file tmpfile_stdout 11:44:26 INFO - Output received: 11:44:26 INFO - Usage: mozinstall [options] installer 11:44:26 INFO - Options: 11:44:26 INFO - -h, --help show this help message and exit 11:44:26 INFO - -d DEST, --destination=DEST 11:44:26 INFO - Directory to install application into. [default: 11:44:26 INFO - "/builds/slave/test"] 11:44:26 INFO - --app=APP Application being installed. [default: firefox] 11:44:26 INFO - mkdir: /builds/slave/test/build/application 11:44:26 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'] 11:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:44:44 INFO - Reading from file tmpfile_stdout 11:44:44 INFO - Output received: 11:44:44 INFO - /builds/slave/test/build/application/firefox/firefox 11:44:44 INFO - Running post-action listener: _resource_record_post_action 11:44:44 INFO - [mozharness: 2017-08-18 18:44:44.384788Z] Finished install step (success) 11:44:44 INFO - [mozharness: 2017-08-18 18:44:44.384938Z] Running setup-mitmproxy step. 11:44:44 INFO - Running pre-action listener: _resource_record_pre_action 11:44:44 INFO - Running main action method: setup_mitmproxy 11:44:44 INFO - Skipping: mitmproxy is not required 11:44:44 INFO - Running post-action listener: _resource_record_post_action 11:44:44 INFO - [mozharness: 2017-08-18 18:44:44.385683Z] Finished setup-mitmproxy step (success) 11:44:44 INFO - [mozharness: 2017-08-18 18:44:44.385908Z] Running run-tests step. 11:44:44 INFO - Running pre-action listener: _resource_record_pre_action 11:44:44 INFO - Running pre-action listener: _set_gcov_prefix 11:44:44 INFO - Running main action method: run_tests 11:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:44:44 INFO - Python 2.7.3 11:44:44 INFO - Return code: 0 11:44:44 INFO - grabbing minidump binary from tooltool 11:44:44 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')]} 11:44:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135e0b0>, '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 0x135efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:44:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:44:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:44:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:44:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:44:44 INFO - Return code: 0 11:44:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:44:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:44:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:44:44 INFO - ENV: RUST_BACKTRACE is now full 11:44:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:44:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 11:44:44 INFO - Using env: {'DISPLAY': ':0', 11:44:44 INFO - 'HOME': '/home/cltbld', 11:44:44 INFO - 'LANG': 'en_US.UTF-8', 11:44:44 INFO - 'LANGUAGE': 'en_US:en', 11:44:44 INFO - 'LOGNAME': 'cltbld', 11:44:44 INFO - 'MAIL': '/var/mail/cltbld', 11:44:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:44 INFO - 'MOZ_NO_REMOTE': '1', 11:44:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:44 INFO - 'NO_EM_RESTART': '1', 11:44:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:44 INFO - 'PWD': '/builds/slave/test', 11:44:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:44 INFO - 'RUST_BACKTRACE': 'full', 11:44:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:44 INFO - 'SHELL': '/bin/bash', 11:44:44 INFO - 'SHLVL': '1', 11:44:44 INFO - 'TERM': 'linux', 11:44:44 INFO - 'TMOUT': '86400', 11:44:44 INFO - 'USER': 'cltbld', 11:44:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332', 11:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:44 INFO - '_': '/tools/buildbot/bin/python'} 11:44:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 11:44:44 INFO - mozversion application_buildid: 20170818173348 11:44:44 INFO - mozversion application_changeset: 978f68c17245c37283a3635629efff66d2cdcba9 11:44:44 INFO - mozversion application_display_name: Nightly 11:44:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:44:44 INFO - mozversion application_name: Firefox 11:44:44 INFO - mozversion application_remotingname: firefox 11:44:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:44:44 INFO - mozversion application_vendor: Mozilla 11:44:44 INFO - mozversion application_version: 57.0a1 11:44:44 INFO - mozversion platform_buildid: 20170818173348 11:44:44 INFO - mozversion platform_changeset: 978f68c17245c37283a3635629efff66d2cdcba9 11:44:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:44:44 INFO - mozversion platform_version: 57.0a1 11:44:44 INFO - using testdate: 1503081884 11:44:44 INFO - actual date: 1503081884 11:44:44 INFO - starting webserver on 'localhost:36829' 11:44:44 INFO - SUITE-START | Running 2 tests 11:44:44 INFO - TEST-START | dromaeo_css 11:44:44 INFO - Initialising browser for dromaeo_css test... 11:44:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36829/getInfo.html -profile /tmp/tmpkgw2mL/profile 11:44:44 INFO - TEST-INFO | started process 20602 (/builds/slave/test/build/application/firefox/firefox http://localhost:36829/getInfo.html) 11:44:50 INFO - TEST-INFO | 20602: exit 0 11:44:50 INFO - Browser initialized. 11:44:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:44:50 INFO - TEST-INFO | started process 20778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgw2mL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:51 INFO - PID 20778 | 11:44:51 INFO - PID 20778 | (/builds/slave/test/build/application/firefox/firefox:20828): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:51 INFO - PID 20778 | 11:45:01 INFO - PID 20778 | RSS: Main: 156872704 11:45:01 INFO - PID 20778 | 11:48:00 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36829/tests/dromaeo/cssquery-ext.html) 11:48:01 INFO - PID 20778 | RSS: Main: 165580800 11:48:01 INFO - PID 20778 | 11:51:02 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-ext.html (next: http://localhost:36829/tests/dromaeo/cssquery-jquery.html) 11:51:03 INFO - PID 20778 | RSS: Main: 161898496 11:51:03 INFO - PID 20778 | 11:54:04 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36829/tests/dromaeo/cssquery-mootools.html) 11:54:05 INFO - PID 20778 | RSS: Main: 163450880 11:54:05 INFO - PID 20778 | 11:57:06 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36829/tests/dromaeo/cssquery-prototype.html) 11:57:07 INFO - PID 20778 | RSS: Main: 162959360 11:57:07 INFO - PID 20778 | 12:00:10 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36829/tests/dromaeo/cssquery-yui.html) 12:00:11 INFO - PID 20778 | RSS: Main: 166801408 12:00:11 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | Cycle 1(1): loaded http://localhost:36829/tests/dromaeo/cssquery-yui.html (next: http://localhost:36829/tests/dromaeo/cssquery-dojo.html) 12:03:13 INFO - PID 20778 | RSS: Main: 167477248 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | __start_tp_report 12:03:13 INFO - PID 20778 | _x_x_mozilla_page_load 12:03:13 INFO - PID 20778 | _x_x_mozilla_page_load_details 12:03:13 INFO - PID 20778 | |i|pagename|runs| 12:03:13 INFO - PID 20778 | |0;dojo.html;3509.824508774562;3544.9113772155697;3551.4672799080136;3555.2711694102713;3581.1763294442276;6253.624782513041;6326.715297811598;6330.43026127649;6392.584482008666;6413.29453760086;6146.047362658784;6244.968775156118;6247.562670613059;6268.780592679257;6416.903746443807;5519.806806761764;5549.38956714762;5586.832395028136;5621.831345059655;5641.069223578104;5466.726663666821;5509.586780991422;5563.36021357543;5568.303962004749;5572.359178694462;5547.750351234184;5550.139728342114;5571.498565129137;5612.130119831432;5634.295713035871;5544.085225937715;5571.387147413781;5614.663120212759;5627.184058311563;5639.464250896158;5457.345118585795;5463.235147079372;5486.945130548684;5497.312835895513;5518.91721624176;6146.815595532141;6175.07373893915;6219.968900155471;6266.686665666744;6281.811545653638;6806.353396427331;6810.659467026629;6863.588184708883;6864.450843932474;6867.896981545281;6777.390034896834;6890.31096890312;6913;6998.930010699879;7003.264657211022;6303.369663033705;6312.905306420362;6321.589096708699;6323.683815809191;6324.71538780756;6891.207511136284;6968.407685346701;7003.054587630605;7091.9290807091265;7150.141982962078;6684.1978962523835;6729.596224226562;6750.864982700318;6766.458683305324;6772.8984065239065;6811.352921472452;6821.386075253251;6886.2769409212315;6898.689558969859;6910.44716422685;6646.2356828965285;6744.595324280559;6769.796906092825;6770.729170833111;6837.453003759687;6805.931940680629;6840.350166734252;6840.521163518605;6841.247462779091;6882.7591034313555;4885.218365061644;4954.20732682769;4959.107360675113;4960.107180707435;4965.0566392385335;4371.781410929504;4377.1683380157665;4404.075144219686;4404.801783919731;4419.602235798793;6353.68231588428;6431.163948686734;6431.228252609623;6438.066480360415;6448.226212854487;6744;6838.076859623887;6861.142357205349;6873.965630171817;6880.139982502187;6397.616143031433;6426.164598602245;6467.547271690936;6477.449416799531;6477.870442591122;5506.201600767947;5539.972300138554;5566.387697353288;5606.159076138611;5609.663420194802;7125.394341480928;7178.641067946582;7195.208527062019;7257.818554536073;7328.267173282629;6851.177858656993;6861.931380686129;6870.381665649916;6881.174259088742;6886.208086070166;7210.855782884418;7293.0519032525435;7305.926940730737;7308.232635573401;7322.926770732224;6758.155230596176;6770.627615481196;6837.3162683731225;6853.588784672936;6860.965695171692;6759.155105611799;6773.187217533928;6801.965990170018;6875.828104297432;6892.724291028303;6621.238557565942;6623.363645448109;6645.966770166118;6650.700718467778;6702.36327548882;6620.271770105188;6620.569662971891;6694.230163531256;6700.095487109178;6705.09481220029;6619.66901654925;6635.668216589054;6688.230853451915;6690.431313338421;6700.564463309869;6568.47452203813;6599.0761293418;6701.1623547056615;6764.458843292623;6785.287544807724;6305.117283580211;6416.903746443713;6425.1968503937005;6429.7106630200815;6530.249021362414 12:03:13 INFO - PID 20778 | |1;ext.html;858.3519442820669;858.4119877883646;888.7822483491543;904.0462312260562;913.1872633356312;43724.78137609312;44172.55827441725;44461.7776911115;44508.554914450884;44629.33056004154;41673.79163104188;41836.58163418365;41945.37081943766;41992.16015679685;42007;7005.684744186498;7118.572885626879;7140.785776426689;7141;7142.642867856613;6995.580265184105;7055.541389809671;7055.753048643299;7060.29397060295;7060.611666358348;7622.428317876153;7983.520988740665;7985.4809437386675;7988.800279993017;7991.920080799205;7838.294553490185;7872.291493765589;7877.133515313311;7898.802529936769;7903.1701671324545;7631.732889348847;7774.844503109963;7778.0666320041955;7782.49413788102;7791.571463569501;40393;40738.18523629511;40740.79629601863;40812.183756325;40857.182856343;3463.7748546344405;3498.142954976022;3510.2452972611013;3510.7542472026967;3510.859565617372;31617.84191079053;31626;31632.841835790903;31698.841505792323;31752.841235793905;4387.605115539584;4393.275109606911;4412.161689279027;4435.467743870724;4451.132029254297;200513;202796;204421;206504;219106;52960.20559691608;53320.73339633277;53365.46634533605;53399;53408.198877016875;54999.72500137474;55101;55118;55125.44874551283;55153.72423137858;15716.607084822743;15838.76241856373;15854.524364269091;15862.365505379887;16023.038617682976;12785.680357991125;12793.296368699625;12797.168184068007;12814.167079139826;12828.35858207086;15009.549713508612;15012.174330411714;15063.774043389358;15106.848931510764;15206.391744330103;6117.816465506042;6161.137440758297;6173.166622505994;6257.530685198628;6260.40526150015;1099.8845121262311;1110.2616759854768;1110.294962698676;1125.2517076144436;1125.9549618015187;23928;24181.637275440884;24411.87794061054;24430.633540496907;24432.633510497002;1214.5809695654984;1222.8288039674453;1225.4301749686438;1230.7661544306732;1232.2052276281747;12839.03707221962;12864.93567532175;12866.421011054525;12928.870711292766;12947.741045179233;249098;250532;250666;251514;251849;55777.44222557804;56269.155962660596;56281;56502.43497565054;56582.71708641513;1543.6603947131614;1557.431537488831;1579.6165640347897;1591.610055536401;1597;24428.26715198547;29837.850810745807;30379.392412152076;30647;31064.844675776476;54721;54842.725786370815;54992.45007549873;55071;55244;223092;223988;225193;225301;225799;34933.47599786056;42464;43106.353404698326;43206.35190472208;43365;51645;51953.22070168875;52342;52347;52823.20765188602;37077.6292237085;37101;37713.81143094267;38046.61953380542;38319.42520862134;37663.81168094142;37917.431238530895;37950;38109;38271.80864095662;44780;44824.32763508485;44879;44968;45068.77465612651;37342.253154937294;37349.25301494009;37441.43837842489;37465;37587;25907.22278331653;26229.34426639349;26809.061682841006;27393.84970728312;28137.015204467745 12:03:13 INFO - PID 20778 | |2;jquery.html;571.3543695623949;577.2841676321361;577.3101144132761;578.1270281874368;585.5959388022266;23368.766312336873;23718.5256294874;24142;24167.15414960479;24189.39526511838;26483.86758066207;26992.865035674793;27076.187714368552;27076.864615676943;27093;6415.550911436213;6549.508786840982;6565.212174539062;6570.605763654172;6572.21133463985;6223.906641400383;6401.615903045809;6446.742130314805;6473.28793832678;6495.447886929616;6431.4533264672555;6450.129232553616;6452.257990331102;6455.677216139197;6455.9354406455805;6441.259255185667;6453.193350831146;6454.741810327558;6461.6446095464735;6465.4827613790785;5982.880342393128;5985.4912332451795;5998;6000.699965001776;6001.639901605918;30059.849700751576;30552.694473055206;30610.84694576513;30699.846500767355;30982;2252.8310376721647;2289.8740569268684;2290.0496294037953;2290.141197051106;2290.6678531612824;20083.096260668306;20644.896775516176;20651.070701818455;20654.17383304681;20675.276365327292;2410.626352915301;2464.8397854139425;2507.7366876478072;2511.2842839790574;2512.937176570582;150415.24792376076;154134;154670.22664886716;155386;158986;15135.470258540898;15273.541793746206;15339.846601533842;15787.921060394854;15989.44036958724;23438.710870901923;23452.413689657555;23477.765222347556;24015.63976540353;24162.395940101287;10303.896961030443;10309.536070876678;10493.632722854663;10585.259031867849;10654.62708805188;9553.14021738033;9562.808743825224;9591.424514529012;9678.516074196263;9718.854217186748;9789.657361992438;9947.602095916081;10251.897481025244;10257.871349238405;10365.63720269787;2907.7383035526905;2923.9444780204735;2924.941501169965;2936.471435141695;3037.529182976642;1047.8847326794046;1066.5360568152723;1073.5061871539024;1078.2613909472036;1078.6440474643348;26025.349366265997;26753.732462675125;26778.196654100408;26987.190384288504;27121.457570848474;1110.8555887734542;1113.7494063835572;1141.2638847943197;1146.4095990564865;1153.5904753812445;11685.357305348118;11842.585509507126;11901;11943.58197463102;11998.700032499257;602578;606868;610706;641662;645246;137761;138550;139518;140262;141706;1341.4567100324384;1343.8387393512842;1369.205860600849;1385.2727318157847;1386.383059538516;18813.529661758566;18971.921556097328;19371.903140484206;19377.51556211106;19713.310034148737;51949.480505194464;64003;64788.35211647823;65795.34204658083;65804;78105;78420.21579784129;78705;78829.60585197038;79058.6047069761;14941.77587336169;15036.323365448363;15082.54752357431;15085.24573771329;15116;24268;24378.26865194047;24654.13710520195;24686.753132468446;24834.25497235086;19188;19341;19377.321793737152;19852.50368740793;20459.59080818405;17112.743308850128;17809.198586063398;17889.37387191442;18026.549336266697;19055.047247637838;19015.42953711391;19197.8080219196;19410.611787764446;19438;21042.368728938156;21250.893745531794;21878.12487500482;22214;22226.777732223116;22569.774302257425;19660.50848728793;19762.60474790525;19872.304469343504;20204;20318.492037699176 12:03:13 INFO - PID 20778 | |3;mootools.html;1406.3319923036559;1453.7673972164448;1467.662437639343;1473.6389584551773;1479.9704005919875;15729.134897580643;15931.601709957256;16297.83702162978;16313.755293670605;16329.18354082297;16327.83672163278;16557.917210413932;16572.585685357873;16666.250018749157;16687.165641717897;2645.9470810583825;2672.184983580007;2697.568389057751;2699.487097451488;2703.175531462903;2754.559270516718;2792.1483947396036;2796.846173460459;2801.145650576573;2802.7757779377703;2653.548896687568;2670.4258584404347;2686.086730511626;2700.351915540276;2701.18964310707;2520.9243722688257;2542.9618555721677;2546.5161619292276;2546.541622507957;2552.22157242042;2512.057978258153;2519.848809071462;2530.911418100376;2535.9492810143693;2569.498947705198;15774.921125394414;15903.045817251003;15918.840811591852;15928.362865485367;15939.681206375808;8293.460925039853;8564.400491965565;8576.528290943996;8580.099089595627;8581.914180858237;5024.497550244946;5259.737013149327;5339.866503337409;5384.0847056000575;5513.26332205354;1757.428835628413;1761.7357396390644;1782.2336395349994;1798.8201179882037;1824.4800231933968;28687.13938581846;29521.557176642367;29654.258643534085;29671.703282967326;29674;7369.520981136209;7452.366548843301;7483.32650061497;7538.3592394645975;7615.847683046419;21798.455038623844;21799.128034878428;21810.345689629336;21819.127234910426;21842.672359914613;8513.702020429255;8691.913080869237;8700.60847261862;8705.869411958825;8706.47761134334;7662.310392064741;7710.537367757953;7807.102183248886;7827.491213071132;7858.5677787722225;5683.090705487102;5795.391483894215;6006.099085137177;6015.187949626745;6116.969415152896;1710.9059001755022;1739.4868513788463;1741.7474466202584;1784.8036715961234;1793.390247315919;857.5283594023263;878.1218781218781;891.9821603567892;898.734873212404;898.9820203595891;8301.377396695272;8317.708880189164;8411.537365444838;8415.747527574182;8479.703210387606;739.2385842582149;739.5895278120587;755.4787196834167;761.6800943603699;764.7552783109352;5008.874778130503;5260.316158899319;5590.133529302964;5619.775208991677;5809.128630705428;21942.561148776935;22967.770322296896;23449.531009379716;23592.174273900673;23675.881620592132;22563.43591410228;22698.97854596547;23155.652665210037;23157.53684926292;23234.767652323597;11310.660680179608;11401.20191586581;11642.24325418845;11661.35862527569;11662.53349865996;8935.687250946186;9028.864567031369;9039.412438191497;9082.500462474627;9147.131022552847;19486.12312445915;19562.60874782468;20279.69580456265;20322.288719894732;20339.8983005084;20420.081096350405;20631.793682062988;20633.79366206379;20659;20768.79231207729;12342.13605047638;12342.81485777732;12379.071569632493;12406.131570789958;12413.193142445713;14371.20958347301;14403.495877644651;14518.128912265298;14539.854601454274;14553.345099470762;11592.1305902056;11791.705207369885;11796.587119451122;11999.76000479968;12009.39953002329;11431.657050288504;11508.59719909799;11556.364399958084;11618.0705543558;11832.053435724949;10734.355938643706;10758.8386174209;10784.946075269574;10887.836682449612;10934.070603998749;8080.676772929017;8091.757247282591;8130.02439707239;8169.142240064708;8305.252527272574;8249.092599813896;8278.958605206935;8320.791980200544;8426.873596895928;8426.915730842613 12:03:13 INFO - PID 20778 | |4;prototype.html;502.4954351795496;516.0736478021952;525.955293800027;527.2012900455808;534.4575256115044;6257.527072474781;6275.874482510353;6276.309605943343;6278.466330361919;6311.936880631192;6156.261248650157;6165.691715414234;6211.254649442062;6212.658303793301;6233.252009758824;4921.163402221631;4936.3829521309835;4950.183219768734;4958.479359667237;4965.981973695384;4651.767411629405;4809.455064963611;4823.20417131173;4858.708477491344;4952.108620448318;4675.438947326325;4738.502457241992;4757.833475828329;4770.785314660849;4772.308015337774;4733;4796.496367881357;4806.086843499741;4806.206975848998;4845.75771211438;4307.181635489247;4326.762028088454;4329.1558146161515;4345.521992580813;4348.391225228471;6096.11606317086;6096.634201947897;6115.2912257561875;6125.234345706786;6154.815355539341;5718.828435146952;5732.369439361667;5750.539956803445;5754.165645981351;5767.855803604902;6596.274409814964;6602;6608.438282745972;6612.603243805339;6627.1716035495565;4885.6335774817035;4887.120318342697;4894.755262236874;4898.093852637237;4914.901701965977;6703.229128650219;6752.2234942981695;6843.247242803337;6895.620740859201;6902.723891044352;4993.50064993505;5011.574016208663;5016.297718319438;5021.338690494044;5023.874403139951;5075.97462012695;5079.390473143172;5108.518529626441;5118.61610379223;5142.717150556755;5675.517581005578;5679.6876171810945;5681.857953551194;5683.516901063374;5699;6435.292117867031;6547.9017814732815;6557.573757705733;6557.967210163919;6562.868742625216;1761.348301128565;1775.6981313176532;1780.412463886914;1793.1751394358741;1799.6580649676519;1186.8783999120749;1237.2761934268553;1243.490169030693;1246.0841281657974;1262.9052821038274;6171.007061575222;6218.9116904542425;6225.252969643671;6270.770553165124;6322.629014119705;6710.83222919431;6746.561473504206;6754.223264324567;6779.35596118368;6801.0138529913875;6133.29467111279;6190;6196.256449226032;6228.968855155786;6238.469730072904;3511.525943997579;3530.8234588270484;3566.732495062881;3569;3614.1868079681863;7103.502754807114;7108.644567771591;7123.608201548861;7161.606111663908;7191.928080719231;6859.691313890887;6874.518783685194;6889.311068893071;6926.2034865990045;6985.196702379189;6578.111954886125;6983.580985140908;6997.580145191203;7109.75115870942;7210.60341681202;6523.9347606525225;6668.199356270475;6688.097106890507;6737.898931516129;6773.661316934232;6591.835204119935;6632.502562307943;6651.467882569286;6705.396514313735;6709.563878347892;7060.293970602898;7107.857842843011;7133.678984445816;7144.607046612278;7215.71137154508;5405.918911216414;5422.783088676409;5459.317585301837;5506.80726174598;5530.668159910419;6652.667366631746;6719.193696756421;6728.226253980855;6784.830379240361;6826.214985276558;6576.408123268738;6578.342165783383;6584.7036883341325;6586.209654841449;6632.867342653217;6364.681765911593;6464.612123272619;6480.675966201577;6584.407403333723;6650.534462587572;6537.1501704778075;6564.573302735307;6588.176477940257;6617.338266173344;6628.83427914306;6559.540832141704;6628.475450646282;6689.364510371702;6718.328167183243;6723.630200339028;6340.302566717565;6354.650494222862;6381.649009304533;6441.033844923299;6515.902261465987 12:03:13 INFO - PID 20778 | |5;yui.html;831.9251267385933;835.8495470815253;846.7713717296332;847.2459511035183;848.1730312944879;16865.15674216289;17264.395746148886;17328.740068898976;17426.215820288086;21658.89170554149;19712.507187320323;19952.50118747032;20352.592948141028;20371.898140509278;20387.796122038777;938.7183844846553;1052.3317693264794;1066.9359838409682;1067.151614466501;1068.1881769854888;1064.1858977881927;1076.445630500293;1080.3193987787683;1087.7335052912008;1090.2313868722572;1157.340316019869;1161.8780028097055;1162.2561560601223;1162.3026184289442;1163.6858048326947;1140.8231724082739;1156.3582211872408;1156.6645672754892;1156.9190156689035;1157.2535714464166;848.0925409811504;848.6647774129246;852.3735054734765;852.6205838401913;853.1298075962484;16550.917245413817;16840.157992100467;16865.494035178843;18063;18090.547736306566;19395.515112122168;19743.40769776909;19750.604987900304;19752;19772.20911163552;14055;14200.289985500684;14477.203753793538;14477.565673029825;14477.71044579113;3143.811371317728;3192.233863872677;3193.1378527797365;3196.2329041030216;3196.440622891008;134569;135742;144378;146229;146795;15300.311485983157;15300.923495382453;15686.68626627461;15701.214939252992;15740.68518629621;29689.40621187564;29745;29981.100566983027;30395.696043039286;30607;6969.372756451842;7138.464615153885;7740.225977402328;7932.286094251545;7932.722354717557;3857.517810273716;3926.155876486569;3932.390479475686;3943.2507823514015;3947;4994.200927851526;5116.462771409023;5144.125498665236;5155.278261043457;5167.354080739908;1097.2538673701958;1106.0598491282506;1129.265977114882;1132.3771925440974;1141.4920360439692;621.8476473264079;631.1668597451412;634.8920683483819;635.9523035772243;648.5913874259281;10499.632512862014;10581.477174612826;10592.046715795615;10655.360678359324;10672.466376681135;611.8409213604406;618.9783357582463;621.9378062193834;626.9153664255267;634.9746010159541;4779.163646361872;4851.296561998491;4901.044296362246;4978.551930326288;5035.244713293036;137943.31028344794;139532;142651;143546.282268588;148163;118890;119277.40361298138;120790;121844.39077804555;123093;108087;108292.45853770681;109045;110630.44684776686;113611.43194283976;9351.064893510867;9442.85835712451;9455.810883782147;9477;9489.715308540755;51990;52342.21486677779;52526;52709.7364513175;54170.187447187534;66176;66515;66745;67442.3255767436;69047.96428053483;14724.852751472348;14776.63058423505;14948.925255374088;14968.550943471713;15174.165420901514;15562.922185389001;18123;18760.53098672544;20148.496287592927;21671.891640541697;18492.81507184911;18552.072396379855;18635.627287453903;18639.347622833135;18750;18470.445886623424;18481.72277415867;18667.813321866608;18803.153858076144;18935.242590296235;16563.751543726612;16861;16919.91540042292;17007.48977530676;17271.56821079483;13465.394057267642;13795.724085518434;14027.789583156056;14128.78806817919;14162.079464834753;11992.64022079339;12018.017027190415;12245.877541224474;12331.69170770738;12578.748425031265 12:03:13 INFO - PID 20778 | __end_tp_report 12:03:13 INFO - PID 20778 | __start_cc_report 12:03:13 INFO - PID 20778 | _x_x_mozilla_cycle_collect,326 12:03:13 INFO - PID 20778 | __end_cc_report 12:03:13 INFO - PID 20778 | __startTimestamp1503082993241__endTimestamp 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | ------- Summary: start ------- 12:03:13 INFO - PID 20778 | Number of tests: 6 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#0] dojo.html Cycles:165 Average:6278.11 Median:6619.67 stddev:822.38 (12.4%) stddev-sans-first:795.71 12:03:13 INFO - PID 20778 | Values: 3509.8 3544.9 3551.5 3555.3 3581.2 6253.6 6326.7 6330.4 6392.6 6413.3 6146.0 6245.0 6247.6 6268.8 6416.9 5519.8 5549.4 5586.8 5621.8 5641.1 5466.7 5509.6 5563.4 5568.3 5572.4 5547.8 5550.1 5571.5 5612.1 5634.3 5544.1 5571.4 5614.7 5627.2 5639.5 5457.3 5463.2 5486.9 5497.3 5518.9 6146.8 6175.1 6220.0 6266.7 6281.8 6806.4 6810.7 6863.6 6864.5 6867.9 6777.4 6890.3 6913.0 6998.9 7003.3 6303.4 6312.9 6321.6 6323.7 6324.7 6891.2 6968.4 7003.1 7091.9 7150.1 6684.2 6729.6 6750.9 6766.5 6772.9 6811.4 6821.4 6886.3 6898.7 6910.4 6646.2 6744.6 6769.8 6770.7 6837.5 6805.9 6840.4 6840.5 6841.2 6882.8 4885.2 4954.2 4959.1 4960.1 4965.1 4371.8 4377.2 4404.1 4404.8 4419.6 6353.7 6431.2 6431.2 6438.1 6448.2 6744.0 6838.1 6861.1 6874.0 6880.1 6397.6 6426.2 6467.5 6477.4 6477.9 5506.2 5540.0 5566.4 5606.2 5609.7 7125.4 7178.6 7195.2 7257.8 7328.3 6851.2 6861.9 6870.4 6881.2 6886.2 7210.9 7293.1 7305.9 7308.2 7322.9 6758.2 6770.6 6837.3 6853.6 6861.0 6759.2 6773.2 6802.0 6875.8 6892.7 6621.2 6623.4 6646.0 6650.7 6702.4 6620.3 6620.6 6694.2 6700.1 6705.1 6619.7 6635.7 6688.2 6690.4 6700.6 6568.5 6599.1 6701.2 6764.5 6785.3 6305.1 6416.9 6425.2 6429.7 6530.2 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#1] ext.html Cycles:180 Average:41821.66 Median:39356.21 stddev:59244.92 (150.5%) stddev-sans-first:59331.27 12:03:13 INFO - PID 20778 | Values: 858.4 858.4 888.8 904.0 913.2 43724.8 44172.6 44461.8 44508.6 44629.3 41673.8 41836.6 41945.4 41992.2 42007.0 7005.7 7118.6 7140.8 7141.0 7142.6 6995.6 7055.5 7055.8 7060.3 7060.6 7622.4 7983.5 7985.5 7988.8 7991.9 7838.3 7872.3 7877.1 7898.8 7903.2 7631.7 7774.8 7778.1 7782.5 7791.6 40393.0 40738.2 40740.8 40812.2 40857.2 3463.8 3498.1 3510.2 3510.8 3510.9 31617.8 31626.0 31632.8 31698.8 31752.8 4387.6 4393.3 4412.2 4435.5 4451.1 200513.0 202796.0 204421.0 206504.0 219106.0 52960.2 53320.7 53365.5 53399.0 53408.2 54999.7 55101.0 55118.0 55125.4 55153.7 15716.6 15838.8 15854.5 15862.4 16023.0 12785.7 12793.3 12797.2 12814.2 12828.4 15009.5 15012.2 15063.8 15106.8 15206.4 6117.8 6161.1 6173.2 6257.5 6260.4 1099.9 1110.3 1110.3 1125.3 1126.0 23928.0 24181.6 24411.9 24430.6 24432.6 1214.6 1222.8 1225.4 1230.8 1232.2 12839.0 12864.9 12866.4 12928.9 12947.7 249098.0 250532.0 250666.0 251514.0 251849.0 55777.4 56269.2 56281.0 56502.4 56582.7 1543.7 1557.4 1579.6 1591.6 1597.0 24428.3 29837.9 30379.4 30647.0 31064.8 54721.0 54842.7 54992.5 55071.0 55244.0 223092.0 223988.0 225193.0 225301.0 225799.0 34933.5 42464.0 43106.4 43206.4 43365.0 51645.0 51953.2 52342.0 52347.0 52823.2 37077.6 37101.0 37713.8 38046.6 38319.4 37663.8 37917.4 37950.0 38109.0 38271.8 44780.0 44824.3 44879.0 44968.0 45068.8 37342.3 37349.3 37441.4 37465.0 37587.0 25907.2 26229.3 26809.1 27393.8 28137.0 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#2] jquery.html Cycles:180 Average:40794.40 Median:23465.09 stddev:104123.98 (443.7%) stddev-sans-first:104372.28 12:03:13 INFO - PID 20778 | Values: 571.4 577.3 577.3 578.1 585.6 23368.8 23718.5 24142.0 24167.2 24189.4 26483.9 26992.9 27076.2 27076.9 27093.0 6415.6 6549.5 6565.2 6570.6 6572.2 6223.9 6401.6 6446.7 6473.3 6495.4 6431.5 6450.1 6452.3 6455.7 6455.9 6441.3 6453.2 6454.7 6461.6 6465.5 5982.9 5985.5 5998.0 6000.7 6001.6 30059.8 30552.7 30610.8 30699.8 30982.0 2252.8 2289.9 2290.0 2290.1 2290.7 20083.1 20644.9 20651.1 20654.2 20675.3 2410.6 2464.8 2507.7 2511.3 2512.9 150415.2 154134.0 154670.2 155386.0 158986.0 15135.5 15273.5 15339.8 15787.9 15989.4 23438.7 23452.4 23477.8 24015.6 24162.4 10303.9 10309.5 10493.6 10585.3 10654.6 9553.1 9562.8 9591.4 9678.5 9718.9 9789.7 9947.6 10251.9 10257.9 10365.6 2907.7 2923.9 2924.9 2936.5 3037.5 1047.9 1066.5 1073.5 1078.3 1078.6 26025.3 26753.7 26778.2 26987.2 27121.5 1110.9 1113.7 1141.3 1146.4 1153.6 11685.4 11842.6 11901.0 11943.6 11998.7 602578.0 606868.0 610706.0 641662.0 645246.0 137761.0 138550.0 139518.0 140262.0 141706.0 1341.5 1343.8 1369.2 1385.3 1386.4 18813.5 18971.9 19371.9 19377.5 19713.3 51949.5 64003.0 64788.4 65795.3 65804.0 78105.0 78420.2 78705.0 78829.6 79058.6 14941.8 15036.3 15082.5 15085.2 15116.0 24268.0 24378.3 24654.1 24686.8 24834.3 19188.0 19341.0 19377.3 19852.5 20459.6 17112.7 17809.2 17889.4 18026.5 19055.0 19015.4 19197.8 19410.6 19438.0 21042.4 21250.9 21878.1 22214.0 22226.8 22569.8 19660.5 19762.6 19872.3 20204.0 20318.5 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#3] mootools.html Cycles:180 Average:10058.37 Median:2544.74 stddev:7386.52 (290.3%) stddev-sans-first:7378.64 12:03:13 INFO - PID 20778 | Values: 1406.3 1453.8 1467.7 1473.6 1480.0 15729.1 15931.6 16297.8 16313.8 16329.2 16327.8 16557.9 16572.6 16666.3 16687.2 2645.9 2672.2 2697.6 2699.5 2703.2 2754.6 2792.1 2796.8 2801.1 2802.8 2653.5 2670.4 2686.1 2700.4 2701.2 2520.9 2543.0 2546.5 2546.5 2552.2 2512.1 2519.8 2530.9 2535.9 2569.5 15774.9 15903.0 15918.8 15928.4 15939.7 8293.5 8564.4 8576.5 8580.1 8581.9 5024.5 5259.7 5339.9 5384.1 5513.3 1757.4 1761.7 1782.2 1798.8 1824.5 28687.1 29521.6 29654.3 29671.7 29674.0 7369.5 7452.4 7483.3 7538.4 7615.8 21798.5 21799.1 21810.3 21819.1 21842.7 8513.7 8691.9 8700.6 8705.9 8706.5 7662.3 7710.5 7807.1 7827.5 7858.6 5683.1 5795.4 6006.1 6015.2 6117.0 1710.9 1739.5 1741.7 1784.8 1793.4 857.5 878.1 892.0 898.7 899.0 8301.4 8317.7 8411.5 8415.7 8479.7 739.2 739.6 755.5 761.7 764.8 5008.9 5260.3 5590.1 5619.8 5809.1 21942.6 22967.8 23449.5 23592.2 23675.9 22563.4 22699.0 23155.7 23157.5 23234.8 11310.7 11401.2 11642.2 11661.4 11662.5 8935.7 9028.9 9039.4 9082.5 9147.1 19486.1 19562.6 20279.7 20322.3 20339.9 20420.1 20631.8 20633.8 20659.0 20768.8 12342.1 12342.8 12379.1 12406.1 12413.2 14371.2 14403.5 14518.1 14539.9 14553.3 11592.1 11791.7 11796.6 11999.8 12009.4 11431.7 11508.6 11556.4 11618.1 11832.1 10734.4 10758.8 10784.9 10887.8 10934.1 8080.7 8091.8 8130.0 8169.1 8305.3 8249.1 8279.0 8320.8 8426.9 8426.9 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#4] prototype.html Cycles:180 Average:5594.03 Median:6231.11 stddev:1602.21 (25.7%) stddev-sans-first:1560.46 12:03:13 INFO - PID 20778 | Values: 502.5 516.1 526.0 527.2 534.5 6257.5 6275.9 6276.3 6278.5 6311.9 6156.3 6165.7 6211.3 6212.7 6233.3 4921.2 4936.4 4950.2 4958.5 4966.0 4651.8 4809.5 4823.2 4858.7 4952.1 4675.4 4738.5 4757.8 4770.8 4772.3 4733.0 4796.5 4806.1 4806.2 4845.8 4307.2 4326.8 4329.2 4345.5 4348.4 6096.1 6096.6 6115.3 6125.2 6154.8 5718.8 5732.4 5750.5 5754.2 5767.9 6596.3 6602.0 6608.4 6612.6 6627.2 4885.6 4887.1 4894.8 4898.1 4914.9 6703.2 6752.2 6843.2 6895.6 6902.7 4993.5 5011.6 5016.3 5021.3 5023.9 5076.0 5079.4 5108.5 5118.6 5142.7 5675.5 5679.7 5681.9 5683.5 5699.0 6435.3 6547.9 6557.6 6558.0 6562.9 1761.3 1775.7 1780.4 1793.2 1799.7 1186.9 1237.3 1243.5 1246.1 1262.9 6171.0 6218.9 6225.3 6270.8 6322.6 6710.8 6746.6 6754.2 6779.4 6801.0 6133.3 6190.0 6196.3 6229.0 6238.5 3511.5 3530.8 3566.7 3569.0 3614.2 7103.5 7108.6 7123.6 7161.6 7191.9 6859.7 6874.5 6889.3 6926.2 6985.2 6578.1 6983.6 6997.6 7109.8 7210.6 6523.9 6668.2 6688.1 6737.9 6773.7 6591.8 6632.5 6651.5 6705.4 6709.6 7060.3 7107.9 7133.7 7144.6 7215.7 5405.9 5422.8 5459.3 5506.8 5530.7 6652.7 6719.2 6728.2 6784.8 6826.2 6576.4 6578.3 6584.7 6586.2 6632.9 6364.7 6464.6 6480.7 6584.4 6650.5 6537.2 6564.6 6588.2 6617.3 6628.8 6559.5 6628.5 6689.4 6718.3 6723.6 6340.3 6354.7 6381.6 6441.0 6515.9 12:03:13 INFO - PID 20778 | 12:03:13 INFO - PID 20778 | [#5] yui.html Cycles:180 Average:26030.67 Median:18476.08 stddev:39179.30 (212.1%) stddev-sans-first:39243.52 12:03:13 INFO - PID 20778 | Values: 831.9 835.8 846.8 847.2 848.2 16865.2 17264.4 17328.7 17426.2 21658.9 19712.5 19952.5 20352.6 20371.9 20387.8 938.7 1052.3 1066.9 1067.2 1068.2 1064.2 1076.4 1080.3 1087.7 1090.2 1157.3 1161.9 1162.3 1162.3 1163.7 1140.8 1156.4 1156.7 1156.9 1157.3 848.1 848.7 852.4 852.6 853.1 16550.9 16840.2 16865.5 18063.0 18090.5 19395.5 19743.4 19750.6 19752.0 19772.2 14055.0 14200.3 14477.2 14477.6 14477.7 3143.8 3192.2 3193.1 3196.2 3196.4 134569.0 135742.0 144378.0 146229.0 146795.0 15300.3 15300.9 15686.7 15701.2 15740.7 29689.4 29745.0 29981.1 30395.7 30607.0 6969.4 7138.5 7740.2 7932.3 7932.7 3857.5 3926.2 3932.4 3943.3 3947.0 4994.2 5116.5 5144.1 5155.3 5167.4 1097.3 1106.1 1129.3 1132.4 1141.5 621.8 631.2 634.9 636.0 648.6 10499.6 10581.5 10592.0 10655.4 10672.5 611.8 619.0 621.9 626.9 635.0 4779.2 4851.3 4901.0 4978.6 5035.2 137943.3 139532.0 142651.0 143546.3 148163.0 118890.0 119277.4 120790.0 121844.4 123093.0 108087.0 108292.5 109045.0 110630.4 113611.4 9351.1 9442.9 9455.8 9477.0 9489.7 51990.0 52342.2 52526.0 52709.7 54170.2 66176.0 66515.0 66745.0 67442.3 69048.0 14724.9 14776.6 14948.9 14968.6 15174.2 15562.9 18123.0 18760.5 20148.5 21671.9 18492.8 18552.1 18635.6 18639.3 18750.0 18470.4 18481.7 18667.8 18803.2 18935.2 16563.8 16861.0 16919.9 17007.5 17271.6 13465.4 13795.7 14027.8 14128.8 14162.1 11992.6 12018.0 12245.9 12331.7 12578.7 12:03:13 INFO - PID 20778 | -------- Summary: end -------- 12:03:13 INFO - PID 20778 | 12:03:13 INFO - TEST-INFO | 20778: exit 0 12:03:13 INFO - TEST-OK | dromaeo_css | took 1109140ms 12:03:13 INFO - TEST-START | kraken 12:03:13 INFO - Initialising browser for kraken test... 12:03:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36829/getInfo.html -profile /tmp/tmpEmhZlI/profile 12:03:13 INFO - TEST-INFO | started process 21150 (/builds/slave/test/build/application/firefox/firefox http://localhost:36829/getInfo.html) 12:03:19 INFO - TEST-INFO | 21150: exit 0 12:03:19 INFO - Browser initialized. 12:03:19 INFO - Running cycle 1/1 for kraken test... 12:03:19 INFO - TEST-INFO | started process 21323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEmhZlI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:20 INFO - PID 21323 | 12:03:20 INFO - PID 21323 | (/builds/slave/test/build/application/firefox/firefox:21370): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:03:20 INFO - PID 21323 | 12:03:30 INFO - PID 21323 | RSS: Main: 157175808 12:03:30 INFO - PID 21323 | 12:03:33 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-beat-detection) 12:03:34 INFO - PID 21323 | RSS: Main: 163352576 12:03:34 INFO - PID 21323 | 12:03:36 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-dft) 12:03:37 INFO - PID 21323 | RSS: Main: 167723008 12:03:37 INFO - PID 21323 | 12:03:40 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-fft) 12:03:40 INFO - PID 21323 | RSS: Main: 160751616 12:03:40 INFO - PID 21323 | 12:03:42 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36829/tests/kraken/driver.html?testName=audio-oscillator) 12:03:43 INFO - PID 21323 | RSS: Main: 161533952 12:03:43 INFO - PID 21323 | 12:03:45 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:03:46 INFO - PID 21323 | RSS: Main: 161337344 12:03:46 INFO - PID 21323 | 12:03:49 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-darkroom) 12:03:49 INFO - PID 21323 | RSS: Main: 161685504 12:03:49 INFO - PID 21323 | 12:03:53 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36829/tests/kraken/driver.html?testName=imaging-desaturate) 12:03:53 INFO - PID 21323 | RSS: Main: 164999168 12:03:53 INFO - PID 21323 | 12:03:56 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36829/tests/kraken/driver.html?testName=json-parse-financial) 12:03:57 INFO - PID 21323 | RSS: Main: 163946496 12:03:57 INFO - PID 21323 | 12:03:58 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36829/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:03:59 INFO - PID 21323 | RSS: Main: 163557376 12:03:59 INFO - PID 21323 | 12:04:01 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:01 INFO - PID 21323 | RSS: Main: 163979264 12:04:01 INFO - PID 21323 | 12:04:03 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:04 INFO - PID 21323 | RSS: Main: 163733504 12:04:04 INFO - PID 21323 | 12:04:07 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:07 INFO - PID 21323 | RSS: Main: 163655680 12:04:07 INFO - PID 21323 | 12:04:10 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:11 INFO - PID 21323 | RSS: Main: 164093952 12:04:11 INFO - PID 21323 | 12:04:12 INFO - PID 21323 | Cycle 1(1): loaded http://localhost:36829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36829/tests/kraken/driver.html?testName=ai-astar) 12:04:13 INFO - PID 21323 | RSS: Main: 166125568 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | __start_tp_report 12:04:13 INFO - PID 21323 | _x_x_mozilla_page_load 12:04:13 INFO - PID 21323 | _x_x_mozilla_page_load_details 12:04:13 INFO - PID 21323 | |i|pagename|runs| 12:04:13 INFO - PID 21323 | |0;ai-astar;98;107;102;108;106;113;109;99;105;110 12:04:13 INFO - PID 21323 | |1;audio-beat-detection;148;114;140;170;116;142;144;115;170;112 12:04:13 INFO - PID 21323 | |2;audio-dft;163;162;161;162;163;160;161;162;170;165 12:04:13 INFO - PID 21323 | |3;audio-fft;75;73;75;147;74;75;73;89;103;73 12:04:13 INFO - PID 21323 | |4;audio-oscillator;79;78;130;78;78;79;121;78;78;124 12:04:13 INFO - PID 21323 | |5;imaging-gaussian-blur;113;115;114;113;115;113;114;113;114;113 12:04:13 INFO - PID 21323 | |6;imaging-darkroom;147;149;153;147;147;147;147;147;148;149 12:04:13 INFO - PID 21323 | |7;imaging-desaturate;95;95;95;95;93;94;95;93;94;94 12:04:13 INFO - PID 21323 | |8;json-parse-financial;46;46;52;54;46;55;47;46;48;47 12:04:13 INFO - PID 21323 | |9;json-stringify-tinderbox;54;54;55;55;59;54;55;54;55;54 12:04:13 INFO - PID 21323 | |10;stanford-crypto-aes;73;72;73;73;74;72;72;73;73;73 12:04:13 INFO - PID 21323 | |11;stanford-crypto-ccm;124;113;123;127;124;113;115;115;116;149 12:04:13 INFO - PID 21323 | |12;stanford-crypto-pbkdf2;173;170;164;169;161;169;168;177;160;164 12:04:13 INFO - PID 21323 | |13;stanford-crypto-sha256-iterative;64;66;61;63;62;61;62;60;61;65 12:04:13 INFO - PID 21323 | __end_tp_report 12:04:13 INFO - PID 21323 | __start_cc_report 12:04:13 INFO - PID 21323 | _x_x_mozilla_cycle_collect,861 12:04:13 INFO - PID 21323 | __end_cc_report 12:04:13 INFO - PID 21323 | __startTimestamp1503083053148__endTimestamp 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | ------- Summary: start ------- 12:04:13 INFO - PID 21323 | Number of tests: 14 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#0] ai-astar Cycles:10 Average:105.70 Median:109.50 stddev:4.81 (4.4%) stddev-sans-first:4.22 12:04:13 INFO - PID 21323 | Values: 98.0 107.0 102.0 108.0 106.0 113.0 109.0 99.0 105.0 110.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:143.00 stddev:22.26 (15.6%) stddev-sans-first:23.26 12:04:13 INFO - PID 21323 | Values: 148.0 114.0 140.0 170.0 116.0 142.0 144.0 115.0 170.0 112.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.85 (1.8%) stddev-sans-first:3.02 12:04:13 INFO - PID 21323 | Values: 163.0 162.0 161.0 162.0 163.0 160.0 161.0 162.0 170.0 165.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.50 stddev:23.65 (31.7%) stddev-sans-first:24.76 12:04:13 INFO - PID 21323 | Values: 75.0 73.0 75.0 147.0 74.0 75.0 73.0 89.0 103.0 73.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:78.00 stddev:22.67 (29.1%) stddev-sans-first:23.53 12:04:13 INFO - PID 21323 | Values: 79.0 78.0 130.0 78.0 78.0 79.0 121.0 78.0 78.0 124.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 12:04:13 INFO - PID 21323 | Values: 113.0 115.0 114.0 113.0 115.0 113.0 114.0 113.0 114.0 113.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:147.50 stddev:1.91 (1.3%) stddev-sans-first:1.99 12:04:13 INFO - PID 21323 | Values: 147.0 149.0 153.0 147.0 147.0 147.0 147.0 147.0 148.0 149.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 12:04:13 INFO - PID 21323 | Values: 95.0 95.0 95.0 95.0 93.0 94.0 95.0 93.0 94.0 94.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:47.50 stddev:3.56 (7.5%) stddev-sans-first:3.64 12:04:13 INFO - PID 21323 | Values: 46.0 46.0 52.0 54.0 46.0 55.0 47.0 46.0 48.0 47.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.58 12:04:13 INFO - PID 21323 | Values: 54.0 54.0 55.0 55.0 59.0 54.0 55.0 54.0 55.0 54.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 12:04:13 INFO - PID 21323 | Values: 73.0 72.0 73.0 73.0 74.0 72.0 72.0 73.0 73.0 73.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.50 stddev:10.85 (8.8%) stddev-sans-first:11.48 12:04:13 INFO - PID 21323 | Values: 124.0 113.0 123.0 127.0 124.0 113.0 115.0 115.0 116.0 149.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:169.00 stddev:5.32 (3.1%) stddev-sans-first:5.25 12:04:13 INFO - PID 21323 | Values: 173.0 170.0 164.0 169.0 161.0 169.0 168.0 177.0 160.0 164.0 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:2.00 12:04:13 INFO - PID 21323 | Values: 64.0 66.0 61.0 63.0 62.0 61.0 62.0 60.0 61.0 65.0 12:04:13 INFO - PID 21323 | -------- Summary: end -------- 12:04:13 INFO - PID 21323 | 12:04:13 INFO - PID 21323 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:04:13 INFO - TEST-INFO | 21323: exit 0 12:04:13 INFO - TEST-OK | kraken | took 59959ms 12:04:13 INFO - SUITE-END | took 1169s 12:04:14 INFO - Completed test suite (00:19:29) 12:04:14 INFO - javascript benchmark 12:04:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8860.689484341703, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3509.824508774562, 3544.9113772155697, 3551.4672799080136, 3555.2711694102713, 3581.1763294442276, 6253.624782513041, 6326.715297811598, 6330.43026127649, 6392.584482008666, 6413.29453760086, 6146.047362658784, 6244.968775156118, 6247.562670613059, 6268.780592679257, 6416.903746443807, 5519.806806761764, 5549.38956714762, 5586.832395028136, 5621.831345059655, 5641.069223578104, 5466.726663666821, 5509.586780991422, 5563.36021357543, 5568.303962004749, 5572.359178694462, 5547.750351234184, 5550.139728342114, 5571.498565129137, 5612.130119831432, 5634.295713035871, 5544.085225937715, 5571.387147413781, 5614.663120212759, 5627.184058311563, 5639.464250896158, 5457.345118585795, 5463.235147079372, 5486.945130548684, 5497.312835895513, 5518.91721624176, 6146.815595532141, 6175.07373893915, 6219.968900155471, 6266.686665666744, 6281.811545653638, 6806.353396427331, 6810.659467026629, 6863.588184708883, 6864.450843932474, 6867.896981545281, 6777.390034896834, 6890.31096890312, 6913.0, 6998.930010699879, 7003.264657211022, 6303.369663033705, 6312.905306420362, 6321.589096708699, 6323.683815809191, 6324.71538780756, 6891.207511136284, 6968.407685346701, 7003.054587630605, 7091.9290807091265, 7150.141982962078, 6684.1978962523835, 6729.596224226562, 6750.864982700318, 6766.458683305324, 6772.8984065239065, 6811.352921472452, 6821.386075253251, 6886.2769409212315, 6898.689558969859, 6910.44716422685, 6646.2356828965285, 6744.595324280559, 6769.796906092825, 6770.729170833111, 6837.453003759687, 6805.931940680629, 6840.350166734252, 6840.521163518605, 6841.247462779091, 6882.7591034313555, 4885.218365061644, 4954.20732682769, 4959.107360675113, 4960.107180707435, 4965.0566392385335, 4371.781410929504, 4377.1683380157665, 4404.075144219686, 4404.801783919731, 4419.602235798793, 6353.68231588428, 6431.163948686734, 6431.228252609623, 6438.066480360415, 6448.226212854487, 6744.0, 6838.076859623887, 6861.142357205349, 6873.965630171817, 6880.139982502187, 6397.616143031433, 6426.164598602245, 6467.547271690936, 6477.449416799531, 6477.870442591122, 5506.201600767947, 5539.972300138554, 5566.387697353288, 5606.159076138611, 5609.663420194802, 7125.394341480928, 7178.641067946582, 7195.208527062019, 7257.818554536073, 7328.267173282629, 6851.177858656993, 6861.931380686129, 6870.381665649916, 6881.174259088742, 6886.208086070166, 7210.855782884418, 7293.0519032525435, 7305.926940730737, 7308.232635573401, 7322.926770732224, 6758.155230596176, 6770.627615481196, 6837.3162683731225, 6853.588784672936, 6860.965695171692, 6759.155105611799, 6773.187217533928, 6801.965990170018, 6875.828104297432, 6892.724291028303, 6621.238557565942, 6623.363645448109, 6645.966770166118, 6650.700718467778, 6702.36327548882, 6620.271770105188, 6620.569662971891, 6694.230163531256, 6700.095487109178, 6705.09481220029, 6619.66901654925, 6635.668216589054, 6688.230853451915, 6690.431313338421, 6700.564463309869, 6568.47452203813, 6599.0761293418, 6701.1623547056615, 6764.458843292623, 6785.287544807724, 6305.117283580211, 6416.903746443713, 6425.1968503937005, 6429.7106630200815, 6530.249021362414], "value": 6214.6818771819935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.3519442820669, 858.4119877883646, 888.7822483491543, 904.0462312260562, 913.1872633356312, 43724.78137609312, 44172.55827441725, 44461.7776911115, 44508.554914450884, 44629.33056004154, 41673.79163104188, 41836.58163418365, 41945.37081943766, 41992.16015679685, 42007.0, 7005.684744186498, 7118.572885626879, 7140.785776426689, 7141.0, 7142.642867856613, 6995.580265184105, 7055.541389809671, 7055.753048643299, 7060.29397060295, 7060.611666358348, 7622.428317876153, 7983.520988740665, 7985.4809437386675, 7988.800279993017, 7991.920080799205, 7838.294553490185, 7872.291493765589, 7877.133515313311, 7898.802529936769, 7903.1701671324545, 7631.732889348847, 7774.844503109963, 7778.0666320041955, 7782.49413788102, 7791.571463569501, 40393.0, 40738.18523629511, 40740.79629601863, 40812.183756325, 40857.182856343, 3463.7748546344405, 3498.142954976022, 3510.2452972611013, 3510.7542472026967, 3510.859565617372, 31617.84191079053, 31626.0, 31632.841835790903, 31698.841505792323, 31752.841235793905, 4387.605115539584, 4393.275109606911, 4412.161689279027, 4435.467743870724, 4451.132029254297, 200513.0, 202796.0, 204421.0, 206504.0, 219106.0, 52960.20559691608, 53320.73339633277, 53365.46634533605, 53399.0, 53408.198877016875, 54999.72500137474, 55101.0, 55118.0, 55125.44874551283, 55153.72423137858, 15716.607084822743, 15838.76241856373, 15854.524364269091, 15862.365505379887, 16023.038617682976, 12785.680357991125, 12793.296368699625, 12797.168184068007, 12814.167079139826, 12828.35858207086, 15009.549713508612, 15012.174330411714, 15063.774043389358, 15106.848931510764, 15206.391744330103, 6117.816465506042, 6161.137440758297, 6173.166622505994, 6257.530685198628, 6260.40526150015, 1099.8845121262311, 1110.2616759854768, 1110.294962698676, 1125.2517076144436, 1125.9549618015187, 23928.0, 24181.637275440884, 24411.87794061054, 24430.633540496907, 24432.633510497002, 1214.5809695654984, 1222.8288039674453, 1225.4301749686438, 1230.7661544306732, 1232.2052276281747, 12839.03707221962, 12864.93567532175, 12866.421011054525, 12928.870711292766, 12947.741045179233, 249098.0, 250532.0, 250666.0, 251514.0, 251849.0, 55777.44222557804, 56269.155962660596, 56281.0, 56502.43497565054, 56582.71708641513, 1543.6603947131614, 1557.431537488831, 1579.6165640347897, 1591.610055536401, 1597.0, 24428.26715198547, 29837.850810745807, 30379.392412152076, 30647.0, 31064.844675776476, 54721.0, 54842.725786370815, 54992.45007549873, 55071.0, 55244.0, 223092.0, 223988.0, 225193.0, 225301.0, 225799.0, 34933.47599786056, 42464.0, 43106.353404698326, 43206.35190472208, 43365.0, 51645.0, 51953.22070168875, 52342.0, 52347.0, 52823.20765188602, 37077.6292237085, 37101.0, 37713.81143094267, 38046.61953380542, 38319.42520862134, 37663.81168094142, 37917.431238530895, 37950.0, 38109.0, 38271.80864095662, 44780.0, 44824.32763508485, 44879.0, 44968.0, 45068.77465612651, 37342.253154937294, 37349.25301494009, 37441.43837842489, 37465.0, 37587.0, 25907.22278331653, 26229.34426639349, 26809.061682841006, 27393.84970728312, 28137.015204467745], "value": 18528.26840676005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3543695623949, 577.2841676321361, 577.3101144132761, 578.1270281874368, 585.5959388022266, 23368.766312336873, 23718.5256294874, 24142.0, 24167.15414960479, 24189.39526511838, 26483.86758066207, 26992.865035674793, 27076.187714368552, 27076.864615676943, 27093.0, 6415.550911436213, 6549.508786840982, 6565.212174539062, 6570.605763654172, 6572.21133463985, 6223.906641400383, 6401.615903045809, 6446.742130314805, 6473.28793832678, 6495.447886929616, 6431.4533264672555, 6450.129232553616, 6452.257990331102, 6455.677216139197, 6455.9354406455805, 6441.259255185667, 6453.193350831146, 6454.741810327558, 6461.6446095464735, 6465.4827613790785, 5982.880342393128, 5985.4912332451795, 5998.0, 6000.699965001776, 6001.639901605918, 30059.849700751576, 30552.694473055206, 30610.84694576513, 30699.846500767355, 30982.0, 2252.8310376721647, 2289.8740569268684, 2290.0496294037953, 2290.141197051106, 2290.6678531612824, 20083.096260668306, 20644.896775516176, 20651.070701818455, 20654.17383304681, 20675.276365327292, 2410.626352915301, 2464.8397854139425, 2507.7366876478072, 2511.2842839790574, 2512.937176570582, 150415.24792376076, 154134.0, 154670.22664886716, 155386.0, 158986.0, 15135.470258540898, 15273.541793746206, 15339.846601533842, 15787.921060394854, 15989.44036958724, 23438.710870901923, 23452.413689657555, 23477.765222347556, 24015.63976540353, 24162.395940101287, 10303.896961030443, 10309.536070876678, 10493.632722854663, 10585.259031867849, 10654.62708805188, 9553.14021738033, 9562.808743825224, 9591.424514529012, 9678.516074196263, 9718.854217186748, 9789.657361992438, 9947.602095916081, 10251.897481025244, 10257.871349238405, 10365.63720269787, 2907.7383035526905, 2923.9444780204735, 2924.941501169965, 2936.471435141695, 3037.529182976642, 1047.8847326794046, 1066.5360568152723, 1073.5061871539024, 1078.2613909472036, 1078.6440474643348, 26025.349366265997, 26753.732462675125, 26778.196654100408, 26987.190384288504, 27121.457570848474, 1110.8555887734542, 1113.7494063835572, 1141.2638847943197, 1146.4095990564865, 1153.5904753812445, 11685.357305348118, 11842.585509507126, 11901.0, 11943.58197463102, 11998.700032499257, 602578.0, 606868.0, 610706.0, 641662.0, 645246.0, 137761.0, 138550.0, 139518.0, 140262.0, 141706.0, 1341.4567100324384, 1343.8387393512842, 1369.205860600849, 1385.2727318157847, 1386.383059538516, 18813.529661758566, 18971.921556097328, 19371.903140484206, 19377.51556211106, 19713.310034148737, 51949.480505194464, 64003.0, 64788.35211647823, 65795.34204658083, 65804.0, 78105.0, 78420.21579784129, 78705.0, 78829.60585197038, 79058.6047069761, 14941.77587336169, 15036.323365448363, 15082.54752357431, 15085.24573771329, 15116.0, 24268.0, 24378.26865194047, 24654.13710520195, 24686.753132468446, 24834.25497235086, 19188.0, 19341.0, 19377.321793737152, 19852.50368740793, 20459.59080818405, 17112.743308850128, 17809.198586063398, 17889.37387191442, 18026.549336266697, 19055.047247637838, 19015.42953711391, 19197.8080219196, 19410.611787764446, 19438.0, 21042.368728938156, 21250.893745531794, 21878.12487500482, 22214.0, 22226.777732223116, 22569.774302257425, 19660.50848728793, 19762.60474790525, 19872.304469343504, 20204.0, 20318.492037699176], "value": 12966.57811520749, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.3319923036559, 1453.7673972164448, 1467.662437639343, 1473.6389584551773, 1479.9704005919875, 15729.134897580643, 15931.601709957256, 16297.83702162978, 16313.755293670605, 16329.18354082297, 16327.83672163278, 16557.917210413932, 16572.585685357873, 16666.250018749157, 16687.165641717897, 2645.9470810583825, 2672.184983580007, 2697.568389057751, 2699.487097451488, 2703.175531462903, 2754.559270516718, 2792.1483947396036, 2796.846173460459, 2801.145650576573, 2802.7757779377703, 2653.548896687568, 2670.4258584404347, 2686.086730511626, 2700.351915540276, 2701.18964310707, 2520.9243722688257, 2542.9618555721677, 2546.5161619292276, 2546.541622507957, 2552.22157242042, 2512.057978258153, 2519.848809071462, 2530.911418100376, 2535.9492810143693, 2569.498947705198, 15774.921125394414, 15903.045817251003, 15918.840811591852, 15928.362865485367, 15939.681206375808, 8293.460925039853, 8564.400491965565, 8576.528290943996, 8580.099089595627, 8581.914180858237, 5024.497550244946, 5259.737013149327, 5339.866503337409, 5384.0847056000575, 5513.26332205354, 1757.428835628413, 1761.7357396390644, 1782.2336395349994, 1798.8201179882037, 1824.4800231933968, 28687.13938581846, 29521.557176642367, 29654.258643534085, 29671.703282967326, 29674.0, 7369.520981136209, 7452.366548843301, 7483.32650061497, 7538.3592394645975, 7615.847683046419, 21798.455038623844, 21799.128034878428, 21810.345689629336, 21819.127234910426, 21842.672359914613, 8513.702020429255, 8691.913080869237, 8700.60847261862, 8705.869411958825, 8706.47761134334, 7662.310392064741, 7710.537367757953, 7807.102183248886, 7827.491213071132, 7858.5677787722225, 5683.090705487102, 5795.391483894215, 6006.099085137177, 6015.187949626745, 6116.969415152896, 1710.9059001755022, 1739.4868513788463, 1741.7474466202584, 1784.8036715961234, 1793.390247315919, 857.5283594023263, 878.1218781218781, 891.9821603567892, 898.734873212404, 898.9820203595891, 8301.377396695272, 8317.708880189164, 8411.537365444838, 8415.747527574182, 8479.703210387606, 739.2385842582149, 739.5895278120587, 755.4787196834167, 761.6800943603699, 764.7552783109352, 5008.874778130503, 5260.316158899319, 5590.133529302964, 5619.775208991677, 5809.128630705428, 21942.561148776935, 22967.770322296896, 23449.531009379716, 23592.174273900673, 23675.881620592132, 22563.43591410228, 22698.97854596547, 23155.652665210037, 23157.53684926292, 23234.767652323597, 11310.660680179608, 11401.20191586581, 11642.24325418845, 11661.35862527569, 11662.53349865996, 8935.687250946186, 9028.864567031369, 9039.412438191497, 9082.500462474627, 9147.131022552847, 19486.12312445915, 19562.60874782468, 20279.69580456265, 20322.288719894732, 20339.8983005084, 20420.081096350405, 20631.793682062988, 20633.79366206379, 20659.0, 20768.79231207729, 12342.13605047638, 12342.81485777732, 12379.071569632493, 12406.131570789958, 12413.193142445713, 14371.20958347301, 14403.495877644651, 14518.128912265298, 14539.854601454274, 14553.345099470762, 11592.1305902056, 11791.705207369885, 11796.587119451122, 11999.76000479968, 12009.39953002329, 11431.657050288504, 11508.59719909799, 11556.364399958084, 11618.0705543558, 11832.053435724949, 10734.355938643706, 10758.8386174209, 10784.946075269574, 10887.836682449612, 10934.070603998749, 8080.676772929017, 8091.757247282591, 8130.02439707239, 8169.142240064708, 8305.252527272574, 8249.092599813896, 8278.958605206935, 8320.791980200544, 8426.873596895928, 8426.915730842613], "value": 7006.587259711441, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4954351795496, 516.0736478021952, 525.955293800027, 527.2012900455808, 534.4575256115044, 6257.527072474781, 6275.874482510353, 6276.309605943343, 6278.466330361919, 6311.936880631192, 6156.261248650157, 6165.691715414234, 6211.254649442062, 6212.658303793301, 6233.252009758824, 4921.163402221631, 4936.3829521309835, 4950.183219768734, 4958.479359667237, 4965.981973695384, 4651.767411629405, 4809.455064963611, 4823.20417131173, 4858.708477491344, 4952.108620448318, 4675.438947326325, 4738.502457241992, 4757.833475828329, 4770.785314660849, 4772.308015337774, 4733.0, 4796.496367881357, 4806.086843499741, 4806.206975848998, 4845.75771211438, 4307.181635489247, 4326.762028088454, 4329.1558146161515, 4345.521992580813, 4348.391225228471, 6096.11606317086, 6096.634201947897, 6115.2912257561875, 6125.234345706786, 6154.815355539341, 5718.828435146952, 5732.369439361667, 5750.539956803445, 5754.165645981351, 5767.855803604902, 6596.274409814964, 6602.0, 6608.438282745972, 6612.603243805339, 6627.1716035495565, 4885.6335774817035, 4887.120318342697, 4894.755262236874, 4898.093852637237, 4914.901701965977, 6703.229128650219, 6752.2234942981695, 6843.247242803337, 6895.620740859201, 6902.723891044352, 4993.50064993505, 5011.574016208663, 5016.297718319438, 5021.338690494044, 5023.874403139951, 5075.97462012695, 5079.390473143172, 5108.518529626441, 5118.61610379223, 5142.717150556755, 5675.517581005578, 5679.6876171810945, 5681.857953551194, 5683.516901063374, 5699.0, 6435.292117867031, 6547.9017814732815, 6557.573757705733, 6557.967210163919, 6562.868742625216, 1761.348301128565, 1775.6981313176532, 1780.412463886914, 1793.1751394358741, 1799.6580649676519, 1186.8783999120749, 1237.2761934268553, 1243.490169030693, 1246.0841281657974, 1262.9052821038274, 6171.007061575222, 6218.9116904542425, 6225.252969643671, 6270.770553165124, 6322.629014119705, 6710.83222919431, 6746.561473504206, 6754.223264324567, 6779.35596118368, 6801.0138529913875, 6133.29467111279, 6190.0, 6196.256449226032, 6228.968855155786, 6238.469730072904, 3511.525943997579, 3530.8234588270484, 3566.732495062881, 3569.0, 3614.1868079681863, 7103.502754807114, 7108.644567771591, 7123.608201548861, 7161.606111663908, 7191.928080719231, 6859.691313890887, 6874.518783685194, 6889.311068893071, 6926.2034865990045, 6985.196702379189, 6578.111954886125, 6983.580985140908, 6997.580145191203, 7109.75115870942, 7210.60341681202, 6523.9347606525225, 6668.199356270475, 6688.097106890507, 6737.898931516129, 6773.661316934232, 6591.835204119935, 6632.502562307943, 6651.467882569286, 6705.396514313735, 6709.563878347892, 7060.293970602898, 7107.857842843011, 7133.678984445816, 7144.607046612278, 7215.71137154508, 5405.918911216414, 5422.783088676409, 5459.317585301837, 5506.80726174598, 5530.668159910419, 6652.667366631746, 6719.193696756421, 6728.226253980855, 6784.830379240361, 6826.214985276558, 6576.408123268738, 6578.342165783383, 6584.7036883341325, 6586.209654841449, 6632.867342653217, 6364.681765911593, 6464.612123272619, 6480.675966201577, 6584.407403333723, 6650.534462587572, 6537.1501704778075, 6564.573302735307, 6588.176477940257, 6617.338266173344, 6628.83427914306, 6559.540832141704, 6628.475450646282, 6689.364510371702, 6718.328167183243, 6723.630200339028, 6340.302566717565, 6354.650494222862, 6381.649009304533, 6441.033844923299, 6515.902261465987], "value": 5123.151712964918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.9251267385933, 835.8495470815253, 846.7713717296332, 847.2459511035183, 848.1730312944879, 16865.15674216289, 17264.395746148886, 17328.740068898976, 17426.215820288086, 21658.89170554149, 19712.507187320323, 19952.50118747032, 20352.592948141028, 20371.898140509278, 20387.796122038777, 938.7183844846553, 1052.3317693264794, 1066.9359838409682, 1067.151614466501, 1068.1881769854888, 1064.1858977881927, 1076.445630500293, 1080.3193987787683, 1087.7335052912008, 1090.2313868722572, 1157.340316019869, 1161.8780028097055, 1162.2561560601223, 1162.3026184289442, 1163.6858048326947, 1140.8231724082739, 1156.3582211872408, 1156.6645672754892, 1156.9190156689035, 1157.2535714464166, 848.0925409811504, 848.6647774129246, 852.3735054734765, 852.6205838401913, 853.1298075962484, 16550.917245413817, 16840.157992100467, 16865.494035178843, 18063.0, 18090.547736306566, 19395.515112122168, 19743.40769776909, 19750.604987900304, 19752.0, 19772.20911163552, 14055.0, 14200.289985500684, 14477.203753793538, 14477.565673029825, 14477.71044579113, 3143.811371317728, 3192.233863872677, 3193.1378527797365, 3196.2329041030216, 3196.440622891008, 134569.0, 135742.0, 144378.0, 146229.0, 146795.0, 15300.311485983157, 15300.923495382453, 15686.68626627461, 15701.214939252992, 15740.68518629621, 29689.40621187564, 29745.0, 29981.100566983027, 30395.696043039286, 30607.0, 6969.372756451842, 7138.464615153885, 7740.225977402328, 7932.286094251545, 7932.722354717557, 3857.517810273716, 3926.155876486569, 3932.390479475686, 3943.2507823514015, 3947.0, 4994.200927851526, 5116.462771409023, 5144.125498665236, 5155.278261043457, 5167.354080739908, 1097.2538673701958, 1106.0598491282506, 1129.265977114882, 1132.3771925440974, 1141.4920360439692, 621.8476473264079, 631.1668597451412, 634.8920683483819, 635.9523035772243, 648.5913874259281, 10499.632512862014, 10581.477174612826, 10592.046715795615, 10655.360678359324, 10672.466376681135, 611.8409213604406, 618.9783357582463, 621.9378062193834, 626.9153664255267, 634.9746010159541, 4779.163646361872, 4851.296561998491, 4901.044296362246, 4978.551930326288, 5035.244713293036, 137943.31028344794, 139532.0, 142651.0, 143546.282268588, 148163.0, 118890.0, 119277.40361298138, 120790.0, 121844.39077804555, 123093.0, 108087.0, 108292.45853770681, 109045.0, 110630.44684776686, 113611.43194283976, 9351.064893510867, 9442.85835712451, 9455.810883782147, 9477.0, 9489.715308540755, 51990.0, 52342.21486677779, 52526.0, 52709.7364513175, 54170.187447187534, 66176.0, 66515.0, 66745.0, 67442.3255767436, 69047.96428053483, 14724.852751472348, 14776.63058423505, 14948.925255374088, 14968.550943471713, 15174.165420901514, 15562.922185389001, 18123.0, 18760.53098672544, 20148.496287592927, 21671.891640541697, 18492.81507184911, 18552.072396379855, 18635.627287453903, 18639.347622833135, 18750.0, 18470.445886623424, 18481.72277415867, 18667.813321866608, 18803.153858076144, 18935.242590296235, 16563.751543726612, 16861.0, 16919.91540042292, 17007.48977530676, 17271.56821079483, 13465.394057267642, 13795.724085518434, 14027.789583156056, 14128.78806817919, 14162.079464834753, 11992.64022079339, 12018.017027190415, 12245.877541224474, 12331.69170770738, 12578.748425031265], "value": 9029.311906154038, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 102.0, 108.0, 106.0, 113.0, 109.0, 99.0, 105.0, 110.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 114.0, 140.0, 170.0, 116.0, 142.0, 144.0, 115.0, 170.0, 112.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 163.0, 160.0, 161.0, 162.0, 170.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 147.0, 74.0, 75.0, 73.0, 89.0, 103.0, 73.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 130.0, 78.0, 78.0, 79.0, 121.0, 78.0, 78.0, 124.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 153.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 93.0, 94.0, 95.0, 93.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 52.0, 54.0, 46.0, 55.0, 47.0, 46.0, 48.0, 47.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 59.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 73.0, 74.0, 72.0, 72.0, 73.0, 73.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 113.0, 123.0, 127.0, 124.0, 113.0, 115.0, 115.0, 116.0, 149.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 164.0, 169.0, 161.0, 169.0, 168.0, 177.0, 160.0, 164.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 61.0, 63.0, 62.0, 61.0, 62.0, 60.0, 61.0, 65.0], "value": 62.5, "unit": "score"}]}]} 12:04:14 INFO - Return code: 0 12:04:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:04:14 INFO - # TBPL SUCCESS # 12:04:14 INFO - Running post-action listener: _package_coverage_data 12:04:14 INFO - Running post-action listener: _resource_record_post_action 12:04:14 INFO - [mozharness: 2017-08-18 19:04:14.412952Z] Finished run-tests step (success) 12:04:14 INFO - Running post-run listener: _resource_record_post_run 12:04:14 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429228032; Read time: 8; Write time: 256036 12:04:14 INFO - TinderboxPrint: CPU usage
13.0% 12:04:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:04:14 INFO - TinderboxPrint: I/O write bytes / time
429,228,032 / 256,036 12:04:14 INFO - TinderboxPrint: CPU idle
8,238.8 (87.0%) 12:04:14 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 12:04:14 INFO - TinderboxPrint: Swap in / out
0 / 0 12:04:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107540480; Read time: 0; Write time: 76112 12:04:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:04:14 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 321687552; Read time: 0; Write time: 179924 12:04:15 INFO - Running post-run listener: _upload_blobber_files 12:04:15 INFO - Blob upload gear active. 12:04:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:15 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 12:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:15 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:16 INFO - (blobuploader) - INFO - Done attempting. 12:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:23 INFO - (blobuploader) - INFO - Done attempting. 12:04:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:04:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:04:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:24 INFO - (blobuploader) - INFO - Done attempting. 12:04:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:04:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:04:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:25 INFO - (blobuploader) - INFO - Done attempting. 12:04:25 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:25 INFO - Return code: 0 12:04:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e566c3ea8b07ae953a70f9516ff0872e3ff6843fbdd100dbf2bb48b85fd8023bbdbb37005326b84cb34d48850029e33e458c51ee630aeff7fdd4d22e208b49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a897c2039cb106fe9ffa0d557c3e9e5989edef56a1ca907d7d053ecd29c9056955a5d37c31622441e4546fead2096539787d50f778a3a67b38e43e6448e9e397", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e2c43eb07b9e4076cf0c160539c8f0f93c22d75d042d5017bae07e84b8516e3c01ebc905b457084c5471f047d1a13a3fa012cdfc76470e6bf7835ef3d62554", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8fdf99bbf5c40cb689749b058120f5ab2cb81bfcf93cd716d7814eaa013cd408a9069791a90515182789b5c24058e14e437573b5e54e49f68a5c17e258caa8e"} 12:04:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:25 INFO - Contents: 12:04:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e566c3ea8b07ae953a70f9516ff0872e3ff6843fbdd100dbf2bb48b85fd8023bbdbb37005326b84cb34d48850029e33e458c51ee630aeff7fdd4d22e208b49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a897c2039cb106fe9ffa0d557c3e9e5989edef56a1ca907d7d053ecd29c9056955a5d37c31622441e4546fead2096539787d50f778a3a67b38e43e6448e9e397", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e2c43eb07b9e4076cf0c160539c8f0f93c22d75d042d5017bae07e84b8516e3c01ebc905b457084c5471f047d1a13a3fa012cdfc76470e6bf7835ef3d62554", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8fdf99bbf5c40cb689749b058120f5ab2cb81bfcf93cd716d7814eaa013cd408a9069791a90515182789b5c24058e14e437573b5e54e49f68a5c17e258caa8e"} 12:04:25 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:25 INFO - Copying logs to upload dir... 12:04:25 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.787096 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-18 12:04:25.650445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 12:04:25.653816) ========= 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=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e566c3ea8b07ae953a70f9516ff0872e3ff6843fbdd100dbf2bb48b85fd8023bbdbb37005326b84cb34d48850029e33e458c51ee630aeff7fdd4d22e208b49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a897c2039cb106fe9ffa0d557c3e9e5989edef56a1ca907d7d053ecd29c9056955a5d37c31622441e4546fead2096539787d50f778a3a67b38e43e6448e9e397", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e2c43eb07b9e4076cf0c160539c8f0f93c22d75d042d5017bae07e84b8516e3c01ebc905b457084c5471f047d1a13a3fa012cdfc76470e6bf7835ef3d62554", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8fdf99bbf5c40cb689749b058120f5ab2cb81bfcf93cd716d7814eaa013cd408a9069791a90515182789b5c24058e14e437573b5e54e49f68a5c17e258caa8e"} build_url:https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/XiW5Eyh5TGG8fP6P6_2IWA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48e566c3ea8b07ae953a70f9516ff0872e3ff6843fbdd100dbf2bb48b85fd8023bbdbb37005326b84cb34d48850029e33e458c51ee630aeff7fdd4d22e208b49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a897c2039cb106fe9ffa0d557c3e9e5989edef56a1ca907d7d053ecd29c9056955a5d37c31622441e4546fead2096539787d50f778a3a67b38e43e6448e9e397", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07e2c43eb07b9e4076cf0c160539c8f0f93c22d75d042d5017bae07e84b8516e3c01ebc905b457084c5471f047d1a13a3fa012cdfc76470e6bf7835ef3d62554", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8fdf99bbf5c40cb689749b058120f5ab2cb81bfcf93cd716d7814eaa013cd408a9069791a90515182789b5c24058e14e437573b5e54e49f68a5c17e258caa8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 12:04:25.684371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 12:04:25.684699) ========= 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=bb9b54edd4a927dc735d112f000001d9-1503081813.958399-124148332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 12:04:25.766837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 12:04:25.767191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 12:04:25.767597) ========= ========= Total master_lag: 0.17 =========