builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1503012573.83 results: success (0) revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.831319) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.831770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.832042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.847734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.847988) ========= 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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 16:29:33-- 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% 46.0M=0s 2017-08-17 16:29:34 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.946565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.946863) ========= 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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:33.995823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 16:29:33.996134) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 54ad22b649e547a5b20babdecc84f5563a9b7dea --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 54ad22b649e547a5b20babdecc84f5563a9b7dea --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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 16:29:34,154 truncating revision to first 12 chars 2017-08-17 16:29:34,154 Setting DEBUG logging. 2017-08-17 16:29:34,154 attempt 1/10 2017-08-17 16:29:34,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/54ad22b649e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 16:29:35,267 unpacking tar archive at: mozilla-central-54ad22b649e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.466729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 16:29:35.477317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:35.477643) ========= script_repo_revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:35.478019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:35.478284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:29:35.488396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-17 16:29:35.488655) ========= /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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:29:35 INFO - MultiFileLogger online at 20170817 16:29:35 in /builds/slave/test 16:29:35 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 16:29:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:29:35 INFO - {'append_to_log': False, 16:29:35 INFO - 'base_work_dir': '/builds/slave/test', 16:29:35 INFO - 'blob_upload_branch': 'Firefox', 16:29:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:29:35 INFO - 'branch': 'Firefox', 16:29:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:29:35 INFO - 'code_coverage': False, 16:29:35 INFO - 'config_files': ('talos/linux_config.py',), 16:29:35 INFO - 'default_actions': ('clobber', 16:29:35 INFO - 'read-buildbot-config', 16:29:35 INFO - 'download-and-extract', 16:29:35 INFO - 'populate-webroot', 16:29:35 INFO - 'create-virtualenv', 16:29:35 INFO - 'install', 16:29:35 INFO - 'setup-mitmproxy', 16:29:35 INFO - 'run-tests'), 16:29:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:29:35 INFO - 'disable_ccov_upload': False, 16:29:35 INFO - 'download_minidump_stackwalk': True, 16:29:35 INFO - 'download_symbols': 'ondemand', 16:29:35 INFO - 'enable_stylo': False, 16:29:35 INFO - 'enable_webrender': False, 16:29:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:29:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:29:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:29:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:29:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:29:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:29:35 INFO - 'gecko_profile': False, 16:29:35 INFO - 'gecko_profile_interval': 0, 16:29:35 INFO - 'installer_path': 'installer.exe', 16:29:35 INFO - 'log_level': 'info', 16:29:35 INFO - 'log_name': 'talos', 16:29:35 INFO - 'log_to_console': True, 16:29:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:29:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:29:35 INFO - 'opt_config_files': (), 16:29:35 INFO - 'pip_index': False, 16:29:35 INFO - 'suite': 'dromaeojs-e10s', 16:29:35 INFO - 'system_bits': '32', 16:29:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:29:35 INFO - 'title': 'talos-linux64-ix-065', 16:29:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:29:35 INFO - 'use_talos_json': True, 16:29:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:29:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:29:35 INFO - 'work_dir': 'build'} 16:29:35 INFO - [mozharness: 2017-08-17 23:29:35.746129Z] Running clobber step. 16:29:35 INFO - Running pre-action listener: _resource_record_pre_action 16:29:35 INFO - Running main action method: clobber 16:29:35 INFO - rmtree: /builds/slave/test/build 16:29:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:29:36 INFO - Running post-action listener: _resource_record_post_action 16:29:36 INFO - [mozharness: 2017-08-17 23:29:36.823380Z] Finished clobber step (success) 16:29:36 INFO - [mozharness: 2017-08-17 23:29:36.823483Z] Running read-buildbot-config step. 16:29:36 INFO - Running pre-action listener: _resource_record_pre_action 16:29:36 INFO - Running main action method: read_buildbot_config 16:29:36 INFO - Using buildbot properties: 16:29:36 INFO - { 16:29:36 INFO - "project": "", 16:29:36 INFO - "product": "firefox", 16:29:36 INFO - "who": "dtownsend@mozilla.com", 16:29:36 INFO - "installer_path": "public/build/target.tar.bz2", 16:29:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:29:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:29:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:29:36 INFO - "stage_platform": "linux64-pgo", 16:29:36 INFO - "basedir": "/builds/slave/test", 16:29:36 INFO - "buildnumber": 126, 16:29:36 INFO - "platform": "ubuntu64_hw", 16:29:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:29:36 INFO - "slavebuilddir": "test", 16:29:36 INFO - "taskId": "HM_Q3Lo9TdWYoAtfunOqaQ", 16:29:36 INFO - "branch": "mozilla-central", 16:29:36 INFO - "script_repo_revision": "production", 16:29:36 INFO - "revision": "54ad22b649e547a5b20babdecc84f5563a9b7dea", 16:29:36 INFO - "slavename": "talos-linux64-ix-065", 16:29:36 INFO - "repo_path": "mozilla-central" 16:29:36 INFO - } 16:29:36 INFO - Finding installer, test and symbols from parent task. 16:29:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HM_Q3Lo9TdWYoAtfunOqaQ'}, attempt #1 16:29:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HM_Q3Lo9TdWYoAtfunOqaQ'}, attempt #1 16:29:37 INFO - Task dependencies: ZWBuZkNwS_22rQ2YylU9uw 16:29:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw'}, attempt #1 16:29:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 16:29:38 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.test_packages.json 16:29:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.crashreporter-symbols.zip 16:29:38 INFO - Running post-action listener: _resource_record_post_action 16:29:38 INFO - [mozharness: 2017-08-17 23:29:38.200328Z] Finished read-buildbot-config step (success) 16:29:38 INFO - [mozharness: 2017-08-17 23:29:38.200550Z] Running download-and-extract step. 16:29:38 INFO - Running pre-action listener: _resource_record_pre_action 16:29:38 INFO - Running main action method: download_and_extract 16:29:38 INFO - mkdir: /builds/slave/test/build/tests 16:29: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')]} 16:29:38 INFO - trying https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.test_packages.json 16:29:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:29:38 INFO - Downloaded 989 bytes. 16:29:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:29:38 INFO - Using the following test package requirements: 16:29:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:29:38 INFO - u'common': [u'target.common.tests.zip'], 16:29:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:29:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:29:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:29:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:29:38 INFO - u'mozbase': [u'target.common.tests.zip'], 16:29:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:29:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:29:38 INFO - u'web-platform': [u'target.common.tests.zip', 16:29:38 INFO - u'target.web-platform.tests.tar.gz'], 16:29:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:29:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:29:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip 16:29:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:29:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip into memory 16:29:39 INFO - Content-Length response header: 54612016 16:29:39 INFO - Bytes received: 54612016 16:29:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip 16:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.common.tests.zip into memory 16:29:51 INFO - Content-Length response header: 54612016 16:29:51 INFO - Bytes received: 54612016 16:30:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.talos.tests.zip 16:30:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:30:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.talos.tests.zip into memory 16:30:04 INFO - Content-Length response header: 14496161 16:30:04 INFO - Bytes received: 14496161 16:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:04 INFO - trying https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 16:30:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:30:05 INFO - Downloaded 63051075 bytes. 16:30:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 16:30:05 INFO - mkdir: /builds/slave/test/properties 16:30:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:05 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:05 INFO - Contents: 16:30:05 INFO - build_url:https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 16:30:05 INFO - Running post-action listener: _resource_record_post_action 16:30:05 INFO - Running post-action listener: set_extra_try_arguments 16:30:05 INFO - [mozharness: 2017-08-17 23:30:05.911760Z] Finished download-and-extract step (success) 16:30:05 INFO - [mozharness: 2017-08-17 23:30:05.911858Z] Running populate-webroot step. 16:30:05 INFO - Running pre-action listener: _resource_record_pre_action 16:30:05 INFO - Running main action method: populate_webroot 16:30:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:30:05 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:30:05 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:30:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:05 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'tests': ['damp', 'tps']}, 16:30:05 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['damp', 'tps']}, 16:30:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:30:05 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:30:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:30:05 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:30:05 INFO - 'other-e10s': {'tests': ['a11yr', 16:30:05 INFO - 'ts_paint', 16:30:05 INFO - 'tpaint', 16:30:05 INFO - 'sessionrestore', 16:30:05 INFO - 'sessionrestore_many_windows', 16:30:05 INFO - 'sessionrestore_no_auto_restore', 16:30:05 INFO - 'tabpaint']}, 16:30:05 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['a11yr', 16:30:05 INFO - 'ts_paint', 16:30:05 INFO - 'tpaint', 16:30:05 INFO - 'sessionrestore', 16:30:05 INFO - 'sessionrestore_many_windows', 16:30:05 INFO - 'sessionrestore_no_auto_restore', 16:30:05 INFO - 'tabpaint']}, 16:30:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:30:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:30:05 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['bloom_basic_singleton']}, 16:30:05 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['bloom_basic']}, 16:30:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:30:05 INFO - 'tsvgr_opacity', 16:30:05 INFO - 'tart', 16:30:05 INFO - 'tscrollx', 16:30:05 INFO - 'tsvg_static']}, 16:30:05 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['tsvgx', 16:30:05 INFO - 'tsvgr_opacity', 16:30:05 INFO - 'tart', 16:30:05 INFO - 'tscrollx', 16:30:05 INFO - 'tsvg_static']}, 16:30:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:30:05 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--stylo'], 16:30:05 INFO - 'tests': ['tp5o']}, 16:30:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:30:05 INFO - 'talos_options': ['--mitmproxy', 16:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:30:05 INFO - '--firstNonBlankPaint'], 16:30:05 INFO - 'tests': ['tp6_google', 16:30:05 INFO - 'tp6_youtube', 16:30:05 INFO - 'tp6_amazon', 16:30:05 INFO - 'tp6_facebook']}, 16:30:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:30:05 INFO - 'talos_options': ['--stylo', 16:30:05 INFO - '--mitmproxy', 16:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:30:05 INFO - '--firstNonBlankPaint'], 16:30:05 INFO - 'tests': ['tp6_google', 16:30:05 INFO - 'tp6_youtube', 16:30:05 INFO - 'tp6_amazon', 16:30:05 INFO - 'tp6_facebook']}, 16:30:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:30:05 INFO - 'talos_options': ['--stylo', 16:30:05 INFO - '--stylo-threads=1', 16:30:05 INFO - '--mitmproxy', 16:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:30:05 INFO - '--firstNonBlankPaint'], 16:30:05 INFO - 'tests': ['tp6_google', 16:30:05 INFO - 'tp6_youtube', 16:30:05 INFO - 'tp6_amazon', 16:30:05 INFO - 'tp6_facebook']}, 16:30:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--xperf_path', 16:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:05 INFO - 'tests': ['tp5n']}, 16:30:05 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:30:05 INFO - 'talos_options': ['--stylo', 16:30:05 INFO - '--xperf_path', 16:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:05 INFO - 'tests': ['tp5n']}}} 16:30:05 INFO - Running post-action listener: _resource_record_post_action 16:30:05 INFO - [mozharness: 2017-08-17 23:30:05.926087Z] Finished populate-webroot step (success) 16:30:05 INFO - [mozharness: 2017-08-17 23:30:05.926178Z] Running create-virtualenv step. 16:30:05 INFO - Running pre-action listener: _resource_record_pre_action 16:30:05 INFO - Running main action method: create_virtualenv 16:30:05 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:05 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 16:30:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:30:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:06 INFO - Using real prefix '/usr' 16:30:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:06 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:08 INFO - Installing pip.................done. 16:30:08 INFO - Return code: 0 16:30:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:30:08 INFO - Reading from file tmpfile_stdout 16:30:08 INFO - Output received: 16:30:08 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) 16:30:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:08 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:30:08 INFO - Using env: {'DISPLAY': ':0', 16:30:08 INFO - 'HOME': '/home/cltbld', 16:30:08 INFO - 'LANG': 'en_US.UTF-8', 16:30:08 INFO - 'LANGUAGE': 'en_US:en', 16:30:08 INFO - 'LOGNAME': 'cltbld', 16:30:08 INFO - 'MAIL': '/var/mail/cltbld', 16:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:08 INFO - 'MOZ_NO_REMOTE': '1', 16:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:08 INFO - 'NO_EM_RESTART': '1', 16:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:08 INFO - 'PWD': '/builds/slave/test', 16:30:08 INFO - 'SHELL': '/bin/bash', 16:30:08 INFO - 'SHLVL': '1', 16:30:08 INFO - 'TERM': 'linux', 16:30:08 INFO - 'TMOUT': '86400', 16:30:08 INFO - 'USER': 'cltbld', 16:30:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:08 INFO - '_': '/tools/buildbot/bin/python'} 16:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:08 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 16:30:08 INFO - Cleaning up... 16:30:08 INFO - Return code: 0 16:30:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:08 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:30:08 INFO - Using env: {'DISPLAY': ':0', 16:30:08 INFO - 'HOME': '/home/cltbld', 16:30:08 INFO - 'LANG': 'en_US.UTF-8', 16:30:08 INFO - 'LANGUAGE': 'en_US:en', 16:30:08 INFO - 'LOGNAME': 'cltbld', 16:30:08 INFO - 'MAIL': '/var/mail/cltbld', 16:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:08 INFO - 'MOZ_NO_REMOTE': '1', 16:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:08 INFO - 'NO_EM_RESTART': '1', 16:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:08 INFO - 'PWD': '/builds/slave/test', 16:30:08 INFO - 'SHELL': '/bin/bash', 16:30:08 INFO - 'SHLVL': '1', 16:30:08 INFO - 'TERM': 'linux', 16:30:08 INFO - 'TMOUT': '86400', 16:30:08 INFO - 'USER': 'cltbld', 16:30:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:08 INFO - '_': '/tools/buildbot/bin/python'} 16:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:09 INFO - Downloading/unpacking psutil>=3.1.1 16:30: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 16:30: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 16:30: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 16:30: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 16:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:10 INFO - Installing collected packages: psutil 16:30:10 INFO - Running setup.py install for psutil 16:30:10 INFO - building 'psutil._psutil_linux' extension 16:30: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 16:30:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:30:10 INFO - building 'psutil._psutil_posix' extension 16:30:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:30:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:10 INFO - Successfully installed psutil 16:30:10 INFO - Cleaning up... 16:30:10 INFO - Return code: 0 16:30:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:10 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:30:10 INFO - Using env: {'DISPLAY': ':0', 16:30:10 INFO - 'HOME': '/home/cltbld', 16:30:10 INFO - 'LANG': 'en_US.UTF-8', 16:30:10 INFO - 'LANGUAGE': 'en_US:en', 16:30:10 INFO - 'LOGNAME': 'cltbld', 16:30:10 INFO - 'MAIL': '/var/mail/cltbld', 16:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:10 INFO - 'MOZ_NO_REMOTE': '1', 16:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:10 INFO - 'NO_EM_RESTART': '1', 16:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:10 INFO - 'PWD': '/builds/slave/test', 16:30:10 INFO - 'SHELL': '/bin/bash', 16:30:10 INFO - 'SHLVL': '1', 16:30:10 INFO - 'TERM': 'linux', 16:30:10 INFO - 'TMOUT': '86400', 16:30:10 INFO - 'USER': 'cltbld', 16:30:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:10 INFO - '_': '/tools/buildbot/bin/python'} 16:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:30: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 16:30: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 16:30: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 16:30: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 16:30:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:30:13 INFO - Installing collected packages: mozsystemmonitor 16:30:13 INFO - Running setup.py install for mozsystemmonitor 16:30:13 INFO - Successfully installed mozsystemmonitor 16:30:13 INFO - Cleaning up... 16:30:13 INFO - Return code: 0 16:30:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:13 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:30:13 INFO - Using env: {'DISPLAY': ':0', 16:30:13 INFO - 'HOME': '/home/cltbld', 16:30:13 INFO - 'LANG': 'en_US.UTF-8', 16:30:13 INFO - 'LANGUAGE': 'en_US:en', 16:30:13 INFO - 'LOGNAME': 'cltbld', 16:30:13 INFO - 'MAIL': '/var/mail/cltbld', 16:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:13 INFO - 'MOZ_NO_REMOTE': '1', 16:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:13 INFO - 'NO_EM_RESTART': '1', 16:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:13 INFO - 'PWD': '/builds/slave/test', 16:30:13 INFO - 'SHELL': '/bin/bash', 16:30:13 INFO - 'SHLVL': '1', 16:30:13 INFO - 'TERM': 'linux', 16:30:13 INFO - 'TMOUT': '86400', 16:30:13 INFO - 'USER': 'cltbld', 16:30:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:13 INFO - '_': '/tools/buildbot/bin/python'} 16:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:13 INFO - Downloading/unpacking jsonschema==2.5.1 16:30: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 16:30: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 16:30: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 16:30: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 16:30:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:30:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:30: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 16:30: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 16:30: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 16:30: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 16:30:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:30:14 INFO - warning: no files found matching '*.txt' 16:30:14 INFO - no previously-included directories found matching 'build' 16:30:14 INFO - no previously-included directories found matching 'dist' 16:30:14 INFO - no previously-included directories found matching '.git*' 16:30:14 INFO - Installing collected packages: jsonschema, functools32 16:30:14 INFO - Running setup.py install for functools32 16:30:15 INFO - warning: no files found matching '*.txt' 16:30:15 INFO - no previously-included directories found matching 'build' 16:30:15 INFO - no previously-included directories found matching 'dist' 16:30:15 INFO - no previously-included directories found matching '.git*' 16:30:15 INFO - Successfully installed jsonschema functools32 16:30:15 INFO - Cleaning up... 16:30:15 INFO - Return code: 0 16:30:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:15 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:30:15 INFO - Using env: {'DISPLAY': ':0', 16:30:15 INFO - 'HOME': '/home/cltbld', 16:30:15 INFO - 'LANG': 'en_US.UTF-8', 16:30:15 INFO - 'LANGUAGE': 'en_US:en', 16:30:15 INFO - 'LOGNAME': 'cltbld', 16:30:15 INFO - 'MAIL': '/var/mail/cltbld', 16:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:15 INFO - 'MOZ_NO_REMOTE': '1', 16:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:15 INFO - 'NO_EM_RESTART': '1', 16:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:15 INFO - 'PWD': '/builds/slave/test', 16:30:15 INFO - 'SHELL': '/bin/bash', 16:30:15 INFO - 'SHLVL': '1', 16:30:15 INFO - 'TERM': 'linux', 16:30:15 INFO - 'TMOUT': '86400', 16:30:15 INFO - 'USER': 'cltbld', 16:30:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:15 INFO - '_': '/tools/buildbot/bin/python'} 16:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:30:15 INFO - Cleaning up... 16:30:15 INFO - Return code: 0 16:30:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:15 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:30:15 INFO - Using env: {'DISPLAY': ':0', 16:30:15 INFO - 'HOME': '/home/cltbld', 16:30:15 INFO - 'LANG': 'en_US.UTF-8', 16:30:15 INFO - 'LANGUAGE': 'en_US:en', 16:30:15 INFO - 'LOGNAME': 'cltbld', 16:30:15 INFO - 'MAIL': '/var/mail/cltbld', 16:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:15 INFO - 'MOZ_NO_REMOTE': '1', 16:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:15 INFO - 'NO_EM_RESTART': '1', 16:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:15 INFO - 'PWD': '/builds/slave/test', 16:30:15 INFO - 'SHELL': '/bin/bash', 16:30:15 INFO - 'SHLVL': '1', 16:30:15 INFO - 'TERM': 'linux', 16:30:15 INFO - 'TMOUT': '86400', 16:30:15 INFO - 'USER': 'cltbld', 16:30:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:15 INFO - '_': '/tools/buildbot/bin/python'} 16:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:30:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:30: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 16:30: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 16:30: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 16:30: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 16:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:30:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:17 INFO - Downloading docopt-0.6.1.tar.gz 16:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:30:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:30:17 INFO - Running setup.py install for blobuploader 16:30:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:30:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:30:17 INFO - Running setup.py install for requests 16:30:17 INFO - Running setup.py install for docopt 16:30:17 INFO - Successfully installed blobuploader requests docopt 16:30:17 INFO - Cleaning up... 16:30:17 INFO - Return code: 0 16:30:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30: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')]} 16:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30: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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30: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 16:30: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 16:30:17 INFO - Using env: {'DISPLAY': ':0', 16:30:17 INFO - 'HOME': '/home/cltbld', 16:30:17 INFO - 'LANG': 'en_US.UTF-8', 16:30:17 INFO - 'LANGUAGE': 'en_US:en', 16:30:17 INFO - 'LOGNAME': 'cltbld', 16:30:17 INFO - 'MAIL': '/var/mail/cltbld', 16:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:17 INFO - 'MOZ_NO_REMOTE': '1', 16:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:17 INFO - 'NO_EM_RESTART': '1', 16:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:17 INFO - 'PWD': '/builds/slave/test', 16:30:17 INFO - 'SHELL': '/bin/bash', 16:30:17 INFO - 'SHLVL': '1', 16:30:17 INFO - 'TERM': 'linux', 16:30:17 INFO - 'TMOUT': '86400', 16:30:17 INFO - 'USER': 'cltbld', 16:30:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:17 INFO - '_': '/tools/buildbot/bin/python'} 16:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:18 INFO - Running setup.py (path:/tmp/pip-VtgCi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:18 INFO - Running setup.py (path:/tmp/pip-C6ekHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:18 INFO - Running setup.py (path:/tmp/pip-yNfdOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:18 INFO - Running setup.py (path:/tmp/pip-XV7T4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:18 INFO - Running setup.py (path:/tmp/pip-Kg4iBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:18 INFO - Running setup.py (path:/tmp/pip-exNm4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:18 INFO - Running setup.py (path:/tmp/pip-ukxtuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:18 INFO - Running setup.py (path:/tmp/pip-GGhkRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:18 INFO - Running setup.py (path:/tmp/pip-KZmtTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:18 INFO - Running setup.py (path:/tmp/pip-rwQnT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:18 INFO - Running setup.py (path:/tmp/pip-SjEmFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:18 INFO - Running setup.py (path:/tmp/pip-rzMESN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:18 INFO - Running setup.py (path:/tmp/pip-Xs3i4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:19 INFO - Running setup.py (path:/tmp/pip-ESpd0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:19 INFO - Running setup.py (path:/tmp/pip-7Tupv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:19 INFO - Running setup.py (path:/tmp/pip-1tDz07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:19 INFO - Running setup.py (path:/tmp/pip-YwGyCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:30:19 INFO - Running setup.py install for manifestparser 16:30:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:30:19 INFO - Running setup.py install for mozcrash 16:30:19 INFO - Running setup.py install for mozdebug 16:30:19 INFO - Running setup.py install for mozdevice 16:30:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:30:19 INFO - Running setup.py install for mozfile 16:30:19 INFO - Running setup.py install for mozhttpd 16:30:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:30:19 INFO - Running setup.py install for mozinfo 16:30:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:30:19 INFO - Running setup.py install for mozInstall 16:30:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Running setup.py install for mozleak 16:30:20 INFO - Running setup.py install for mozlog 16:30:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Running setup.py install for moznetwork 16:30:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Running setup.py install for mozprocess 16:30:20 INFO - Running setup.py install for mozprofile 16:30:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Running setup.py install for mozrunner 16:30:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:30:20 INFO - Running setup.py install for mozscreenshot 16:30:20 INFO - Running setup.py install for moztest 16:30:20 INFO - Running setup.py install for mozversion 16:30:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:30:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:30:21 INFO - Cleaning up... 16:30:21 INFO - Return code: 0 16:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:21 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:21 INFO - Using env: {'DISPLAY': ':0', 16:30:21 INFO - 'HOME': '/home/cltbld', 16:30:21 INFO - 'LANG': 'en_US.UTF-8', 16:30:21 INFO - 'LANGUAGE': 'en_US:en', 16:30:21 INFO - 'LOGNAME': 'cltbld', 16:30:21 INFO - 'MAIL': '/var/mail/cltbld', 16:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:21 INFO - 'MOZ_NO_REMOTE': '1', 16:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:21 INFO - 'NO_EM_RESTART': '1', 16:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:21 INFO - 'PWD': '/builds/slave/test', 16:30:21 INFO - 'SHELL': '/bin/bash', 16:30:21 INFO - 'SHLVL': '1', 16:30:21 INFO - 'TERM': 'linux', 16:30:21 INFO - 'TMOUT': '86400', 16:30:21 INFO - 'USER': 'cltbld', 16:30:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:21 INFO - '_': '/tools/buildbot/bin/python'} 16:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:30:21 INFO - Running setup.py (path:/tmp/pip-B5sLYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:30:21 INFO - Running setup.py (path:/tmp/pip-vr496o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:30:21 INFO - Running setup.py (path:/tmp/pip-T01IFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:30:21 INFO - Running setup.py (path:/tmp/pip-YDwiS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:30:21 INFO - Running setup.py (path:/tmp/pip-SdfJbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:30:21 INFO - Running setup.py (path:/tmp/pip-eBjpOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:30:21 INFO - Running setup.py (path:/tmp/pip-hL_6ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:30:21 INFO - Running setup.py (path:/tmp/pip-61HY5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:30:21 INFO - Running setup.py (path:/tmp/pip-eruHC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:30: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)) 16:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:30:21 INFO - Running setup.py (path:/tmp/pip-KUuclV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:30:22 INFO - Running setup.py (path:/tmp/pip-KOkITK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:30:22 INFO - Running setup.py (path:/tmp/pip-dZ51tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:30:22 INFO - Running setup.py (path:/tmp/pip-AXQEC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:30:22 INFO - Running setup.py (path:/tmp/pip-CRbpYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:22 INFO - Running setup.py (path:/tmp/pip-1Khofe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:30:22 INFO - Running setup.py (path:/tmp/pip-0AFCs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:30:22 INFO - Running setup.py (path:/tmp/pip-nMTLJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:30:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:23 INFO - Downloading blessings-1.6.tar.gz 16:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:30:23 INFO - Installing collected packages: blessings 16:30:23 INFO - Running setup.py install for blessings 16:30:23 INFO - Successfully installed blessings 16:30:23 INFO - Cleaning up... 16:30:23 INFO - Return code: 0 16:30:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:24 INFO - Reading from file tmpfile_stdout 16:30:24 INFO - Current package versions: 16:30:24 INFO - argparse == 1.2.1 16:30:24 INFO - blessings == 1.6 16:30:24 INFO - blobuploader == 1.2.4 16:30:24 INFO - docopt == 0.6.1 16:30:24 INFO - functools32 == 3.2.3-2 16:30:24 INFO - jsonschema == 2.5.1 16:30:24 INFO - manifestparser == 1.1 16:30:24 INFO - mozInstall == 1.13 16:30:24 INFO - mozcrash == 1.0 16:30:24 INFO - mozdebug == 0.1 16:30:24 INFO - mozdevice == 0.51 16:30:24 INFO - mozfile == 1.2 16:30:24 INFO - mozhttpd == 0.7 16:30:24 INFO - mozinfo == 0.10 16:30:24 INFO - mozleak == 0.1 16:30:24 INFO - mozlog == 3.5 16:30:24 INFO - moznetwork == 0.27 16:30:24 INFO - mozprocess == 0.25 16:30:24 INFO - mozprofile == 0.28 16:30:24 INFO - mozrunner == 6.13 16:30:24 INFO - mozscreenshot == 0.1 16:30:24 INFO - mozsystemmonitor == 0.3 16:30:24 INFO - moztest == 0.8 16:30:24 INFO - mozversion == 1.4 16:30:24 INFO - psutil == 3.1.1 16:30:24 INFO - requests == 1.2.3 16:30:24 INFO - wsgiref == 0.1.2 16:30:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:24 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:30:24 INFO - Using env: {'DISPLAY': ':0', 16:30:24 INFO - 'HOME': '/home/cltbld', 16:30:24 INFO - 'LANG': 'en_US.UTF-8', 16:30:24 INFO - 'LANGUAGE': 'en_US:en', 16:30:24 INFO - 'LOGNAME': 'cltbld', 16:30:24 INFO - 'MAIL': '/var/mail/cltbld', 16:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:24 INFO - 'MOZ_NO_REMOTE': '1', 16:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:24 INFO - 'NO_EM_RESTART': '1', 16:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:24 INFO - 'PWD': '/builds/slave/test', 16:30:24 INFO - 'SHELL': '/bin/bash', 16:30:24 INFO - 'SHLVL': '1', 16:30:24 INFO - 'TERM': 'linux', 16:30:24 INFO - 'TMOUT': '86400', 16:30:24 INFO - 'USER': 'cltbld', 16:30:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:24 INFO - '_': '/tools/buildbot/bin/python'} 16:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:30:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:30:25 INFO - Installing collected packages: simplejson 16:30:25 INFO - Running setup.py install for simplejson 16:30:25 INFO - building 'simplejson._speedups' extension 16:30:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:30:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:30:26 INFO - Successfully installed simplejson 16:30:26 INFO - Cleaning up... 16:30:26 INFO - Return code: 0 16:30:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:26 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 0x1b671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e0eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, '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': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:30:26 INFO - Using env: {'DISPLAY': ':0', 16:30:26 INFO - 'HOME': '/home/cltbld', 16:30:26 INFO - 'LANG': 'en_US.UTF-8', 16:30:26 INFO - 'LANGUAGE': 'en_US:en', 16:30:26 INFO - 'LOGNAME': 'cltbld', 16:30:26 INFO - 'MAIL': '/var/mail/cltbld', 16:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:26 INFO - 'MOZ_NO_REMOTE': '1', 16:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:26 INFO - 'NO_EM_RESTART': '1', 16:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:26 INFO - 'PWD': '/builds/slave/test', 16:30:26 INFO - 'SHELL': '/bin/bash', 16:30:26 INFO - 'SHLVL': '1', 16:30:26 INFO - 'TERM': 'linux', 16:30:26 INFO - 'TMOUT': '86400', 16:30:26 INFO - 'USER': 'cltbld', 16:30:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:26 INFO - '_': '/tools/buildbot/bin/python'} 16:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:30:26 INFO - Cleaning up... 16:30:26 INFO - Return code: 0 16:30:26 INFO - Running post-action listener: _resource_record_post_action 16:30:26 INFO - Running post-action listener: _start_resource_monitoring 16:30:26 INFO - Starting resource monitoring. 16:30:26 INFO - [mozharness: 2017-08-17 23:30:26.808087Z] Finished create-virtualenv step (success) 16:30:26 INFO - [mozharness: 2017-08-17 23:30:26.808601Z] Running install step. 16:30:26 INFO - Running pre-action listener: _resource_record_pre_action 16:30:26 INFO - Running main action method: install 16:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:30:27 INFO - Reading from file tmpfile_stdout 16:30:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:30:27 INFO - Reading from file tmpfile_stdout 16:30:27 INFO - Output received: 16:30:27 INFO - Usage: mozinstall [options] installer 16:30:27 INFO - Options: 16:30:27 INFO - -h, --help show this help message and exit 16:30:27 INFO - -d DEST, --destination=DEST 16:30:27 INFO - Directory to install application into. [default: 16:30:27 INFO - "/builds/slave/test"] 16:30:27 INFO - --app=APP Application being installed. [default: firefox] 16:30:27 INFO - mkdir: /builds/slave/test/build/application 16:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:30:45 INFO - Reading from file tmpfile_stdout 16:30:45 INFO - Output received: 16:30:45 INFO - /builds/slave/test/build/application/firefox/firefox 16:30:45 INFO - Running post-action listener: _resource_record_post_action 16:30:45 INFO - [mozharness: 2017-08-17 23:30:45.022465Z] Finished install step (success) 16:30:45 INFO - [mozharness: 2017-08-17 23:30:45.022609Z] Running setup-mitmproxy step. 16:30:45 INFO - Running pre-action listener: _resource_record_pre_action 16:30:45 INFO - Running main action method: setup_mitmproxy 16:30:45 INFO - Skipping: mitmproxy is not required 16:30:45 INFO - Running post-action listener: _resource_record_post_action 16:30:45 INFO - [mozharness: 2017-08-17 23:30:45.023159Z] Finished setup-mitmproxy step (success) 16:30:45 INFO - [mozharness: 2017-08-17 23:30:45.023263Z] Running run-tests step. 16:30:45 INFO - Running pre-action listener: _resource_record_pre_action 16:30:45 INFO - Running pre-action listener: _set_gcov_prefix 16:30:45 INFO - Running main action method: run_tests 16:30:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:30:45 INFO - Python 2.7.3 16:30:45 INFO - Return code: 0 16:30:45 INFO - grabbing minidump binary from tooltool 16:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:45 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 0x1e0c0b0>, '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 0x1e0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:30:45 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 16:30:45 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 16:30:45 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 16:30:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:30:45 INFO - Return code: 0 16:30:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:30:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:30:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:30:45 INFO - ENV: RUST_BACKTRACE is now full 16:30:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:30:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:30:45 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/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:30:45 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/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:30:45 INFO - Using env: {'DISPLAY': ':0', 16:30:45 INFO - 'HOME': '/home/cltbld', 16:30:45 INFO - 'LANG': 'en_US.UTF-8', 16:30:45 INFO - 'LANGUAGE': 'en_US:en', 16:30:45 INFO - 'LOGNAME': 'cltbld', 16:30:45 INFO - 'MAIL': '/var/mail/cltbld', 16:30:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:30:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:45 INFO - 'MOZ_NO_REMOTE': '1', 16:30:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:45 INFO - 'NO_EM_RESTART': '1', 16:30:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:45 INFO - 'PWD': '/builds/slave/test', 16:30:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:30:45 INFO - 'RUST_BACKTRACE': 'full', 16:30:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:30:45 INFO - 'SHELL': '/bin/bash', 16:30:45 INFO - 'SHLVL': '1', 16:30:45 INFO - 'TERM': 'linux', 16:30:45 INFO - 'TMOUT': '86400', 16:30:45 INFO - 'USER': 'cltbld', 16:30:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085', 16:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:45 INFO - '_': '/tools/buildbot/bin/python'} 16:30:45 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/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:30:45 INFO - mozversion application_buildid: 20170817221603 16:30:45 INFO - mozversion application_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:30:45 INFO - mozversion application_display_name: Nightly 16:30:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:30:45 INFO - mozversion application_name: Firefox 16:30:45 INFO - mozversion application_remotingname: firefox 16:30:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:30:45 INFO - mozversion application_vendor: Mozilla 16:30:45 INFO - mozversion application_version: 57.0a1 16:30:45 INFO - mozversion platform_buildid: 20170817221603 16:30:45 INFO - mozversion platform_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:30:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:30:45 INFO - mozversion platform_version: 57.0a1 16:30:45 INFO - using testdate: 1503012645 16:30:45 INFO - actual date: 1503012645 16:30:45 INFO - starting webserver on 'localhost:54328' 16:30:45 INFO - SUITE-START | Running 2 tests 16:30:45 INFO - TEST-START | dromaeo_css 16:30:45 INFO - Initialising browser for dromaeo_css test... 16:30:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54328/getInfo.html -profile /tmp/tmp2eHk2Y/profile 16:30:45 INFO - TEST-INFO | started process 9834 (/builds/slave/test/build/application/firefox/firefox http://localhost:54328/getInfo.html) 16:30:50 INFO - TEST-INFO | 9834: exit 0 16:30:50 INFO - Browser initialized. 16:30:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:30:50 INFO - TEST-INFO | started process 10007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2eHk2Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:51 INFO - PID 10007 | 16:30:51 INFO - PID 10007 | (/builds/slave/test/build/application/firefox/firefox:10056): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:30:51 INFO - PID 10007 | 16:31:02 INFO - PID 10007 | RSS: Main: 160571392 16:31:02 INFO - PID 10007 | 16:33:59 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54328/tests/dromaeo/cssquery-ext.html) 16:34:01 INFO - PID 10007 | RSS: Main: 165928960 16:34:01 INFO - PID 10007 | 16:37:02 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-ext.html (next: http://localhost:54328/tests/dromaeo/cssquery-jquery.html) 16:37:03 INFO - PID 10007 | RSS: Main: 163172352 16:37:03 INFO - PID 10007 | 16:40:04 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54328/tests/dromaeo/cssquery-mootools.html) 16:40:05 INFO - PID 10007 | RSS: Main: 165109760 16:40:05 INFO - PID 10007 | 16:43:06 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54328/tests/dromaeo/cssquery-prototype.html) 16:43:07 INFO - PID 10007 | RSS: Main: 163528704 16:43:07 INFO - PID 10007 | 16:46:10 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54328/tests/dromaeo/cssquery-yui.html) 16:46:11 INFO - PID 10007 | RSS: Main: 167112704 16:46:11 INFO - PID 10007 | 16:49:12 INFO - PID 10007 | Cycle 1(1): loaded http://localhost:54328/tests/dromaeo/cssquery-yui.html (next: http://localhost:54328/tests/dromaeo/cssquery-dojo.html) 16:49:13 INFO - PID 10007 | RSS: Main: 167542784 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | __start_tp_report 16:49:13 INFO - PID 10007 | _x_x_mozilla_page_load 16:49:13 INFO - PID 10007 | _x_x_mozilla_page_load_details 16:49:13 INFO - PID 10007 | |i|pagename|runs| 16:49:13 INFO - PID 10007 | |0;dojo.html;3458.9654103458975;3465.480177973304;3494.405950988332;3505.5618047744024;3513.5959364673054;6083.817485475432;6138.96930515348;6150.046742754869;6194.7831825886105;6228.096925945735;6049.032154855224;6090.908636370447;6091.817245482632;6124.846878828032;6184.56708030438;5402.702851343174;5418.106012507941;5439.456054394568;5440.211169380437;5518.834434966937;5495.6153069285165;5528.530074943635;5532.1425179097105;5534.584906132056;5544.944550554484;5458.099413596752;5491.752871120789;5513.952349053667;5596.328440587135;5609.214709940612;5297.894042119175;5416.322959630046;5417.45825417459;5473.808416705396;5484.232207490914;5406.756695948692;5407.83776486706;5467.535259502947;5471.72641367934;5476.945230547683;6038.396160383971;6077.726502307407;6092.573519853612;6110.419510146529;6143.754249830002;6643.236027856762;6667.366600173024;6680.432163266129;6691.364320389555;6729.327067293231;6716.059751634775;6774.254831968479;6802.795916122524;6809.863802723968;6839.726410943556;6190.845228869314;6300.684965751694;6328.398802113792;6333.619982801047;6343.714532846033;6903.896441553381;6910.689018994158;6918.584884906922;6966.442684585221;6990.196127445409;6431.2604050533855;6534.4445722113205;6577.473802095917;6598;6660.666966651648;6761.188657361148;6773.695183716744;6821.795346139525;6828.863422731518;6830.248672646005;6635.568688035262;6637.435817955527;6640.169978752656;6700.162479690039;6744.460443164535;6577.704003319862;6652.667366631649;6678.599284042973;6729.226138994079;6741.561798483083;4769.42766867978;4793.352897358882;4807.254875494304;4809.302651115569;4832.903341933142;4240.5123410808155;4279.122779830127;4291.249031419489;4294.785260737013;4344.782760862007;6223.253209614875;6278.6860656966965;6279.434850863444;6290.245170579468;6368.808935731936;6619.735210591522;6631.137952066297;6684.2981486944145;6711.026901099313;6725.562838415487;6168;6207.596506227081;6224.844378890564;6318.462930650946;6324.588901721466;5349.090654588729;5404.54061404785;5408.0535906216255;5421.593380496479;5450.155225939986;6960.9303906961295;6963.79108626742;7037.2962703730245;7043.718251269995;7064.43484521237;6655.534112612071;6659.334066593302;6738.989151627197;6741.831454213684;6754.527183097332;6851.657417129223;6956.373926346653;6967.233604303624;7026.9648651756415;7044.366007059184;6615.66921653925;6710.496712746466;6726.159230096238;6727.327267273234;6739.730410783513;6694.196696396269;6702.128723265944;6702.36327548882;6772.695228714621;6779.762708305186;6264.029075493306;6422.133012043314;6454.644994525346;6489.059086432535;6580.1116849226655;6567;6568.868622627425;6574.342565743387;6580.605163690194;6599.703013364314;6471.191101112361;6577.177852768404;6626.105475760711;6645.036469711961;6656.635389745187;6438.67806609677;6577.506686998398;6624.635645039569;6692.498062645223;6708.865822683617;6327.303996560283;6329.8734025320155;6398.616083035033;6400.263969643551;6402.93597064042 16:49:13 INFO - PID 10007 | |1;ext.html;904.9411788233766;912.6988093929;941.4774799986008;973.4354074636707;974.8391515399959;43485.347719784186;44605.33092003623;44620.10759784802;44717.55282447174;44729;41947.161056778925;42203;42207.36688949668;42269.788651056704;42339;7043.119610048731;7165.498415110945;7166.928330716678;7186.029885965406;7190.496665233436;7058.505904586681;7130;7132.07283053205;7145.85708285834;7147.642617869085;7059.541129826544;7109.253528379523;7113.573185608854;7142.464315176382;7143.642817859112;7026.156861176666;7087.964560177218;7088.893666595005;7092.9290707093305;7097.041899343574;6471.83820404489;6485.643289619069;6487.772927947546;6488.0916671666;6554.672266386709;36378.27243455143;36578.8171059143;36674.81662591697;36684;36703.265934681156;3291.4075466416275;3327.317899830529;3329.3840639481773;3337.8164200968936;3338.4157772389976;29011.709882901112;29126.41747165045;29154.416911661647;29172.854135729187;29237.561436578468;4385.2106620808245;4442.933355999663;4561;4601.654875884322;4676.55572720591;207382;208772;210013;214792;223125.88437057874;54236;54334.45665543373;54371;54495.182572261445;54533.18200227;55222.44777552173;55317;55317.723411382685;55559;55977.72011139918;15998.680026399406;16405.91797041007;16559.83440165607;16563.171841408122;16585.50243492697;12879.42042608085;12880.742385152245;12886.033547483976;12886.548970786165;12887.226766394046;14454.988150829551;14460.13239205651;14522.927385363006;14573.854261457462;14736.926315368355;5706.4864162225595;5850.356460789395;5890.528757699374;5921.67430791302;5929.970350148308;1088.7713580148259;1093.3439936038471;1097.7091070866227;1113.716002419378;1115.5314767797545;24621.5075698485;24659.630105548433;24882;24887.377815554755;25103.246902592953;1189.262657152571;1191.3566673996118;1197.5928284265954;1199.580146948561;1204.584418375659;12974.870251297554;13073.411696473682;13211.14127581704;13214.207147571176;13263.801042984363;257154.71422642766;257932;259223;259260;259737;56614.7169264151;56837.715811421505;56963;57247.14129288064;57343.71328143332;1513.954581362561;1537.0547113525101;1566.6553358261392;1577.242923396753;1577.9053256804398;24782.256532304058;24788.903493049776;30757.53863692091;30984.486873508173;31250;56541;56581.71709141593;56829.71585142213;57232.713836432216;57238;240105;240111;240779.79610101838;240809;241247;37167.442488362154;38928.221435570566;39315;39460;39475.60524394719;49993;51502.22746658728;51693.48306516887;51901.480985189664;52065.47934520606;36917.63082369142;37118;37280.44079338758;37604.435933460474;37664.81167594145;36260.81869590635;36827.447588285664;36921.63078369182;37019.814900925325;37644.05889852776;42540.787296063325;42589.36115958325;42589.36115958325;42880.78559607182;43901.341479878465;36037;36125.27749445049;36281.185940703384;36736.63263367332;37099.62900370962;26096.478070438865;26163.476730465663;26306.605400919383;26704.599431008162;26930.057447989228 16:49:13 INFO - PID 10007 | |2;jquery.html;569.9373068962414;571.5513322042198;573.3807487913055;579.9536037117031;586.9589128760987;23297.767022329794;23566.882165589148;24328.27015189545;24726.13458528954;24776.256712298615;27425;28165.29586760327;28170.577441338395;28203.012894548694;28245.43509129821;6300.8739825203465;6466.224053113633;6476.579022363531;6477;6481.31946145655;6189.659568723719;6243.781467648633;6246.312905580383;6444.258910225337;6488.61068335899;6445.419912207901;6460.806175814733;6462.192225971754;6474.546781725281;6476.838079048038;6444.774432894873;6450.806475805757;6463.612183268995;6464.806055818286;6471.611703297794;5968.134620480006;5976.372480889488;5982;6001.849953751147;6001.909971350433;31089;31151.84424077888;31515.21211969696;32675.6732432675;32912.17719557006;2274.5223503064376;2281.885905704708;2282.931512054641;2304.055337311694;2311.28350211435;20568.177272909066;21098.26156084545;21132.366029019155;21166.470838229012;21171.788282117137;2397.29279862441;2452.7547245275327;2501.0996041425074;2565.756253155947;2581.238534632288;158918;162492;163095;163157;163581.18209408995;15090.623719121551;15871;16043.919780401024;16107.275172617261;16410.753838692428;23677.289681309587;24286.878565607058;24306.756932430802;24508.632370514457;24588.139415120386;10834.133269338434;10882.891171088346;10964.56141754337;10986.395748233925;11038.227324087398;10041.748956276006;10052.798944021079;10106.747331316776;10115.291929565006;10193.490325483695;10051.24615653829;10125.392476451436;10211.132053775513;10315.432651204106;10419;2859.985700071528;2868.1395581325937;2874.2813052243737;2908.1420980810713;3016.2007068126964;1048.3238311289329;1048.8846226915034;1060.5492665617082;1079.6491140379408;1081.1080858291784;21382;22149.446263843533;22196.556068878534;22627.718980748028;22652.660210096863;1068.540527573151;1110.245033377311;1111.572044762772;1119.7928383248961;1138.6413279816832;11826;11864.525418983316;11954.76090478203;11955.462004209832;11963.88036119645;650247;652393;669815;670292;675048;142353;149636;150909;153965.23017384842;154698;1314.5399110311505;1314.8685131486775;1358.6195865157772;1365.808786769853;1375.408574313055;22833.885830571406;22852.200172993864;22921.083156673547;23177.18879839265;23346;64757;65106.674466627366;65932.34067659262;66570.33429665641;68278;83417.58291208505;87081.56459217917;87828;88268;88437;14962.625934351729;15014;15156.621084472976;15306.693866122838;15318;24638.87680561586;24726.381840454134;24812.627810583217;24995.75004249934;25396.365090872878;19656.508587285432;19714.901425492782;19899.900500497406;19920;19932;17739.733903991193;17868.374606888698;18114.637707245518;18290.908545457187;18548.721769173204;20591;20910.790892090885;20915.26796562113;20974.2659006934;21061.684074739198;14954;15019.173945433105;15060.849391505944;15077.623059423602;15118.773218401513;20058.598828023067;20132.798672013094;20151.79848201499;20352.694709579664;20400.795992040483 16:49:13 INFO - PID 10007 | |3;mootools.html;1438.654722866512;1470.397137173759;1486.4797320937666;1495.4616338118283;1526.519146468862;15618.453354132607;16307.347706091758;16315.592110197236;16318.102504362256;16336;15330.233488325566;16383.83616163838;16385.83614163858;16394.180290985463;16412.425565105223;2660.6009098635213;2695.218386667864;2696.3798326384945;2705.7970652201066;2707.7698395636394;2602.206327070243;2606.1399738086384;2644.788416926651;2697.8111532192756;2698.689650690176;2659.8670066496693;2679.7454241846995;2685.087070396065;2686.073304709872;2687.50281197979;2431.63525471179;2470.3330100872754;2470.4564995700916;2588.6117082437786;2638.736126387365;2560.8463492190526;2563.5641940870096;2586.6508021417058;2607.361196506849;2651.880665370063;16138.919305403515;16241.837581624151;16255.51233462998;16258.918705406515;16261.349546018146;8055.15420880805;8318.292945099674;8335.458195217352;8338.583070846433;8340.040895297057;4823.300621409911;5069.645124841262;5138.434772175057;5159.458256883048;5177;1868.3460788723974;1889.1121173048782;1893.870487184901;1910.360029390156;1926.8265856073021;29383.412331753458;29423.2644183895;29458.410831783458;29636.110916672533;29640.25899352512;6737.831554211184;6745;6765;6921.688524016431;6966.12923384577;19702.21191152338;19773.307934222234;19775.60448791016;19792.802071979095;19795.218430341338;8167;8292.917070829215;8300.501969881827;8300.584970751439;8303.04514980773;7574.204708505637;7583.203763604853;7726.613669316512;7760.650770715331;7763.844723105619;5316.521513063843;5562.499375056264;5566.443355664482;5590.413006634326;5599.160125981135;1412.4067891485602;1474.9188794616184;1509.0492989416598;1563.5309407177801;1595.5372941846967;962.7208109648124;970.4811969268073;974.1086905481405;983.7638966647953;989.1394486796534;9132.406393584395;9164.816703665889;9226.446413215095;9251.398659087137;9321.067893210624;1030.7886883188928;1032.3083534032216;1065.63235683689;1068.9037986581245;1069.5667805141147;4842.709437433765;5119.564836988823;5841.240638717025;5884.411558844081;5994.940050599525;23353.299401017655;24285.514289714105;24373;24420.63369049466;24436;22964.425889352566;23731.28806135784;23820.52358952811;23953.52092958166;24186.637200442008;12648.304343261025;12794.552190673468;12854.55009074678;12895;12944.41750121228;8950.82098358016;9075.50084745319;9247.213986811197;9250.2137318326;9356;20183.798162018193;20301.49246268855;20760.584788303848;21158.47103822417;21329.360119196448;21161.365159045254;21598.460038499165;21769.891150544147;21861;21946.45133871666;12047;12221.083418743452;12347.62957111288;12388.876111239133;12415.503379864704;14944.626384340478;15028.323725432601;15166.696666066837;15168;15233.771493427828;11711.414429278673;11724.58963936258;11949.22330048544;12162.75674486523;12230.082743794073;11469.820734060502;11646.76706465849;11672.182947193955;12093.093018023508;12123.393830308625;10193.949030254802;10271.794564108826;10295.897041029793;10300.124489418484;10313.22650801208;7216.675249613885;7348.265173482609;7432.814179645552;8052.15452377492;8180.713675021346;8586.570671466277;8648.481091134552;8683.305335573014;8697.391182617155;8711.825763484569 16:49:13 INFO - PID 10007 | |4;prototype.html;508.54485235714026;511.2101802714805;527.8996990571791;533.4975883325965;538.9353277606688;6146.477549408294;6236.3205708631895;6263.185785847833;6278.874422511552;6310.274318453379;6159.8768024639485;6181.414779427932;6181.6600086995195;6187.628742275467;6203.193584833976;4930.8767280818;4962.627802914796;4964.131277026506;4972.502749725035;4974.990130970765;4699.38907941967;4844.543020421203;4888.73111978841;4906.786055133875;4914.729689867056;4753.310769938357;4768.952310476903;4781.3784208053075;4793.856184314476;4825.445073816503;4827.227643577046;4842;4843.200871856139;4846.660733748639;4848.181931775584;4359.258925982559;4365.563443655641;4368.012554287823;4371.912561748779;4391.648668106575;6032.758689652409;6074.119252708377;6103.389661033905;6120.846978825565;6138.600990935575;5752.654840709571;5756.971215143939;5805.535557155417;5827.941720582782;5847.26909136358;6579.914314138209;6635.170603674541;6636.800895973129;6645.60126392418;6684.498662600276;4867.634927380425;4889.242167464049;4948.777305021283;4974.925376119361;4991;6695.363940425652;6701.961196014626;6799.830004249933;6870.141232345957;7044.189918159426;5049;5061.417936937226;5087.440381558025;5115.462876397924;5134.152864777345;5106.46805958211;5135.974320128375;5173.068847607392;5183.844484665466;5187.170052791535;5739.053056245672;5746.798862039892;5771.5671324649975;5777.277840269966;5783.71081445926;6583.440407565315;6608.744338575655;6632.1709786276715;6638.340414896276;6703.229128650268;1776.342753181331;1795.093477793706;1797.640471905624;1807.4667972948012;1811.7735283089614;1201.3332600406684;1237.622525129826;1254.6988722706485;1255.7614053329837;1272.351100938528;6203.720832562455;6313.337099604567;6344.809655710336;6357.043974551763;6411.711472983727;6648.700808463631;6666.366740148695;6750.189977202767;6772.492063095189;6804.659767011729;6276.529260305495;6295.464885484785;6318.399752023551;6349.206349206349;6367.363263673688;3498.58017037952;3541.3094446583186;3553.786772793589;3596.3346780845627;3612.945805812915;6963.059986901703;7009.754658587027;7025.754098606524;7066.717331306793;7100.893486597705;6565.540412171198;6873.934540146285;6914.619695916773;6955.339242771928;7019.3682568569075;6890.896636550456;6972.44220462372;7016.473764467685;7017.89473157903;7067.399271062018;6658.400743933069;6697.129373181455;6700.564463309869;6747.426468750211;6845.794626161223;6614.371634694697;6652.90020649681;6711.463082953254;6743.662816859235;6753.898691519729;7105.812756687544;7122.501424900207;7128.501004929605;7144.3212894774915;7146.571205727673;5089.872753181052;5138.614603904647;5165.690058596496;5177.4822517749435;5186.766595503136;6622.437092847162;6651.73393064272;6712.530122891546;6787.524873258824;6803.367191874014;6509.4051957268875;6531.379518945692;6541.476681865344;6594.439472644879;6630.3092711358295;6516.771912983023;6541.70562324687;6582.1696670432175;6607.900881486878;6613.2394774601535;6323;6506.186726659168;6515;6535.44448721864;6606.372394622503;6568.474522038321;6619.669016549057;6621.71550814968;6634.601923884582;6673.599584024974;6351.428371446592;6369.681515924092;6443.581167224115;6450.225972883284;6459.741610335534 16:49:13 INFO - PID 10007 | |5;yui.html;914.4558987402493;924.8936372317183;940.8259471997677;949.2121539122529;953.1469334945222;19347.322843700473;20215.898920505395;20269.885156316413;20299.695504567444;21342.46643833905;21196.89401552994;22903.77096229037;23025.4243643909;23122.88438557809;23125.19061832836;995.5121990224774;1013.6857574152;1017.3895662602454;1017.7811770469348;1018.6231094495047;1029.8918613545582;1071.59815069349;1080.3409919948824;1085.8588383510173;1099.2415233488907;1141;1149.0290704354848;1149.3678476837706;1150.2465884845399;1150.7583407484397;1135.9261647992853;1139.191174266272;1140.9372484513349;1144.7882141803752;1146.0430540498653;831.3598529132535;839.6977088248226;841.154639587217;841.47828346425;843.3674743942044;19386.903065484723;19537.316193933144;19539.218431262732;19573.314933977384;20030.69953950692;22419.663705044437;22968.196113136128;23193.768062319497;23436.64845027326;23455.179068732683;17037.48887533376;17056.48830535086;17304.221310041077;17461.82538174615;17563.385281515086;3789.696824254053;3791.9810400948095;3807.8857634271017;3822.9808850955847;3826.081740382288;153242;153973.23013384972;154794.22602887137;155141;155261;17326.3069477222;17449.302027918995;17906.641867162845;17963.550911227325;18040.18819153141;33304;34065.65934340675;34086.48870266948;34145.65854341474;34487.310253794785;7670.7698769037015;8023.1575684553445;8940.195382415613;9311.580978855967;9823.508824558743;4543.61379282758;4650.302454631765;4657.208274593328;4658.86023419298;4662.32396302541;5556.499915007668;5636.2954630671165;5760.769569217185;5761.049426844607;5761.971190144106;1142.6457798082454;1186.507599346279;1201.6274954763876;1203.8374819399269;1205.0540325844345;724.4964749499153;738.6048464071696;745.37760969591;751.9285667861544;760.7945854619333;12210.877891220975;12241.816372754416;13061.08572399923;13142.671433214055;13237.470501180038;693.9791806245821;700.4291502425507;708.3553965891015;712.5866997141645;717.1394326807851;5940.405959404112;6053.182820319201;6169.259688837368;6739.966300168468;6998.510104292753;139254;144170;144173.27913360365;145413.27293363467;152677.23661381623;127372;133588.33205834104;133928;134562;138472;116686.41656791662;117736.41131794457;117971.41014294873;118888.40555797338;119001;13390.799138012742;13841.653958650712;14036.2981850905;14037.368318425491;14077.225752583707;50232.748836257044;50307.49692503028;50798;50955.74522127365;52488;67532;67907;68840.65579672069;69288.6535567319;69377;16408;20644.587108258052;20735.68896466524;21556.89221553882;21593.13627454884;19716.704249436556;21652;22727.77272227323;22740.772592273865;22822.65766013478;19284.71072933879;19392.321268755524;19436;19528;19581.314653987043;19887.801121988596;20120.899395503515;20139.39581812548;20234.392968210977;20249.39251822448;20183.899080504503;20441.693374599094;20508.282210122576;20522;20640.380788576367;15117.319720612819;15609.297581608627;15621.609459763597;15638.905276630527;15864.682706346039;15639.843601563838;16009.919950400174;16127.516174514783;16250.593735156242;16267.837321626632 16:49:13 INFO - PID 10007 | __end_tp_report 16:49:13 INFO - PID 10007 | __start_cc_report 16:49:13 INFO - PID 10007 | _x_x_mozilla_cycle_collect,329 16:49:13 INFO - PID 10007 | __end_cc_report 16:49:13 INFO - PID 10007 | __startTimestamp1503013753158__endTimestamp 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | ------- Summary: start ------- 16:49:13 INFO - PID 10007 | Number of tests: 6 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#0] dojo.html Cycles:165 Average:6153.62 Median:6431.26 stddev:803.67 (12.5%) stddev-sans-first:777.84 16:49:13 INFO - PID 10007 | Values: 3459.0 3465.5 3494.4 3505.6 3513.6 6083.8 6139.0 6150.0 6194.8 6228.1 6049.0 6090.9 6091.8 6124.8 6184.6 5402.7 5418.1 5439.5 5440.2 5518.8 5495.6 5528.5 5532.1 5534.6 5544.9 5458.1 5491.8 5514.0 5596.3 5609.2 5297.9 5416.3 5417.5 5473.8 5484.2 5406.8 5407.8 5467.5 5471.7 5476.9 6038.4 6077.7 6092.6 6110.4 6143.8 6643.2 6667.4 6680.4 6691.4 6729.3 6716.1 6774.3 6802.8 6809.9 6839.7 6190.8 6300.7 6328.4 6333.6 6343.7 6903.9 6910.7 6918.6 6966.4 6990.2 6431.3 6534.4 6577.5 6598.0 6660.7 6761.2 6773.7 6821.8 6828.9 6830.2 6635.6 6637.4 6640.2 6700.2 6744.5 6577.7 6652.7 6678.6 6729.2 6741.6 4769.4 4793.4 4807.3 4809.3 4832.9 4240.5 4279.1 4291.2 4294.8 4344.8 6223.3 6278.7 6279.4 6290.2 6368.8 6619.7 6631.1 6684.3 6711.0 6725.6 6168.0 6207.6 6224.8 6318.5 6324.6 5349.1 5404.5 5408.1 5421.6 5450.2 6960.9 6963.8 7037.3 7043.7 7064.4 6655.5 6659.3 6739.0 6741.8 6754.5 6851.7 6956.4 6967.2 7027.0 7044.4 6615.7 6710.5 6726.2 6727.3 6739.7 6694.2 6702.1 6702.4 6772.7 6779.8 6264.0 6422.1 6454.6 6489.1 6580.1 6567.0 6568.9 6574.3 6580.6 6599.7 6471.2 6577.2 6626.1 6645.0 6656.6 6438.7 6577.5 6624.6 6692.5 6708.9 6327.3 6329.9 6398.6 6400.3 6402.9 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#1] ext.html Cycles:180 Average:42288.56 Median:37142.72 stddev:61989.65 (166.9%) stddev-sans-first:62085.67 16:49:13 INFO - PID 10007 | Values: 904.9 912.7 941.5 973.4 974.8 43485.3 44605.3 44620.1 44717.6 44729.0 41947.2 42203.0 42207.4 42269.8 42339.0 7043.1 7165.5 7166.9 7186.0 7190.5 7058.5 7130.0 7132.1 7145.9 7147.6 7059.5 7109.3 7113.6 7142.5 7143.6 7026.2 7088.0 7088.9 7092.9 7097.0 6471.8 6485.6 6487.8 6488.1 6554.7 36378.3 36578.8 36674.8 36684.0 36703.3 3291.4 3327.3 3329.4 3337.8 3338.4 29011.7 29126.4 29154.4 29172.9 29237.6 4385.2 4442.9 4561.0 4601.7 4676.6 207382.0 208772.0 210013.0 214792.0 223125.9 54236.0 54334.5 54371.0 54495.2 54533.2 55222.4 55317.0 55317.7 55559.0 55977.7 15998.7 16405.9 16559.8 16563.2 16585.5 12879.4 12880.7 12886.0 12886.5 12887.2 14455.0 14460.1 14522.9 14573.9 14736.9 5706.5 5850.4 5890.5 5921.7 5930.0 1088.8 1093.3 1097.7 1113.7 1115.5 24621.5 24659.6 24882.0 24887.4 25103.2 1189.3 1191.4 1197.6 1199.6 1204.6 12974.9 13073.4 13211.1 13214.2 13263.8 257154.7 257932.0 259223.0 259260.0 259737.0 56614.7 56837.7 56963.0 57247.1 57343.7 1514.0 1537.1 1566.7 1577.2 1577.9 24782.3 24788.9 30757.5 30984.5 31250.0 56541.0 56581.7 56829.7 57232.7 57238.0 240105.0 240111.0 240779.8 240809.0 241247.0 37167.4 38928.2 39315.0 39460.0 39475.6 49993.0 51502.2 51693.5 51901.5 52065.5 36917.6 37118.0 37280.4 37604.4 37664.8 36260.8 36827.4 36921.6 37019.8 37644.1 42540.8 42589.4 42589.4 42880.8 43901.3 36037.0 36125.3 36281.2 36736.6 37099.6 26096.5 26163.5 26306.6 26704.6 26930.1 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#2] jquery.html Cycles:180 Average:42792.81 Median:2278.20 stddev:111291.22 (4885.0%) stddev-sans-first:111558.27 16:49:13 INFO - PID 10007 | Values: 569.9 571.6 573.4 580.0 587.0 23297.8 23566.9 24328.3 24726.1 24776.3 27425.0 28165.3 28170.6 28203.0 28245.4 6300.9 6466.2 6476.6 6477.0 6481.3 6189.7 6243.8 6246.3 6444.3 6488.6 6445.4 6460.8 6462.2 6474.5 6476.8 6444.8 6450.8 6463.6 6464.8 6471.6 5968.1 5976.4 5982.0 6001.8 6001.9 31089.0 31151.8 31515.2 32675.7 32912.2 2274.5 2281.9 2282.9 2304.1 2311.3 20568.2 21098.3 21132.4 21166.5 21171.8 2397.3 2452.8 2501.1 2565.8 2581.2 158918.0 162492.0 163095.0 163157.0 163581.2 15090.6 15871.0 16043.9 16107.3 16410.8 23677.3 24286.9 24306.8 24508.6 24588.1 10834.1 10882.9 10964.6 10986.4 11038.2 10041.7 10052.8 10106.7 10115.3 10193.5 10051.2 10125.4 10211.1 10315.4 10419.0 2860.0 2868.1 2874.3 2908.1 3016.2 1048.3 1048.9 1060.5 1079.6 1081.1 21382.0 22149.4 22196.6 22627.7 22652.7 1068.5 1110.2 1111.6 1119.8 1138.6 11826.0 11864.5 11954.8 11955.5 11963.9 650247.0 652393.0 669815.0 670292.0 675048.0 142353.0 149636.0 150909.0 153965.2 154698.0 1314.5 1314.9 1358.6 1365.8 1375.4 22833.9 22852.2 22921.1 23177.2 23346.0 64757.0 65106.7 65932.3 66570.3 68278.0 83417.6 87081.6 87828.0 88268.0 88437.0 14962.6 15014.0 15156.6 15306.7 15318.0 24638.9 24726.4 24812.6 24995.8 25396.4 19656.5 19714.9 19899.9 19920.0 19932.0 17739.7 17868.4 18114.6 18290.9 18548.7 20591.0 20910.8 20915.3 20974.3 21061.7 14954.0 15019.2 15060.8 15077.6 15118.8 20058.6 20132.8 20151.8 20352.7 20400.8 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#3] mootools.html Cycles:180 Average:10122.22 Median:13453.17 stddev:7506.83 (55.8%) stddev-sans-first:7499.54 16:49:13 INFO - PID 10007 | Values: 1438.7 1470.4 1486.5 1495.5 1526.5 15618.5 16307.3 16315.6 16318.1 16336.0 15330.2 16383.8 16385.8 16394.2 16412.4 2660.6 2695.2 2696.4 2705.8 2707.8 2602.2 2606.1 2644.8 2697.8 2698.7 2659.9 2679.7 2685.1 2686.1 2687.5 2431.6 2470.3 2470.5 2588.6 2638.7 2560.8 2563.6 2586.7 2607.4 2651.9 16138.9 16241.8 16255.5 16258.9 16261.3 8055.2 8318.3 8335.5 8338.6 8340.0 4823.3 5069.6 5138.4 5159.5 5177.0 1868.3 1889.1 1893.9 1910.4 1926.8 29383.4 29423.3 29458.4 29636.1 29640.3 6737.8 6745.0 6765.0 6921.7 6966.1 19702.2 19773.3 19775.6 19792.8 19795.2 8167.0 8292.9 8300.5 8300.6 8303.0 7574.2 7583.2 7726.6 7760.7 7763.8 5316.5 5562.5 5566.4 5590.4 5599.2 1412.4 1474.9 1509.0 1563.5 1595.5 962.7 970.5 974.1 983.8 989.1 9132.4 9164.8 9226.4 9251.4 9321.1 1030.8 1032.3 1065.6 1068.9 1069.6 4842.7 5119.6 5841.2 5884.4 5994.9 23353.3 24285.5 24373.0 24420.6 24436.0 22964.4 23731.3 23820.5 23953.5 24186.6 12648.3 12794.6 12854.6 12895.0 12944.4 8950.8 9075.5 9247.2 9250.2 9356.0 20183.8 20301.5 20760.6 21158.5 21329.4 21161.4 21598.5 21769.9 21861.0 21946.5 12047.0 12221.1 12347.6 12388.9 12415.5 14944.6 15028.3 15166.7 15168.0 15233.8 11711.4 11724.6 11949.2 12162.8 12230.1 11469.8 11646.8 11672.2 12093.1 12123.4 10193.9 10271.8 10295.9 10300.1 10313.2 7216.7 7348.3 7432.8 8052.2 8180.7 8586.6 8648.5 8683.3 8697.4 8711.8 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#4] prototype.html Cycles:180 Average:5601.49 Median:6287.17 stddev:1597.41 (25.4%) stddev-sans-first:1555.48 16:49:13 INFO - PID 10007 | Values: 508.5 511.2 527.9 533.5 538.9 6146.5 6236.3 6263.2 6278.9 6310.3 6159.9 6181.4 6181.7 6187.6 6203.2 4930.9 4962.6 4964.1 4972.5 4975.0 4699.4 4844.5 4888.7 4906.8 4914.7 4753.3 4769.0 4781.4 4793.9 4825.4 4827.2 4842.0 4843.2 4846.7 4848.2 4359.3 4365.6 4368.0 4371.9 4391.6 6032.8 6074.1 6103.4 6120.8 6138.6 5752.7 5757.0 5805.5 5827.9 5847.3 6579.9 6635.2 6636.8 6645.6 6684.5 4867.6 4889.2 4948.8 4974.9 4991.0 6695.4 6702.0 6799.8 6870.1 7044.2 5049.0 5061.4 5087.4 5115.5 5134.2 5106.5 5136.0 5173.1 5183.8 5187.2 5739.1 5746.8 5771.6 5777.3 5783.7 6583.4 6608.7 6632.2 6638.3 6703.2 1776.3 1795.1 1797.6 1807.5 1811.8 1201.3 1237.6 1254.7 1255.8 1272.4 6203.7 6313.3 6344.8 6357.0 6411.7 6648.7 6666.4 6750.2 6772.5 6804.7 6276.5 6295.5 6318.4 6349.2 6367.4 3498.6 3541.3 3553.8 3596.3 3612.9 6963.1 7009.8 7025.8 7066.7 7100.9 6565.5 6873.9 6914.6 6955.3 7019.4 6890.9 6972.4 7016.5 7017.9 7067.4 6658.4 6697.1 6700.6 6747.4 6845.8 6614.4 6652.9 6711.5 6743.7 6753.9 7105.8 7122.5 7128.5 7144.3 7146.6 5089.9 5138.6 5165.7 5177.5 5186.8 6622.4 6651.7 6712.5 6787.5 6803.4 6509.4 6531.4 6541.5 6594.4 6630.3 6516.8 6541.7 6582.2 6607.9 6613.2 6323.0 6506.2 6515.0 6535.4 6606.4 6568.5 6619.7 6621.7 6634.6 6673.6 6351.4 6369.7 6443.6 6450.2 6459.7 16:49:13 INFO - PID 10007 | 16:49:13 INFO - PID 10007 | [#5] yui.html Cycles:180 Average:28445.02 Median:20199.90 stddev:41508.60 (205.5%) stddev-sans-first:41573.57 16:49:13 INFO - PID 10007 | Values: 914.5 924.9 940.8 949.2 953.1 19347.3 20215.9 20269.9 20299.7 21342.5 21196.9 22903.8 23025.4 23122.9 23125.2 995.5 1013.7 1017.4 1017.8 1018.6 1029.9 1071.6 1080.3 1085.9 1099.2 1141.0 1149.0 1149.4 1150.2 1150.8 1135.9 1139.2 1140.9 1144.8 1146.0 831.4 839.7 841.2 841.5 843.4 19386.9 19537.3 19539.2 19573.3 20030.7 22419.7 22968.2 23193.8 23436.6 23455.2 17037.5 17056.5 17304.2 17461.8 17563.4 3789.7 3792.0 3807.9 3823.0 3826.1 153242.0 153973.2 154794.2 155141.0 155261.0 17326.3 17449.3 17906.6 17963.6 18040.2 33304.0 34065.7 34086.5 34145.7 34487.3 7670.8 8023.2 8940.2 9311.6 9823.5 4543.6 4650.3 4657.2 4658.9 4662.3 5556.5 5636.3 5760.8 5761.0 5762.0 1142.6 1186.5 1201.6 1203.8 1205.1 724.5 738.6 745.4 751.9 760.8 12210.9 12241.8 13061.1 13142.7 13237.5 694.0 700.4 708.4 712.6 717.1 5940.4 6053.2 6169.3 6740.0 6998.5 139254.0 144170.0 144173.3 145413.3 152677.2 127372.0 133588.3 133928.0 134562.0 138472.0 116686.4 117736.4 117971.4 118888.4 119001.0 13390.8 13841.7 14036.3 14037.4 14077.2 50232.7 50307.5 50798.0 50955.7 52488.0 67532.0 67907.0 68840.7 69288.7 69377.0 16408.0 20644.6 20735.7 21556.9 21593.1 19716.7 21652.0 22727.8 22740.8 22822.7 19284.7 19392.3 19436.0 19528.0 19581.3 19887.8 20120.9 20139.4 20234.4 20249.4 20183.9 20441.7 20508.3 20522.0 20640.4 15117.3 15609.3 15621.6 15638.9 15864.7 15639.8 16009.9 16127.5 16250.6 16267.8 16:49:13 INFO - PID 10007 | -------- Summary: end -------- 16:49:13 INFO - PID 10007 | 16:49:13 INFO - TEST-INFO | 10007: exit 0 16:49:13 INFO - TEST-OK | dromaeo_css | took 1108420ms 16:49:13 INFO - TEST-START | kraken 16:49:13 INFO - Initialising browser for kraken test... 16:49:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54328/getInfo.html -profile /tmp/tmpogJzP2/profile 16:49:13 INFO - TEST-INFO | started process 10376 (/builds/slave/test/build/application/firefox/firefox http://localhost:54328/getInfo.html) 16:49:19 INFO - TEST-INFO | 10376: exit 0 16:49:19 INFO - Browser initialized. 16:49:19 INFO - Running cycle 1/1 for kraken test... 16:49:19 INFO - TEST-INFO | started process 10553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpogJzP2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:20 INFO - PID 10553 | 16:49:20 INFO - PID 10553 | (/builds/slave/test/build/application/firefox/firefox:10601): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:49:20 INFO - PID 10553 | 16:49:30 INFO - PID 10553 | RSS: Main: 157589504 16:49:30 INFO - PID 10553 | 16:49:32 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54328/tests/kraken/driver.html?testName=audio-beat-detection) 16:49:33 INFO - PID 10553 | RSS: Main: 162996224 16:49:33 INFO - PID 10553 | 16:49:36 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54328/tests/kraken/driver.html?testName=audio-dft) 16:49:36 INFO - PID 10553 | RSS: Main: 166916096 16:49:36 INFO - PID 10553 | 16:49:39 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54328/tests/kraken/driver.html?testName=audio-fft) 16:49:40 INFO - PID 10553 | RSS: Main: 161226752 16:49:40 INFO - PID 10553 | 16:49:42 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54328/tests/kraken/driver.html?testName=audio-oscillator) 16:49:43 INFO - PID 10553 | RSS: Main: 161968128 16:49:43 INFO - PID 10553 | 16:49:45 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:45 INFO - PID 10553 | RSS: Main: 162062336 16:49:45 INFO - PID 10553 | 16:49:48 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54328/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:49 INFO - PID 10553 | RSS: Main: 161693696 16:49:49 INFO - PID 10553 | 16:49:53 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54328/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:53 INFO - PID 10553 | RSS: Main: 165433344 16:49:53 INFO - PID 10553 | 16:49:56 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54328/tests/kraken/driver.html?testName=json-parse-financial) 16:49:57 INFO - PID 10553 | RSS: Main: 164245504 16:49:57 INFO - PID 10553 | 16:49:58 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:59 INFO - PID 10553 | RSS: Main: 164061184 16:49:59 INFO - PID 10553 | 16:50:00 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:01 INFO - PID 10553 | RSS: Main: 164728832 16:50:01 INFO - PID 10553 | 16:50:03 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:04 INFO - PID 10553 | RSS: Main: 164470784 16:50:04 INFO - PID 10553 | 16:50:06 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:07 INFO - PID 10553 | RSS: Main: 164163584 16:50:07 INFO - PID 10553 | 16:50:10 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:50:10 INFO - PID 10553 | RSS: Main: 164691968 16:50:10 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | Cycle 1(1): loaded http://localhost:54328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54328/tests/kraken/driver.html?testName=ai-astar) 16:50:12 INFO - PID 10553 | RSS: Main: 166617088 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | __start_tp_report 16:50:12 INFO - PID 10553 | _x_x_mozilla_page_load 16:50:12 INFO - PID 10553 | _x_x_mozilla_page_load_details 16:50:12 INFO - PID 10553 | |i|pagename|runs| 16:50:12 INFO - PID 10553 | |0;ai-astar;98;109;100;108;107;107;106;97;108;111 16:50:12 INFO - PID 10553 | |1;audio-beat-detection;142;113;151;166;114;140;138;114;169;114 16:50:12 INFO - PID 10553 | |2;audio-dft;165;162;163;162;163;162;162;163;168;169 16:50:12 INFO - PID 10553 | |3;audio-fft;74;78;73;134;74;83;73;88;91;74 16:50:12 INFO - PID 10553 | |4;audio-oscillator;78;78;131;78;77;78;129;78;78;126 16:50:12 INFO - PID 10553 | |5;imaging-gaussian-blur;114;115;115;113;114;114;115;114;114;114 16:50:12 INFO - PID 10553 | |6;imaging-darkroom;147;151;148;149;148;148;147;148;147;148 16:50:12 INFO - PID 10553 | |7;imaging-desaturate;94;100;99;99;94;94;94;94;94;96 16:50:12 INFO - PID 10553 | |8;json-parse-financial;48;51;47;48;49;47;47;47;49;47 16:50:12 INFO - PID 10553 | |9;json-stringify-tinderbox;55;55;54;55;55;55;54;54;54;55 16:50:12 INFO - PID 10553 | |10;stanford-crypto-aes;74;72;76;70;71;71;71;73;73;73 16:50:12 INFO - PID 10553 | |11;stanford-crypto-ccm;114;115;129;122;114;121;118;111;114;156 16:50:12 INFO - PID 10553 | |12;stanford-crypto-pbkdf2;164;162;169;162;173;164;161;162;170;165 16:50:12 INFO - PID 10553 | |13;stanford-crypto-sha256-iterative;63;62;63;62;62;62;67;63;60;60 16:50:12 INFO - PID 10553 | __end_tp_report 16:50:12 INFO - PID 10553 | __start_cc_report 16:50:12 INFO - PID 10553 | _x_x_mozilla_cycle_collect,829 16:50:12 INFO - PID 10553 | __end_cc_report 16:50:12 INFO - PID 10553 | __startTimestamp1503013812825__endTimestamp 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | ------- Summary: start ------- 16:50:12 INFO - PID 10553 | Number of tests: 14 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#0] ai-astar Cycles:10 Average:105.10 Median:108.50 stddev:4.91 (4.5%) stddev-sans-first:4.48 16:50:12 INFO - PID 10553 | Values: 98.0 109.0 100.0 108.0 107.0 107.0 106.0 97.0 108.0 111.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:141.00 stddev:21.73 (15.4%) stddev-sans-first:22.95 16:50:12 INFO - PID 10553 | Values: 142.0 113.0 151.0 166.0 114.0 140.0 138.0 114.0 169.0 114.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.60 (1.6%) stddev-sans-first:2.73 16:50:12 INFO - PID 10553 | Values: 165.0 162.0 163.0 162.0 163.0 162.0 162.0 163.0 168.0 169.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:18.69 (24.6%) stddev-sans-first:19.46 16:50:12 INFO - PID 10553 | Values: 74.0 78.0 73.0 134.0 74.0 83.0 73.0 88.0 91.0 74.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:78.00 stddev:24.57 (31.5%) stddev-sans-first:25.45 16:50:12 INFO - PID 10553 | Values: 78.0 78.0 131.0 78.0 77.0 78.0 129.0 78.0 78.0 126.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:50:12 INFO - PID 10553 | Values: 114.0 115.0 115.0 113.0 114.0 114.0 115.0 114.0 114.0 114.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 16:50:12 INFO - PID 10553 | Values: 147.0 151.0 148.0 149.0 148.0 148.0 147.0 148.0 147.0 148.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:94.00 stddev:2.53 (2.7%) stddev-sans-first:2.60 16:50:12 INFO - PID 10553 | Values: 94.0 100.0 99.0 99.0 94.0 94.0 94.0 94.0 94.0 96.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:1.33 (2.8%) stddev-sans-first:1.41 16:50:12 INFO - PID 10553 | Values: 48.0 51.0 47.0 48.0 49.0 47.0 47.0 47.0 49.0 47.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:50:12 INFO - PID 10553 | Values: 55.0 55.0 54.0 55.0 55.0 55.0 54.0 54.0 54.0 55.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:1.78 (2.4%) stddev-sans-first:1.79 16:50:12 INFO - PID 10553 | Values: 74.0 72.0 76.0 70.0 71.0 71.0 71.0 73.0 73.0 73.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:119.50 stddev:13.25 (11.1%) stddev-sans-first:13.78 16:50:12 INFO - PID 10553 | Values: 114.0 115.0 129.0 122.0 114.0 121.0 118.0 111.0 114.0 156.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:164.50 stddev:4.08 (2.5%) stddev-sans-first:4.30 16:50:12 INFO - PID 10553 | Values: 164.0 162.0 169.0 162.0 173.0 164.0 161.0 162.0 170.0 165.0 16:50:12 INFO - PID 10553 | 16:50:12 INFO - PID 10553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:2.06 16:50:12 INFO - PID 10553 | Values: 63.0 62.0 63.0 62.0 62.0 62.0 67.0 63.0 60.0 60.0 16:50:12 INFO - PID 10553 | -------- Summary: end -------- 16:50:12 INFO - PID 10553 | 16:50:13 INFO - PID 10553 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:50:13 INFO - TEST-INFO | 10553: exit 0 16:50:13 INFO - TEST-OK | kraken | took 59811ms 16:50:13 INFO - SUITE-END | took 1168s 16:50:13 INFO - Completed test suite (00:19:28) 16:50:13 INFO - javascript benchmark 16:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9006.682020127279, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3458.9654103458975, 3465.480177973304, 3494.405950988332, 3505.5618047744024, 3513.5959364673054, 6083.817485475432, 6138.96930515348, 6150.046742754869, 6194.7831825886105, 6228.096925945735, 6049.032154855224, 6090.908636370447, 6091.817245482632, 6124.846878828032, 6184.56708030438, 5402.702851343174, 5418.106012507941, 5439.456054394568, 5440.211169380437, 5518.834434966937, 5495.6153069285165, 5528.530074943635, 5532.1425179097105, 5534.584906132056, 5544.944550554484, 5458.099413596752, 5491.752871120789, 5513.952349053667, 5596.328440587135, 5609.214709940612, 5297.894042119175, 5416.322959630046, 5417.45825417459, 5473.808416705396, 5484.232207490914, 5406.756695948692, 5407.83776486706, 5467.535259502947, 5471.72641367934, 5476.945230547683, 6038.396160383971, 6077.726502307407, 6092.573519853612, 6110.419510146529, 6143.754249830002, 6643.236027856762, 6667.366600173024, 6680.432163266129, 6691.364320389555, 6729.327067293231, 6716.059751634775, 6774.254831968479, 6802.795916122524, 6809.863802723968, 6839.726410943556, 6190.845228869314, 6300.684965751694, 6328.398802113792, 6333.619982801047, 6343.714532846033, 6903.896441553381, 6910.689018994158, 6918.584884906922, 6966.442684585221, 6990.196127445409, 6431.2604050533855, 6534.4445722113205, 6577.473802095917, 6598.0, 6660.666966651648, 6761.188657361148, 6773.695183716744, 6821.795346139525, 6828.863422731518, 6830.248672646005, 6635.568688035262, 6637.435817955527, 6640.169978752656, 6700.162479690039, 6744.460443164535, 6577.704003319862, 6652.667366631649, 6678.599284042973, 6729.226138994079, 6741.561798483083, 4769.42766867978, 4793.352897358882, 4807.254875494304, 4809.302651115569, 4832.903341933142, 4240.5123410808155, 4279.122779830127, 4291.249031419489, 4294.785260737013, 4344.782760862007, 6223.253209614875, 6278.6860656966965, 6279.434850863444, 6290.245170579468, 6368.808935731936, 6619.735210591522, 6631.137952066297, 6684.2981486944145, 6711.026901099313, 6725.562838415487, 6168.0, 6207.596506227081, 6224.844378890564, 6318.462930650946, 6324.588901721466, 5349.090654588729, 5404.54061404785, 5408.0535906216255, 5421.593380496479, 5450.155225939986, 6960.9303906961295, 6963.79108626742, 7037.2962703730245, 7043.718251269995, 7064.43484521237, 6655.534112612071, 6659.334066593302, 6738.989151627197, 6741.831454213684, 6754.527183097332, 6851.657417129223, 6956.373926346653, 6967.233604303624, 7026.9648651756415, 7044.366007059184, 6615.66921653925, 6710.496712746466, 6726.159230096238, 6727.327267273234, 6739.730410783513, 6694.196696396269, 6702.128723265944, 6702.36327548882, 6772.695228714621, 6779.762708305186, 6264.029075493306, 6422.133012043314, 6454.644994525346, 6489.059086432535, 6580.1116849226655, 6567.0, 6568.868622627425, 6574.342565743387, 6580.605163690194, 6599.703013364314, 6471.191101112361, 6577.177852768404, 6626.105475760711, 6645.036469711961, 6656.635389745187, 6438.67806609677, 6577.506686998398, 6624.635645039569, 6692.498062645223, 6708.865822683617, 6327.303996560283, 6329.8734025320155, 6398.616083035033, 6400.263969643551, 6402.93597064042], "value": 6091.671746347776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.9411788233766, 912.6988093929, 941.4774799986008, 973.4354074636707, 974.8391515399959, 43485.347719784186, 44605.33092003623, 44620.10759784802, 44717.55282447174, 44729.0, 41947.161056778925, 42203.0, 42207.36688949668, 42269.788651056704, 42339.0, 7043.119610048731, 7165.498415110945, 7166.928330716678, 7186.029885965406, 7190.496665233436, 7058.505904586681, 7130.0, 7132.07283053205, 7145.85708285834, 7147.642617869085, 7059.541129826544, 7109.253528379523, 7113.573185608854, 7142.464315176382, 7143.642817859112, 7026.156861176666, 7087.964560177218, 7088.893666595005, 7092.9290707093305, 7097.041899343574, 6471.83820404489, 6485.643289619069, 6487.772927947546, 6488.0916671666, 6554.672266386709, 36378.27243455143, 36578.8171059143, 36674.81662591697, 36684.0, 36703.265934681156, 3291.4075466416275, 3327.317899830529, 3329.3840639481773, 3337.8164200968936, 3338.4157772389976, 29011.709882901112, 29126.41747165045, 29154.416911661647, 29172.854135729187, 29237.561436578468, 4385.2106620808245, 4442.933355999663, 4561.0, 4601.654875884322, 4676.55572720591, 207382.0, 208772.0, 210013.0, 214792.0, 223125.88437057874, 54236.0, 54334.45665543373, 54371.0, 54495.182572261445, 54533.18200227, 55222.44777552173, 55317.0, 55317.723411382685, 55559.0, 55977.72011139918, 15998.680026399406, 16405.91797041007, 16559.83440165607, 16563.171841408122, 16585.50243492697, 12879.42042608085, 12880.742385152245, 12886.033547483976, 12886.548970786165, 12887.226766394046, 14454.988150829551, 14460.13239205651, 14522.927385363006, 14573.854261457462, 14736.926315368355, 5706.4864162225595, 5850.356460789395, 5890.528757699374, 5921.67430791302, 5929.970350148308, 1088.7713580148259, 1093.3439936038471, 1097.7091070866227, 1113.716002419378, 1115.5314767797545, 24621.5075698485, 24659.630105548433, 24882.0, 24887.377815554755, 25103.246902592953, 1189.262657152571, 1191.3566673996118, 1197.5928284265954, 1199.580146948561, 1204.584418375659, 12974.870251297554, 13073.411696473682, 13211.14127581704, 13214.207147571176, 13263.801042984363, 257154.71422642766, 257932.0, 259223.0, 259260.0, 259737.0, 56614.7169264151, 56837.715811421505, 56963.0, 57247.14129288064, 57343.71328143332, 1513.954581362561, 1537.0547113525101, 1566.6553358261392, 1577.242923396753, 1577.9053256804398, 24782.256532304058, 24788.903493049776, 30757.53863692091, 30984.486873508173, 31250.0, 56541.0, 56581.71709141593, 56829.71585142213, 57232.713836432216, 57238.0, 240105.0, 240111.0, 240779.79610101838, 240809.0, 241247.0, 37167.442488362154, 38928.221435570566, 39315.0, 39460.0, 39475.60524394719, 49993.0, 51502.22746658728, 51693.48306516887, 51901.480985189664, 52065.47934520606, 36917.63082369142, 37118.0, 37280.44079338758, 37604.435933460474, 37664.81167594145, 36260.81869590635, 36827.447588285664, 36921.63078369182, 37019.814900925325, 37644.05889852776, 42540.787296063325, 42589.36115958325, 42589.36115958325, 42880.78559607182, 43901.341479878465, 36037.0, 36125.27749445049, 36281.185940703384, 36736.63263367332, 37099.62900370962, 26096.478070438865, 26163.476730465663, 26306.605400919383, 26704.599431008162, 26930.057447989228], "value": 18223.011257976734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9373068962414, 571.5513322042198, 573.3807487913055, 579.9536037117031, 586.9589128760987, 23297.767022329794, 23566.882165589148, 24328.27015189545, 24726.13458528954, 24776.256712298615, 27425.0, 28165.29586760327, 28170.577441338395, 28203.012894548694, 28245.43509129821, 6300.8739825203465, 6466.224053113633, 6476.579022363531, 6477.0, 6481.31946145655, 6189.659568723719, 6243.781467648633, 6246.312905580383, 6444.258910225337, 6488.61068335899, 6445.419912207901, 6460.806175814733, 6462.192225971754, 6474.546781725281, 6476.838079048038, 6444.774432894873, 6450.806475805757, 6463.612183268995, 6464.806055818286, 6471.611703297794, 5968.134620480006, 5976.372480889488, 5982.0, 6001.849953751147, 6001.909971350433, 31089.0, 31151.84424077888, 31515.21211969696, 32675.6732432675, 32912.17719557006, 2274.5223503064376, 2281.885905704708, 2282.931512054641, 2304.055337311694, 2311.28350211435, 20568.177272909066, 21098.26156084545, 21132.366029019155, 21166.470838229012, 21171.788282117137, 2397.29279862441, 2452.7547245275327, 2501.0996041425074, 2565.756253155947, 2581.238534632288, 158918.0, 162492.0, 163095.0, 163157.0, 163581.18209408995, 15090.623719121551, 15871.0, 16043.919780401024, 16107.275172617261, 16410.753838692428, 23677.289681309587, 24286.878565607058, 24306.756932430802, 24508.632370514457, 24588.139415120386, 10834.133269338434, 10882.891171088346, 10964.56141754337, 10986.395748233925, 11038.227324087398, 10041.748956276006, 10052.798944021079, 10106.747331316776, 10115.291929565006, 10193.490325483695, 10051.24615653829, 10125.392476451436, 10211.132053775513, 10315.432651204106, 10419.0, 2859.985700071528, 2868.1395581325937, 2874.2813052243737, 2908.1420980810713, 3016.2007068126964, 1048.3238311289329, 1048.8846226915034, 1060.5492665617082, 1079.6491140379408, 1081.1080858291784, 21382.0, 22149.446263843533, 22196.556068878534, 22627.718980748028, 22652.660210096863, 1068.540527573151, 1110.245033377311, 1111.572044762772, 1119.7928383248961, 1138.6413279816832, 11826.0, 11864.525418983316, 11954.76090478203, 11955.462004209832, 11963.88036119645, 650247.0, 652393.0, 669815.0, 670292.0, 675048.0, 142353.0, 149636.0, 150909.0, 153965.23017384842, 154698.0, 1314.5399110311505, 1314.8685131486775, 1358.6195865157772, 1365.808786769853, 1375.408574313055, 22833.885830571406, 22852.200172993864, 22921.083156673547, 23177.18879839265, 23346.0, 64757.0, 65106.674466627366, 65932.34067659262, 66570.33429665641, 68278.0, 83417.58291208505, 87081.56459217917, 87828.0, 88268.0, 88437.0, 14962.625934351729, 15014.0, 15156.621084472976, 15306.693866122838, 15318.0, 24638.87680561586, 24726.381840454134, 24812.627810583217, 24995.75004249934, 25396.365090872878, 19656.508587285432, 19714.901425492782, 19899.900500497406, 19920.0, 19932.0, 17739.733903991193, 17868.374606888698, 18114.637707245518, 18290.908545457187, 18548.721769173204, 20591.0, 20910.790892090885, 20915.26796562113, 20974.2659006934, 21061.684074739198, 14954.0, 15019.173945433105, 15060.849391505944, 15077.623059423602, 15118.773218401513, 20058.598828023067, 20132.798672013094, 20151.79848201499, 20352.694709579664, 20400.795992040483], "value": 13063.184767045515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.654722866512, 1470.397137173759, 1486.4797320937666, 1495.4616338118283, 1526.519146468862, 15618.453354132607, 16307.347706091758, 16315.592110197236, 16318.102504362256, 16336.0, 15330.233488325566, 16383.83616163838, 16385.83614163858, 16394.180290985463, 16412.425565105223, 2660.6009098635213, 2695.218386667864, 2696.3798326384945, 2705.7970652201066, 2707.7698395636394, 2602.206327070243, 2606.1399738086384, 2644.788416926651, 2697.8111532192756, 2698.689650690176, 2659.8670066496693, 2679.7454241846995, 2685.087070396065, 2686.073304709872, 2687.50281197979, 2431.63525471179, 2470.3330100872754, 2470.4564995700916, 2588.6117082437786, 2638.736126387365, 2560.8463492190526, 2563.5641940870096, 2586.6508021417058, 2607.361196506849, 2651.880665370063, 16138.919305403515, 16241.837581624151, 16255.51233462998, 16258.918705406515, 16261.349546018146, 8055.15420880805, 8318.292945099674, 8335.458195217352, 8338.583070846433, 8340.040895297057, 4823.300621409911, 5069.645124841262, 5138.434772175057, 5159.458256883048, 5177.0, 1868.3460788723974, 1889.1121173048782, 1893.870487184901, 1910.360029390156, 1926.8265856073021, 29383.412331753458, 29423.2644183895, 29458.410831783458, 29636.110916672533, 29640.25899352512, 6737.831554211184, 6745.0, 6765.0, 6921.688524016431, 6966.12923384577, 19702.21191152338, 19773.307934222234, 19775.60448791016, 19792.802071979095, 19795.218430341338, 8167.0, 8292.917070829215, 8300.501969881827, 8300.584970751439, 8303.04514980773, 7574.204708505637, 7583.203763604853, 7726.613669316512, 7760.650770715331, 7763.844723105619, 5316.521513063843, 5562.499375056264, 5566.443355664482, 5590.413006634326, 5599.160125981135, 1412.4067891485602, 1474.9188794616184, 1509.0492989416598, 1563.5309407177801, 1595.5372941846967, 962.7208109648124, 970.4811969268073, 974.1086905481405, 983.7638966647953, 989.1394486796534, 9132.406393584395, 9164.816703665889, 9226.446413215095, 9251.398659087137, 9321.067893210624, 1030.7886883188928, 1032.3083534032216, 1065.63235683689, 1068.9037986581245, 1069.5667805141147, 4842.709437433765, 5119.564836988823, 5841.240638717025, 5884.411558844081, 5994.940050599525, 23353.299401017655, 24285.514289714105, 24373.0, 24420.63369049466, 24436.0, 22964.425889352566, 23731.28806135784, 23820.52358952811, 23953.52092958166, 24186.637200442008, 12648.304343261025, 12794.552190673468, 12854.55009074678, 12895.0, 12944.41750121228, 8950.82098358016, 9075.50084745319, 9247.213986811197, 9250.2137318326, 9356.0, 20183.798162018193, 20301.49246268855, 20760.584788303848, 21158.47103822417, 21329.360119196448, 21161.365159045254, 21598.460038499165, 21769.891150544147, 21861.0, 21946.45133871666, 12047.0, 12221.083418743452, 12347.62957111288, 12388.876111239133, 12415.503379864704, 14944.626384340478, 15028.323725432601, 15166.696666066837, 15168.0, 15233.771493427828, 11711.414429278673, 11724.58963936258, 11949.22330048544, 12162.75674486523, 12230.082743794073, 11469.820734060502, 11646.76706465849, 11672.182947193955, 12093.093018023508, 12123.393830308625, 10193.949030254802, 10271.794564108826, 10295.897041029793, 10300.124489418484, 10313.22650801208, 7216.675249613885, 7348.265173482609, 7432.814179645552, 8052.15452377492, 8180.713675021346, 8586.570671466277, 8648.481091134552, 8683.305335573014, 8697.391182617155, 8711.825763484569], "value": 7069.3569552772, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.54485235714026, 511.2101802714805, 527.8996990571791, 533.4975883325965, 538.9353277606688, 6146.477549408294, 6236.3205708631895, 6263.185785847833, 6278.874422511552, 6310.274318453379, 6159.8768024639485, 6181.414779427932, 6181.6600086995195, 6187.628742275467, 6203.193584833976, 4930.8767280818, 4962.627802914796, 4964.131277026506, 4972.502749725035, 4974.990130970765, 4699.38907941967, 4844.543020421203, 4888.73111978841, 4906.786055133875, 4914.729689867056, 4753.310769938357, 4768.952310476903, 4781.3784208053075, 4793.856184314476, 4825.445073816503, 4827.227643577046, 4842.0, 4843.200871856139, 4846.660733748639, 4848.181931775584, 4359.258925982559, 4365.563443655641, 4368.012554287823, 4371.912561748779, 4391.648668106575, 6032.758689652409, 6074.119252708377, 6103.389661033905, 6120.846978825565, 6138.600990935575, 5752.654840709571, 5756.971215143939, 5805.535557155417, 5827.941720582782, 5847.26909136358, 6579.914314138209, 6635.170603674541, 6636.800895973129, 6645.60126392418, 6684.498662600276, 4867.634927380425, 4889.242167464049, 4948.777305021283, 4974.925376119361, 4991.0, 6695.363940425652, 6701.961196014626, 6799.830004249933, 6870.141232345957, 7044.189918159426, 5049.0, 5061.417936937226, 5087.440381558025, 5115.462876397924, 5134.152864777345, 5106.46805958211, 5135.974320128375, 5173.068847607392, 5183.844484665466, 5187.170052791535, 5739.053056245672, 5746.798862039892, 5771.5671324649975, 5777.277840269966, 5783.71081445926, 6583.440407565315, 6608.744338575655, 6632.1709786276715, 6638.340414896276, 6703.229128650268, 1776.342753181331, 1795.093477793706, 1797.640471905624, 1807.4667972948012, 1811.7735283089614, 1201.3332600406684, 1237.622525129826, 1254.6988722706485, 1255.7614053329837, 1272.351100938528, 6203.720832562455, 6313.337099604567, 6344.809655710336, 6357.043974551763, 6411.711472983727, 6648.700808463631, 6666.366740148695, 6750.189977202767, 6772.492063095189, 6804.659767011729, 6276.529260305495, 6295.464885484785, 6318.399752023551, 6349.206349206349, 6367.363263673688, 3498.58017037952, 3541.3094446583186, 3553.786772793589, 3596.3346780845627, 3612.945805812915, 6963.059986901703, 7009.754658587027, 7025.754098606524, 7066.717331306793, 7100.893486597705, 6565.540412171198, 6873.934540146285, 6914.619695916773, 6955.339242771928, 7019.3682568569075, 6890.896636550456, 6972.44220462372, 7016.473764467685, 7017.89473157903, 7067.399271062018, 6658.400743933069, 6697.129373181455, 6700.564463309869, 6747.426468750211, 6845.794626161223, 6614.371634694697, 6652.90020649681, 6711.463082953254, 6743.662816859235, 6753.898691519729, 7105.812756687544, 7122.501424900207, 7128.501004929605, 7144.3212894774915, 7146.571205727673, 5089.872753181052, 5138.614603904647, 5165.690058596496, 5177.4822517749435, 5186.766595503136, 6622.437092847162, 6651.73393064272, 6712.530122891546, 6787.524873258824, 6803.367191874014, 6509.4051957268875, 6531.379518945692, 6541.476681865344, 6594.439472644879, 6630.3092711358295, 6516.771912983023, 6541.70562324687, 6582.1696670432175, 6607.900881486878, 6613.2394774601535, 6323.0, 6506.186726659168, 6515.0, 6535.44448721864, 6606.372394622503, 6568.474522038321, 6619.669016549057, 6621.71550814968, 6634.601923884582, 6673.599584024974, 6351.428371446592, 6369.681515924092, 6443.581167224115, 6450.225972883284, 6459.741610335534], "value": 5133.13649586784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.4558987402493, 924.8936372317183, 940.8259471997677, 949.2121539122529, 953.1469334945222, 19347.322843700473, 20215.898920505395, 20269.885156316413, 20299.695504567444, 21342.46643833905, 21196.89401552994, 22903.77096229037, 23025.4243643909, 23122.88438557809, 23125.19061832836, 995.5121990224774, 1013.6857574152, 1017.3895662602454, 1017.7811770469348, 1018.6231094495047, 1029.8918613545582, 1071.59815069349, 1080.3409919948824, 1085.8588383510173, 1099.2415233488907, 1141.0, 1149.0290704354848, 1149.3678476837706, 1150.2465884845399, 1150.7583407484397, 1135.9261647992853, 1139.191174266272, 1140.9372484513349, 1144.7882141803752, 1146.0430540498653, 831.3598529132535, 839.6977088248226, 841.154639587217, 841.47828346425, 843.3674743942044, 19386.903065484723, 19537.316193933144, 19539.218431262732, 19573.314933977384, 20030.69953950692, 22419.663705044437, 22968.196113136128, 23193.768062319497, 23436.64845027326, 23455.179068732683, 17037.48887533376, 17056.48830535086, 17304.221310041077, 17461.82538174615, 17563.385281515086, 3789.696824254053, 3791.9810400948095, 3807.8857634271017, 3822.9808850955847, 3826.081740382288, 153242.0, 153973.23013384972, 154794.22602887137, 155141.0, 155261.0, 17326.3069477222, 17449.302027918995, 17906.641867162845, 17963.550911227325, 18040.18819153141, 33304.0, 34065.65934340675, 34086.48870266948, 34145.65854341474, 34487.310253794785, 7670.7698769037015, 8023.1575684553445, 8940.195382415613, 9311.580978855967, 9823.508824558743, 4543.61379282758, 4650.302454631765, 4657.208274593328, 4658.86023419298, 4662.32396302541, 5556.499915007668, 5636.2954630671165, 5760.769569217185, 5761.049426844607, 5761.971190144106, 1142.6457798082454, 1186.507599346279, 1201.6274954763876, 1203.8374819399269, 1205.0540325844345, 724.4964749499153, 738.6048464071696, 745.37760969591, 751.9285667861544, 760.7945854619333, 12210.877891220975, 12241.816372754416, 13061.08572399923, 13142.671433214055, 13237.470501180038, 693.9791806245821, 700.4291502425507, 708.3553965891015, 712.5866997141645, 717.1394326807851, 5940.405959404112, 6053.182820319201, 6169.259688837368, 6739.966300168468, 6998.510104292753, 139254.0, 144170.0, 144173.27913360365, 145413.27293363467, 152677.23661381623, 127372.0, 133588.33205834104, 133928.0, 134562.0, 138472.0, 116686.41656791662, 117736.41131794457, 117971.41014294873, 118888.40555797338, 119001.0, 13390.799138012742, 13841.653958650712, 14036.2981850905, 14037.368318425491, 14077.225752583707, 50232.748836257044, 50307.49692503028, 50798.0, 50955.74522127365, 52488.0, 67532.0, 67907.0, 68840.65579672069, 69288.6535567319, 69377.0, 16408.0, 20644.587108258052, 20735.68896466524, 21556.89221553882, 21593.13627454884, 19716.704249436556, 21652.0, 22727.77272227323, 22740.772592273865, 22822.65766013478, 19284.71072933879, 19392.321268755524, 19436.0, 19528.0, 19581.314653987043, 19887.801121988596, 20120.899395503515, 20139.39581812548, 20234.392968210977, 20249.39251822448, 20183.899080504503, 20441.693374599094, 20508.282210122576, 20522.0, 20640.380788576367, 15117.319720612819, 15609.297581608627, 15621.609459763597, 15638.905276630527, 15864.682706346039, 15639.843601563838, 16009.919950400174, 16127.516174514783, 16250.593735156242, 16267.837321626632], "value": 10143.612445864808, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 109.0, 100.0, 108.0, 107.0, 107.0, 106.0, 97.0, 108.0, 111.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 151.0, 166.0, 114.0, 140.0, 138.0, 114.0, 169.0, 114.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 163.0, 168.0, 169.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 73.0, 134.0, 74.0, 83.0, 73.0, 88.0, 91.0, 74.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 131.0, 78.0, 77.0, 78.0, 129.0, 78.0, 78.0, 126.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 148.0, 149.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 99.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 47.0, 48.0, 49.0, 47.0, 47.0, 47.0, 49.0, 47.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 76.0, 70.0, 71.0, 71.0, 71.0, 73.0, 73.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 129.0, 122.0, 114.0, 121.0, 118.0, 111.0, 114.0, 156.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 169.0, 162.0, 173.0, 164.0, 161.0, 162.0, 170.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 67.0, 63.0, 60.0, 60.0], "value": 62.4, "unit": "score"}]}]} 16:50:14 INFO - Return code: 0 16:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:50:14 INFO - # TBPL SUCCESS # 16:50:14 INFO - Running post-action listener: _package_coverage_data 16:50:14 INFO - Running post-action listener: _resource_record_post_action 16:50:14 INFO - [mozharness: 2017-08-17 23:50:14.109909Z] Finished run-tests step (success) 16:50:14 INFO - Running post-run listener: _resource_record_post_run 16:50:14 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 437751808; Read time: 160; Write time: 265788 16:50:14 INFO - TinderboxPrint: CPU usage
13.0% 16:50:14 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 160 16:50:14 INFO - TinderboxPrint: I/O write bytes / time
437,751,808 / 265,788 16:50:14 INFO - TinderboxPrint: CPU idle
8,229.6 (86.9%) 16:50:14 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 16:50:14 INFO - TinderboxPrint: Swap in / out
0 / 0 16:50:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117510144; Read time: 0; Write time: 87208 16:50:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:50:14 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320241664; Read time: 152; Write time: 178580 16:50:14 INFO - Running post-run listener: _upload_blobber_files 16:50:14 INFO - Blob upload gear active. 16:50:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:50:14 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 16:50:14 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'] 16:50:14 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 16:50:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:50:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:15 INFO - (blobuploader) - INFO - Done attempting. 16:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:50:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:16 INFO - (blobuploader) - INFO - Done attempting. 16:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:20 INFO - (blobuploader) - INFO - Done attempting. 16:50:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:50:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:50:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:50:27 INFO - (blobuploader) - INFO - Done attempting. 16:50:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:50:27 INFO - Return code: 0 16:50:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:50:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:50:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90213101fcd510e666b4079f375d0ccb9586060fcc51f61e309e19a582f488189487800ddce91f80c7aa4b79a47a55b0f4dbc41aee30f9e593646793afe50e48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61af2d38f003848d71bc8e06247a011cbd786695d5f1c7a6b0cc0cb75cd037e4320d734cf71ccb4301f8a187412e2ef7fb27280515f1c7418d18bb4f8032f722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeb409eacfeee010e212238488c054a3ad1a382989a0974e6398591cc84f622c17624b79766b1e51173b5bf33916e5db2a139aba6a9ec1d4471b20ac1916350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f86927bb62dd910fa973bce967b3ad5b4b6e5e5f1c70f6b5a1550dd6d906269d73cb08fa15aa2020b5e065ecbb28ddd774cca74124f5b14abbe398b1daaa56b3"} 16:50:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:50:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:50:27 INFO - Contents: 16:50:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90213101fcd510e666b4079f375d0ccb9586060fcc51f61e309e19a582f488189487800ddce91f80c7aa4b79a47a55b0f4dbc41aee30f9e593646793afe50e48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61af2d38f003848d71bc8e06247a011cbd786695d5f1c7a6b0cc0cb75cd037e4320d734cf71ccb4301f8a187412e2ef7fb27280515f1c7418d18bb4f8032f722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeb409eacfeee010e212238488c054a3ad1a382989a0974e6398591cc84f622c17624b79766b1e51173b5bf33916e5db2a139aba6a9ec1d4471b20ac1916350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f86927bb62dd910fa973bce967b3ad5b4b6e5e5f1c70f6b5a1550dd6d906269d73cb08fa15aa2020b5e065ecbb28ddd774cca74124f5b14abbe398b1daaa56b3"} 16:50:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:50:27 INFO - Copying logs to upload dir... 16:50:27 INFO - mkdir: /builds/slave/test/build/upload/logs 16:50:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.689489 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-17 16:50:27.181028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:50:27.184687) ========= 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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90213101fcd510e666b4079f375d0ccb9586060fcc51f61e309e19a582f488189487800ddce91f80c7aa4b79a47a55b0f4dbc41aee30f9e593646793afe50e48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61af2d38f003848d71bc8e06247a011cbd786695d5f1c7a6b0cc0cb75cd037e4320d734cf71ccb4301f8a187412e2ef7fb27280515f1c7418d18bb4f8032f722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeb409eacfeee010e212238488c054a3ad1a382989a0974e6398591cc84f622c17624b79766b1e51173b5bf33916e5db2a139aba6a9ec1d4471b20ac1916350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f86927bb62dd910fa973bce967b3ad5b4b6e5e5f1c70f6b5a1550dd6d906269d73cb08fa15aa2020b5e065ecbb28ddd774cca74124f5b14abbe398b1daaa56b3"} build_url:https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/ZWBuZkNwS_22rQ2YylU9uw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90213101fcd510e666b4079f375d0ccb9586060fcc51f61e309e19a582f488189487800ddce91f80c7aa4b79a47a55b0f4dbc41aee30f9e593646793afe50e48", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61af2d38f003848d71bc8e06247a011cbd786695d5f1c7a6b0cc0cb75cd037e4320d734cf71ccb4301f8a187412e2ef7fb27280515f1c7418d18bb4f8032f722", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeb409eacfeee010e212238488c054a3ad1a382989a0974e6398591cc84f622c17624b79766b1e51173b5bf33916e5db2a139aba6a9ec1d4471b20ac1916350c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f86927bb62dd910fa973bce967b3ad5b4b6e5e5f1c70f6b5a1550dd6d906269d73cb08fa15aa2020b5e065ecbb28ddd774cca74124f5b14abbe398b1daaa56b3"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:50:27.311132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:50:27.311465) ========= 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=523ca41ca1e0623de333ad52000001bf-1503012573.257085-48019085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:50:27.329322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:50:27.329608) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:50:27.329902) ========= ========= Total master_lag: 0.19 =========