builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1499740056.51 results: success (0) revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.513062) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.513558) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.513855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.567083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.567360) ========= 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=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-10 19:27:36-- 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% 112M=0s 2017-07-10 19:27:36 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149002 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.739537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.739874) ========= 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=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042433 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:36.791634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 19:27:36.791975) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e41d07a703f19224f60b01577b2cbb5708046c9 --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 0e41d07a703f19224f60b01577b2cbb5708046c9 --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=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-10 19:27:36,820 truncating revision to first 12 chars 2017-07-10 19:27:36,820 Setting DEBUG logging. 2017-07-10 19:27:36,820 attempt 1/10 2017-07-10 19:27:36,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e41d07a703f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-10 19:27:37,539 unpacking tar archive at: mozilla-central-0e41d07a703f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.054085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 19:27:37.858560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:37.858905) ========= script_repo_revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:37.859397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:37.859675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:27:37.868344) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-10 19:27:37.868630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:27:38 INFO - MultiFileLogger online at 20170710 19:27:38 in /builds/slave/test 19:27:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:38 INFO - {'append_to_log': False, 19:27:38 INFO - 'base_work_dir': '/builds/slave/test', 19:27:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:38 INFO - 'branch': 'Firefox-Non-PGO', 19:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:38 INFO - 'code_coverage': False, 19:27:38 INFO - 'config_files': ('talos/linux_config.py',), 19:27:38 INFO - 'default_actions': ('clobber', 19:27:38 INFO - 'read-buildbot-config', 19:27:38 INFO - 'download-and-extract', 19:27:38 INFO - 'populate-webroot', 19:27:38 INFO - 'create-virtualenv', 19:27:38 INFO - 'install', 19:27:38 INFO - 'setup-mitmproxy', 19:27:38 INFO - 'run-tests'), 19:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:38 INFO - 'disable_ccov_upload': False, 19:27:38 INFO - 'download_minidump_stackwalk': True, 19:27:38 INFO - 'download_symbols': 'ondemand', 19:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:38 INFO - 'gecko_profile': False, 19:27:38 INFO - 'gecko_profile_interval': 0, 19:27:38 INFO - 'installer_path': 'installer.exe', 19:27:38 INFO - 'log_level': 'info', 19:27:38 INFO - 'log_name': 'talos', 19:27:38 INFO - 'log_to_console': True, 19:27:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:27:38 INFO - 'opt_config_files': (), 19:27:38 INFO - 'pip_index': False, 19:27:38 INFO - 'suite': 'dromaeojs-e10s', 19:27:38 INFO - 'system_bits': '32', 19:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:38 INFO - 'title': 'talos-linux64-ix-046', 19:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:38 INFO - 'use_talos_json': True, 19:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:38 INFO - 'work_dir': 'build'} 19:27:38 INFO - [mozharness: 2017-07-11 02:27:38.121025Z] Running clobber step. 19:27:38 INFO - Running pre-action listener: _resource_record_pre_action 19:27:38 INFO - Running main action method: clobber 19:27:38 INFO - rmtree: /builds/slave/test/build 19:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:43 INFO - Running post-action listener: _resource_record_post_action 19:27:43 INFO - [mozharness: 2017-07-11 02:27:43.707386Z] Finished clobber step (success) 19:27:43 INFO - [mozharness: 2017-07-11 02:27:43.707499Z] Running read-buildbot-config step. 19:27:43 INFO - Running pre-action listener: _resource_record_pre_action 19:27:43 INFO - Running main action method: read_buildbot_config 19:27:43 INFO - Using buildbot properties: 19:27:43 INFO - { 19:27:43 INFO - "project": "", 19:27:43 INFO - "product": "firefox", 19:27:43 INFO - "who": "kwierso@gmail.com", 19:27:43 INFO - "installer_path": "public/build/target.tar.bz2", 19:27:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:27:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:27:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:27:43 INFO - "stage_platform": "linux64", 19:27:43 INFO - "basedir": "/builds/slave/test", 19:27:43 INFO - "buildnumber": 1003, 19:27:43 INFO - "platform": "ubuntu64_hw", 19:27:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:27:43 INFO - "slavebuilddir": "test", 19:27:43 INFO - "taskId": "InctV6CnRN6M3JbuWIAQIQ", 19:27:43 INFO - "branch": "mozilla-central", 19:27:43 INFO - "script_repo_revision": "production", 19:27:43 INFO - "revision": "0e41d07a703f19224f60b01577b2cbb5708046c9", 19:27:43 INFO - "slavename": "talos-linux64-ix-046", 19:27:43 INFO - "repo_path": "mozilla-central" 19:27:43 INFO - } 19:27:43 INFO - Finding installer, test and symbols from parent task. 19:27:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/InctV6CnRN6M3JbuWIAQIQ'}, attempt #1 19:27:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/InctV6CnRN6M3JbuWIAQIQ'}, attempt #1 19:27:44 INFO - Task dependencies: T0hz2tMlQleYKN2v0DASoQ 19:27:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ'}, attempt #1 19:27:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 19:27:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/test_packages.json 19:27:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.crashreporter-symbols.zip 19:27:45 INFO - Running post-action listener: _resource_record_post_action 19:27:45 INFO - [mozharness: 2017-07-11 02:27:45.094164Z] Finished read-buildbot-config step (success) 19:27:45 INFO - [mozharness: 2017-07-11 02:27:45.094386Z] Running download-and-extract step. 19:27:45 INFO - Running pre-action listener: _resource_record_pre_action 19:27:45 INFO - Running main action method: download_and_extract 19:27:45 INFO - mkdir: /builds/slave/test/build/tests 19:27: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')]} 19:27:45 INFO - trying https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.test_packages.json 19:27:45 INFO - Downloading https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:27:45 INFO - Downloaded 989 bytes. 19:27:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:27:45 INFO - Using the following test package requirements: 19:27:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:27:45 INFO - u'common': [u'target.common.tests.zip'], 19:27:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:27:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:27:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:27:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:27:45 INFO - u'mozbase': [u'target.common.tests.zip'], 19:27:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:27:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:27:45 INFO - u'web-platform': [u'target.common.tests.zip', 19:27:45 INFO - u'target.web-platform.tests.tar.gz'], 19:27:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:27:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:27:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip 19:27:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:27:45 INFO - Fetch https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip into memory 19:27:47 INFO - Content-Length response header: 67424557 19:27:47 INFO - Bytes received: 67424557 19:27:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:27:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip 19:27:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:27:58 INFO - Fetch https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.common.tests.zip into memory 19:28:00 INFO - Content-Length response header: 67424557 19:28:00 INFO - Bytes received: 67424557 19:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.talos.tests.zip 19:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.talos.tests.zip into memory 19:28:13 INFO - Content-Length response header: 14474423 19:28:13 INFO - Bytes received: 14474423 19:28: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')]} 19:28:13 INFO - trying https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 19:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:28:15 INFO - Downloaded 62231463 bytes. 19:28:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 19:28:15 INFO - mkdir: /builds/slave/test/properties 19:28:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:28:15 INFO - Writing to file /builds/slave/test/properties/build_url 19:28:15 INFO - Contents: 19:28:15 INFO - build_url:https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 19:28:15 INFO - Running post-action listener: _resource_record_post_action 19:28:15 INFO - Running post-action listener: set_extra_try_arguments 19:28:15 INFO - [mozharness: 2017-07-11 02:28:15.067789Z] Finished download-and-extract step (success) 19:28:15 INFO - [mozharness: 2017-07-11 02:28:15.067888Z] Running populate-webroot step. 19:28:15 INFO - Running pre-action listener: _resource_record_pre_action 19:28:15 INFO - Running main action method: populate_webroot 19:28:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:28:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:28:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:28:15 INFO - '--tppagecycles', 19:28:15 INFO - '7'], 19:28:15 INFO - 'tests': ['tsvgm']}}, 19:28:15 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:28:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:28:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:28:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:28:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['damp', 'tps']}, 19:28:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'tests': ['damp', 'tps']}, 19:28:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['dromaeo_dom']}, 19:28:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:28:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:28:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:28:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:28:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'other-e10s': {'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_many_windows', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_many_windows', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_many_windows', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['a11yr', 19:28:15 INFO - 'ts_paint', 19:28:15 INFO - 'tpaint', 19:28:15 INFO - 'sessionrestore', 19:28:15 INFO - 'sessionrestore_no_auto_restore', 19:28:15 INFO - 'tabpaint']}, 19:28:15 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 19:28:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:28:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:28:15 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:28:15 INFO - 'talos_options': ['--mitmproxy', 19:28:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:28:15 INFO - '--firstNonBlankPaint'], 19:28:15 INFO - 'tests': ['quantum_pageload_google', 19:28:15 INFO - 'quantum_pageload_youtube', 19:28:15 INFO - 'quantum_pageload_amazon', 19:28:15 INFO - 'quantum_pageload_facebook']}, 19:28:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['tsvgx', 19:28:15 INFO - 'tsvgr_opacity', 19:28:15 INFO - 'tart', 19:28:15 INFO - 'tscrollx', 19:28:15 INFO - 'cart', 19:28:15 INFO - 'tsvg_static']}, 19:28:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:28:15 INFO - 'tsvgr_opacity', 19:28:15 INFO - 'tart', 19:28:15 INFO - 'tscrollx', 19:28:15 INFO - 'cart', 19:28:15 INFO - 'tsvg_static']}, 19:28:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'talos_options': ['--disable-e10s'], 19:28:15 INFO - 'tests': ['tp5o']}, 19:28:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:28:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'talos_options': ['--disable-e10s', 19:28:15 INFO - '--xperf_path', 19:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:15 INFO - 'tests': ['tp5n']}, 19:28:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:28:15 INFO - 'talos_options': ['--xperf_path', 19:28:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:28:15 INFO - 'tests': ['tp5n']}}, 19:28:15 INFO - 'talos.zip': {'path': '', 19:28:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:28:15 INFO - Running post-action listener: _resource_record_post_action 19:28:15 INFO - [mozharness: 2017-07-11 02:28:15.083148Z] Finished populate-webroot step (success) 19:28:15 INFO - [mozharness: 2017-07-11 02:28:15.083239Z] Running create-virtualenv step. 19:28:15 INFO - Running pre-action listener: _resource_record_pre_action 19:28:15 INFO - Running main action method: create_virtualenv 19:28:15 INFO - Creating virtualenv /builds/slave/test/build/venv 19:28:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:28:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:28:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:28:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:28:15 INFO - Using real prefix '/usr' 19:28:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:28:15 INFO - Installing distribute.............................................................................................................................................................................................done. 19:28:17 INFO - Installing pip.................done. 19:28:17 INFO - Return code: 0 19:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:28:18 INFO - Reading from file tmpfile_stdout 19:28:18 INFO - Output received: 19:28:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:28:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:28:18 INFO - Using env: {'DISPLAY': ':0', 19:28:18 INFO - 'HOME': '/home/cltbld', 19:28:18 INFO - 'LANG': 'en_US.UTF-8', 19:28:18 INFO - 'LANGUAGE': 'en_US:en', 19:28:18 INFO - 'LOGNAME': 'cltbld', 19:28:18 INFO - 'MAIL': '/var/mail/cltbld', 19:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:18 INFO - 'MOZ_NO_REMOTE': '1', 19:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:18 INFO - 'NO_EM_RESTART': '1', 19:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:18 INFO - 'PWD': '/builds/slave/test', 19:28:18 INFO - 'SHELL': '/bin/bash', 19:28:18 INFO - 'SHLVL': '1', 19:28:18 INFO - 'TERM': 'linux', 19:28:18 INFO - 'TMOUT': '86400', 19:28:18 INFO - 'USER': 'cltbld', 19:28:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:18 INFO - '_': '/tools/buildbot/bin/python'} 19:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:28:18 INFO - Cleaning up... 19:28:18 INFO - Return code: 0 19:28:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:28:18 INFO - Using env: {'DISPLAY': ':0', 19:28:18 INFO - 'HOME': '/home/cltbld', 19:28:18 INFO - 'LANG': 'en_US.UTF-8', 19:28:18 INFO - 'LANGUAGE': 'en_US:en', 19:28:18 INFO - 'LOGNAME': 'cltbld', 19:28:18 INFO - 'MAIL': '/var/mail/cltbld', 19:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:18 INFO - 'MOZ_NO_REMOTE': '1', 19:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:18 INFO - 'NO_EM_RESTART': '1', 19:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:18 INFO - 'PWD': '/builds/slave/test', 19:28:18 INFO - 'SHELL': '/bin/bash', 19:28:18 INFO - 'SHLVL': '1', 19:28:18 INFO - 'TERM': 'linux', 19:28:18 INFO - 'TMOUT': '86400', 19:28:18 INFO - 'USER': 'cltbld', 19:28:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:18 INFO - '_': '/tools/buildbot/bin/python'} 19:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:18 INFO - Downloading/unpacking psutil>=3.1.1 19:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:28:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:19 INFO - Installing collected packages: psutil 19:28:19 INFO - Running setup.py install for psutil 19:28:19 INFO - building 'psutil._psutil_linux' extension 19:28:19 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 19:28:21 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 19:28:21 INFO - building 'psutil._psutil_posix' extension 19:28:21 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 19:28:21 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 19:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:28:21 INFO - Successfully installed psutil 19:28:21 INFO - Cleaning up... 19:28:21 INFO - Return code: 0 19:28:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28: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')]} 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:21 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 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:21 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 19:28:21 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 19:28:21 INFO - Using env: {'DISPLAY': ':0', 19:28:21 INFO - 'HOME': '/home/cltbld', 19:28:21 INFO - 'LANG': 'en_US.UTF-8', 19:28:21 INFO - 'LANGUAGE': 'en_US:en', 19:28:21 INFO - 'LOGNAME': 'cltbld', 19:28:21 INFO - 'MAIL': '/var/mail/cltbld', 19:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:21 INFO - 'MOZ_NO_REMOTE': '1', 19:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:21 INFO - 'NO_EM_RESTART': '1', 19:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:21 INFO - 'PWD': '/builds/slave/test', 19:28:21 INFO - 'SHELL': '/bin/bash', 19:28:21 INFO - 'SHLVL': '1', 19:28:21 INFO - 'TERM': 'linux', 19:28:21 INFO - 'TMOUT': '86400', 19:28:21 INFO - 'USER': 'cltbld', 19:28:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:21 INFO - '_': '/tools/buildbot/bin/python'} 19:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:28:22 INFO - Installing collected packages: mozsystemmonitor 19:28:22 INFO - Running setup.py install for mozsystemmonitor 19:28:22 INFO - Successfully installed mozsystemmonitor 19:28:22 INFO - Cleaning up... 19:28:22 INFO - Return code: 0 19:28:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:28:22 INFO - Using env: {'DISPLAY': ':0', 19:28:22 INFO - 'HOME': '/home/cltbld', 19:28:22 INFO - 'LANG': 'en_US.UTF-8', 19:28:22 INFO - 'LANGUAGE': 'en_US:en', 19:28:22 INFO - 'LOGNAME': 'cltbld', 19:28:22 INFO - 'MAIL': '/var/mail/cltbld', 19:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:22 INFO - 'MOZ_NO_REMOTE': '1', 19:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:22 INFO - 'NO_EM_RESTART': '1', 19:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:22 INFO - 'PWD': '/builds/slave/test', 19:28:22 INFO - 'SHELL': '/bin/bash', 19:28:22 INFO - 'SHLVL': '1', 19:28:22 INFO - 'TERM': 'linux', 19:28:22 INFO - 'TMOUT': '86400', 19:28:22 INFO - 'USER': 'cltbld', 19:28:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:22 INFO - '_': '/tools/buildbot/bin/python'} 19:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:23 INFO - Downloading/unpacking jsonschema==2.5.1 19:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:28:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:28: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 19:28: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 19:28: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 19:28: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 19:28:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:28:24 INFO - warning: no files found matching '*.txt' 19:28:24 INFO - no previously-included directories found matching 'build' 19:28:24 INFO - no previously-included directories found matching 'dist' 19:28:24 INFO - no previously-included directories found matching '.git*' 19:28:24 INFO - Installing collected packages: jsonschema, functools32 19:28:24 INFO - Running setup.py install for functools32 19:28:24 INFO - warning: no files found matching '*.txt' 19:28:24 INFO - no previously-included directories found matching 'build' 19:28:24 INFO - no previously-included directories found matching 'dist' 19:28:24 INFO - no previously-included directories found matching '.git*' 19:28:24 INFO - Successfully installed jsonschema functools32 19:28:24 INFO - Cleaning up... 19:28:24 INFO - Return code: 0 19:28:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28: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')]} 19:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:28:24 INFO - Using env: {'DISPLAY': ':0', 19:28:24 INFO - 'HOME': '/home/cltbld', 19:28:24 INFO - 'LANG': 'en_US.UTF-8', 19:28:24 INFO - 'LANGUAGE': 'en_US:en', 19:28:24 INFO - 'LOGNAME': 'cltbld', 19:28:24 INFO - 'MAIL': '/var/mail/cltbld', 19:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:24 INFO - 'MOZ_NO_REMOTE': '1', 19:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:24 INFO - 'NO_EM_RESTART': '1', 19:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:24 INFO - 'PWD': '/builds/slave/test', 19:28:24 INFO - 'SHELL': '/bin/bash', 19:28:24 INFO - 'SHLVL': '1', 19:28:24 INFO - 'TERM': 'linux', 19:28:24 INFO - 'TMOUT': '86400', 19:28:24 INFO - 'USER': 'cltbld', 19:28:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:24 INFO - '_': '/tools/buildbot/bin/python'} 19:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:28:24 INFO - Cleaning up... 19:28:24 INFO - Return code: 0 19:28:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:28: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')]} 19:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28: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')]} 19:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:28:24 INFO - Using env: {'DISPLAY': ':0', 19:28:24 INFO - 'HOME': '/home/cltbld', 19:28:24 INFO - 'LANG': 'en_US.UTF-8', 19:28:24 INFO - 'LANGUAGE': 'en_US:en', 19:28:24 INFO - 'LOGNAME': 'cltbld', 19:28:24 INFO - 'MAIL': '/var/mail/cltbld', 19:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:24 INFO - 'MOZ_NO_REMOTE': '1', 19:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:24 INFO - 'NO_EM_RESTART': '1', 19:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:24 INFO - 'PWD': '/builds/slave/test', 19:28:24 INFO - 'SHELL': '/bin/bash', 19:28:24 INFO - 'SHLVL': '1', 19:28:24 INFO - 'TERM': 'linux', 19:28:24 INFO - 'TMOUT': '86400', 19:28:24 INFO - 'USER': 'cltbld', 19:28:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:24 INFO - '_': '/tools/buildbot/bin/python'} 19:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 19:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:26 INFO - Downloading blobuploader-1.2.4.tar.gz 19:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:28:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:28:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:26 INFO - Downloading docopt-0.6.1.tar.gz 19:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:28:26 INFO - Installing collected packages: blobuploader, requests, docopt 19:28:26 INFO - Running setup.py install for blobuploader 19:28:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:28:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:28:26 INFO - Running setup.py install for requests 19:28:27 INFO - Running setup.py install for docopt 19:28:27 INFO - Successfully installed blobuploader requests docopt 19:28:27 INFO - Cleaning up... 19:28:27 INFO - Return code: 0 19:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:27 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 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:27 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 19:28:27 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 19:28:27 INFO - Using env: {'DISPLAY': ':0', 19:28:27 INFO - 'HOME': '/home/cltbld', 19:28:27 INFO - 'LANG': 'en_US.UTF-8', 19:28:27 INFO - 'LANGUAGE': 'en_US:en', 19:28:27 INFO - 'LOGNAME': 'cltbld', 19:28:27 INFO - 'MAIL': '/var/mail/cltbld', 19:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:27 INFO - 'MOZ_NO_REMOTE': '1', 19:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:27 INFO - 'NO_EM_RESTART': '1', 19:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:27 INFO - 'PWD': '/builds/slave/test', 19:28:27 INFO - 'SHELL': '/bin/bash', 19:28:27 INFO - 'SHLVL': '1', 19:28:27 INFO - 'TERM': 'linux', 19:28:27 INFO - 'TMOUT': '86400', 19:28:27 INFO - 'USER': 'cltbld', 19:28:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:27 INFO - '_': '/tools/buildbot/bin/python'} 19:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:27 INFO - Running setup.py (path:/tmp/pip-GU4rQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:27 INFO - Running setup.py (path:/tmp/pip-0ByQI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:27 INFO - Running setup.py (path:/tmp/pip-hNp3tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:27 INFO - Running setup.py (path:/tmp/pip-snrOFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:27 INFO - Running setup.py (path:/tmp/pip-7KW7S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:27 INFO - Running setup.py (path:/tmp/pip-IHIdeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:27 INFO - Running setup.py (path:/tmp/pip-yosTK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:27 INFO - Running setup.py (path:/tmp/pip-uFCa8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:28 INFO - Running setup.py (path:/tmp/pip-BJ_dCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:28 INFO - Running setup.py (path:/tmp/pip-NkaoP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:28 INFO - Running setup.py (path:/tmp/pip-cyq3w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:28 INFO - Running setup.py (path:/tmp/pip-estpbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:28 INFO - Running setup.py (path:/tmp/pip-QO347a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:28 INFO - Running setup.py (path:/tmp/pip-0aOyuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:28 INFO - Running setup.py (path:/tmp/pip-cwe3OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:28 INFO - Running setup.py (path:/tmp/pip-1paz1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:28 INFO - Running setup.py (path:/tmp/pip-6iZnnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:28:28 INFO - Running setup.py install for manifestparser 19:28:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:28:28 INFO - Running setup.py install for mozcrash 19:28:28 INFO - Running setup.py install for mozdebug 19:28:28 INFO - Running setup.py install for mozdevice 19:28:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for mozfile 19:28:29 INFO - Running setup.py install for mozhttpd 19:28:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for mozinfo 19:28:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for mozInstall 19:28:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for mozleak 19:28:29 INFO - Running setup.py install for mozlog 19:28:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for moznetwork 19:28:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:28:29 INFO - Running setup.py install for mozprocess 19:28:29 INFO - Running setup.py install for mozprofile 19:28:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:28:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:28:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:28:30 INFO - Running setup.py install for mozrunner 19:28:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:28:30 INFO - Running setup.py install for mozscreenshot 19:28:30 INFO - Running setup.py install for moztest 19:28:30 INFO - Running setup.py install for mozversion 19:28:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:28:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:28:30 INFO - Cleaning up... 19:28:30 INFO - Return code: 0 19:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:28:30 INFO - Using env: {'DISPLAY': ':0', 19:28:30 INFO - 'HOME': '/home/cltbld', 19:28:30 INFO - 'LANG': 'en_US.UTF-8', 19:28:30 INFO - 'LANGUAGE': 'en_US:en', 19:28:30 INFO - 'LOGNAME': 'cltbld', 19:28:30 INFO - 'MAIL': '/var/mail/cltbld', 19:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:30 INFO - 'MOZ_NO_REMOTE': '1', 19:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:30 INFO - 'NO_EM_RESTART': '1', 19:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:30 INFO - 'PWD': '/builds/slave/test', 19:28:30 INFO - 'SHELL': '/bin/bash', 19:28:30 INFO - 'SHLVL': '1', 19:28:30 INFO - 'TERM': 'linux', 19:28:30 INFO - 'TMOUT': '86400', 19:28:30 INFO - 'USER': 'cltbld', 19:28:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:30 INFO - '_': '/tools/buildbot/bin/python'} 19:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:28:30 INFO - Running setup.py (path:/tmp/pip-ezxGOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:28:30 INFO - Running setup.py (path:/tmp/pip-wSIKcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:28:30 INFO - Running setup.py (path:/tmp/pip-rrxb9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:28:30 INFO - Running setup.py (path:/tmp/pip-Vv4DSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:28:31 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)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:28:31 INFO - Running setup.py (path:/tmp/pip-T1ZA1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:28:31 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)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:28:31 INFO - Running setup.py (path:/tmp/pip-I6xED4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:28:31 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)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:28:31 INFO - Running setup.py (path:/tmp/pip-8X2bYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:28:31 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)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:28:31 INFO - Running setup.py (path:/tmp/pip-GPSz2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:28:31 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)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:28:31 INFO - Running setup.py (path:/tmp/pip-yYhiHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:28:31 INFO - Running setup.py (path:/tmp/pip-HxXMZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:28:31 INFO - Running setup.py (path:/tmp/pip-Eypjid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:28:31 INFO - Running setup.py (path:/tmp/pip-XQYW6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:28:31 INFO - Running setup.py (path:/tmp/pip-TafkfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:28:31 INFO - Running setup.py (path:/tmp/pip-h8zBvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:31 INFO - Running setup.py (path:/tmp/pip-961xiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:28:31 INFO - Running setup.py (path:/tmp/pip-9x0He9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:28:31 INFO - Running setup.py (path:/tmp/pip-cyTMmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:28:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:33 INFO - Downloading blessings-1.6.tar.gz 19:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:28:33 INFO - Installing collected packages: blessings 19:28:33 INFO - Running setup.py install for blessings 19:28:33 INFO - Successfully installed blessings 19:28:33 INFO - Cleaning up... 19:28:33 INFO - Return code: 0 19:28:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:28:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:33 INFO - Reading from file tmpfile_stdout 19:28:33 INFO - Current package versions: 19:28:33 INFO - argparse == 1.2.1 19:28:33 INFO - blessings == 1.6 19:28:33 INFO - blobuploader == 1.2.4 19:28:33 INFO - docopt == 0.6.1 19:28:33 INFO - functools32 == 3.2.3-2 19:28:33 INFO - jsonschema == 2.5.1 19:28:33 INFO - manifestparser == 1.1 19:28:33 INFO - mozInstall == 1.13 19:28:33 INFO - mozcrash == 1.0 19:28:33 INFO - mozdebug == 0.1 19:28:33 INFO - mozdevice == 0.51 19:28:33 INFO - mozfile == 1.2 19:28:33 INFO - mozhttpd == 0.7 19:28:33 INFO - mozinfo == 0.10 19:28:33 INFO - mozleak == 0.1 19:28:33 INFO - mozlog == 3.5 19:28:33 INFO - moznetwork == 0.27 19:28:33 INFO - mozprocess == 0.25 19:28:33 INFO - mozprofile == 0.28 19:28:33 INFO - mozrunner == 6.13 19:28:33 INFO - mozscreenshot == 0.1 19:28:33 INFO - mozsystemmonitor == 0.3 19:28:33 INFO - moztest == 0.8 19:28:33 INFO - mozversion == 1.4 19:28:33 INFO - psutil == 3.1.1 19:28:33 INFO - requests == 1.2.3 19:28:33 INFO - wsgiref == 0.1.2 19:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:28:33 INFO - Using env: {'DISPLAY': ':0', 19:28:33 INFO - 'HOME': '/home/cltbld', 19:28:33 INFO - 'LANG': 'en_US.UTF-8', 19:28:33 INFO - 'LANGUAGE': 'en_US:en', 19:28:33 INFO - 'LOGNAME': 'cltbld', 19:28:33 INFO - 'MAIL': '/var/mail/cltbld', 19:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:33 INFO - 'MOZ_NO_REMOTE': '1', 19:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:33 INFO - 'NO_EM_RESTART': '1', 19:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:33 INFO - 'PWD': '/builds/slave/test', 19:28:33 INFO - 'SHELL': '/bin/bash', 19:28:33 INFO - 'SHLVL': '1', 19:28:33 INFO - 'TERM': 'linux', 19:28:33 INFO - 'TMOUT': '86400', 19:28:33 INFO - 'USER': 'cltbld', 19:28:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:33 INFO - '_': '/tools/buildbot/bin/python'} 19:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:28:33 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:28:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:28:34 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:28:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:28:34 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 19:28:34 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 19:28:34 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 19:28:34 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 19:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:28:35 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)) 19:28:35 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)) 19:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:28:35 INFO - Installing collected packages: marionette-driver, simplejson 19:28:35 INFO - Running setup.py install for marionette-driver 19:28:35 INFO - Running setup.py install for simplejson 19:28:35 INFO - building 'simplejson._speedups' extension 19:28:35 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 19:28:36 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 19:28:36 INFO - Successfully installed marionette-driver simplejson 19:28:36 INFO - Cleaning up... 19:28:36 INFO - Return code: 0 19:28:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:36 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 0x24311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ffa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', '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 19:28:36 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 19:28:36 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 19:28:36 INFO - Using env: {'DISPLAY': ':0', 19:28:36 INFO - 'HOME': '/home/cltbld', 19:28:36 INFO - 'LANG': 'en_US.UTF-8', 19:28:36 INFO - 'LANGUAGE': 'en_US:en', 19:28:36 INFO - 'LOGNAME': 'cltbld', 19:28:36 INFO - 'MAIL': '/var/mail/cltbld', 19:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:36 INFO - 'MOZ_NO_REMOTE': '1', 19:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:36 INFO - 'NO_EM_RESTART': '1', 19:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:36 INFO - 'PWD': '/builds/slave/test', 19:28:36 INFO - 'SHELL': '/bin/bash', 19:28:36 INFO - 'SHLVL': '1', 19:28:36 INFO - 'TERM': 'linux', 19:28:36 INFO - 'TMOUT': '86400', 19:28:36 INFO - 'USER': 'cltbld', 19:28:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:36 INFO - '_': '/tools/buildbot/bin/python'} 19:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:28:36 INFO - Cleaning up... 19:28:36 INFO - Return code: 0 19:28:36 INFO - Running post-action listener: _resource_record_post_action 19:28:36 INFO - Running post-action listener: _start_resource_monitoring 19:28:36 INFO - Starting resource monitoring. 19:28:36 INFO - [mozharness: 2017-07-11 02:28:36.551581Z] Finished create-virtualenv step (success) 19:28:36 INFO - [mozharness: 2017-07-11 02:28:36.552582Z] Running install step. 19:28:36 INFO - Running pre-action listener: _resource_record_pre_action 19:28:36 INFO - Running main action method: install 19:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:36 INFO - Reading from file tmpfile_stdout 19:28:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:28:36 INFO - Reading from file tmpfile_stdout 19:28:36 INFO - Output received: 19:28:36 INFO - Usage: mozinstall [options] installer 19:28:36 INFO - Options: 19:28:36 INFO - -h, --help show this help message and exit 19:28:36 INFO - -d DEST, --destination=DEST 19:28:36 INFO - Directory to install application into. [default: 19:28:36 INFO - "/builds/slave/test"] 19:28:36 INFO - --app=APP Application being installed. [default: firefox] 19:28:36 INFO - mkdir: /builds/slave/test/build/application 19:28:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:28:54 INFO - Reading from file tmpfile_stdout 19:28:54 INFO - Output received: 19:28:54 INFO - /builds/slave/test/build/application/firefox/firefox 19:28:54 INFO - Running post-action listener: _resource_record_post_action 19:28:54 INFO - [mozharness: 2017-07-11 02:28:54.922942Z] Finished install step (success) 19:28:54 INFO - [mozharness: 2017-07-11 02:28:54.923283Z] Running setup-mitmproxy step. 19:28:54 INFO - Running pre-action listener: _resource_record_pre_action 19:28:54 INFO - Running main action method: setup_mitmproxy 19:28:54 INFO - Skipping: mitmproxy is not required 19:28:54 INFO - Running post-action listener: _resource_record_post_action 19:28:54 INFO - [mozharness: 2017-07-11 02:28:54.924991Z] Finished setup-mitmproxy step (success) 19:28:54 INFO - [mozharness: 2017-07-11 02:28:54.925304Z] Running run-tests step. 19:28:54 INFO - Running pre-action listener: _resource_record_pre_action 19:28:54 INFO - Running pre-action listener: _set_gcov_prefix 19:28:54 INFO - Running main action method: run_tests 19:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:54 INFO - Python 2.7.3 19:28:54 INFO - Return code: 0 19:28:54 INFO - grabbing minidump binary from tooltool 19:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f980>, '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 0x27a0730>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0bc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:28:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:28:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:28:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:55 INFO - Return code: 0 19:28:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:28:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:55 INFO - ENV: RUST_BACKTRACE is now 1 19:28:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:28:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:28:55 INFO - Using env: {'DISPLAY': ':0', 19:28:55 INFO - 'HOME': '/home/cltbld', 19:28:55 INFO - 'LANG': 'en_US.UTF-8', 19:28:55 INFO - 'LANGUAGE': 'en_US:en', 19:28:55 INFO - 'LOGNAME': 'cltbld', 19:28:55 INFO - 'MAIL': '/var/mail/cltbld', 19:28:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:55 INFO - 'MOZ_NO_REMOTE': '1', 19:28:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:55 INFO - 'NO_EM_RESTART': '1', 19:28:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:55 INFO - 'PWD': '/builds/slave/test', 19:28:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:55 INFO - 'RUST_BACKTRACE': '1', 19:28:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:28:55 INFO - 'SHELL': '/bin/bash', 19:28:55 INFO - 'SHLVL': '1', 19:28:55 INFO - 'TERM': 'linux', 19:28:55 INFO - 'TMOUT': '86400', 19:28:55 INFO - 'USER': 'cltbld', 19:28:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034', 19:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:55 INFO - '_': '/tools/buildbot/bin/python'} 19:28:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:28:55 INFO - mozversion application_buildid: 20170711014314 19:28:55 INFO - mozversion application_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:28:55 INFO - mozversion application_display_name: Nightly 19:28:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:55 INFO - mozversion application_name: Firefox 19:28:55 INFO - mozversion application_remotingname: firefox 19:28:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:28:55 INFO - mozversion application_vendor: Mozilla 19:28:55 INFO - mozversion application_version: 56.0a1 19:28:55 INFO - mozversion platform_buildid: 20170711014314 19:28:55 INFO - mozversion platform_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:28:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:28:55 INFO - mozversion platform_version: 56.0a1 19:28:55 INFO - using testdate: 1499740135 19:28:55 INFO - actual date: 1499740135 19:28:55 INFO - starting webserver on 'localhost:49350' 19:28:55 INFO - SUITE-START | Running 2 tests 19:28:55 INFO - TEST-START | dromaeo_css 19:28:55 INFO - Initialising browser for dromaeo_css test... 19:28:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49350/getInfo.html -profile /tmp/tmpDjCaXo/profile 19:28:55 INFO - TEST-INFO | started process 3399 (/builds/slave/test/build/application/firefox/firefox http://localhost:49350/getInfo.html) 19:29:03 INFO - TEST-INFO | 3399: exit 0 19:29:03 INFO - Browser initialized. 19:29:03 INFO - Running cycle 1/1 for dromaeo_css test... 19:29:03 INFO - TEST-INFO | started process 3605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjCaXo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:15 INFO - PID 3605 | RSS: Main: 169988096 19:29:15 INFO - PID 3605 | 19:32:16 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49350/tests/dromaeo/cssquery-ext.html) 19:32:17 INFO - PID 3605 | RSS: Main: 176766976 19:32:17 INFO - PID 3605 | 19:35:19 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-ext.html (next: http://localhost:49350/tests/dromaeo/cssquery-jquery.html) 19:35:20 INFO - PID 3605 | RSS: Main: 174960640 19:35:20 INFO - PID 3605 | 19:38:21 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49350/tests/dromaeo/cssquery-mootools.html) 19:38:22 INFO - PID 3605 | RSS: Main: 177623040 19:38:22 INFO - PID 3605 | 19:41:24 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49350/tests/dromaeo/cssquery-prototype.html) 19:41:24 INFO - PID 3605 | RSS: Main: 176926720 19:41:24 INFO - PID 3605 | 19:44:27 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49350/tests/dromaeo/cssquery-yui.html) 19:44:28 INFO - PID 3605 | RSS: Main: 176295936 19:44:28 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:49350/tests/dromaeo/cssquery-yui.html (next: http://localhost:49350/tests/dromaeo/cssquery-dojo.html) 19:47:30 INFO - PID 3605 | RSS: Main: 177008640 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | __start_tp_report 19:47:30 INFO - PID 3605 | _x_x_mozilla_page_load 19:47:30 INFO - PID 3605 | _x_x_mozilla_page_load_details 19:47:30 INFO - PID 3605 | |i|pagename|runs| 19:47:30 INFO - PID 3605 | |0;dojo.html;3117.3141908780062;3178.6185657721076;3197.7601679874015;3201.0716892101286;3227.4997375406806;5931.584789064767;6007.189029481019;6054;6063.120847477118;6068.939310606893;6027.728752206151;6066.4236897494775;6084.665343406122;6127.295361033483;6130.969345153279;5523.944760552404;5574.526165275956;5576.86057848553;5615.298087739033;5632.464915832989;5572.916406253909;5593.944060559383;5601.103823388259;5620.803271885485;5621.831345059655;5601.271834661508;5612.186232996213;5623.212750214973;5624.634398764088;5629.521490673298;5585.972070139664;5594.1888426177975;5606.691631960241;5613.607047506676;5622.240997465351;5451.155070964007;5591.161325801122;5600.859978500529;5615.634983726086;5665;6106.4809491192855;6143.539234557426;6156.353582873823;6172;6207.596506227081;6381.840453988641;6486.416222539947;6501.414872661483;6603.834904127387;6604;6540.247871494744;6550.312217217172;6594.274629790719;6613.371729685672;6623.768168114093;6079.665618390986;6083.574149809515;6139.938600613981;6143.754249830002;6156.138140660311;6698;6725.19297684281;6727.764528241488;6750;6801.081853949752;6350.7777227796805;6399.55203135776;6432.646204458706;6489.870202595922;6501.544891857525;6472.46612115201;6476.125723027331;6576.1122248496795;6599.835004124935;6602.207735071726;6401.167848179707;6439.066335381343;6463.547551671338;6472.644004579699;6473.417392434703;6426.196725409324;6522.902156467657;6526.608403495806;6538.640374779433;6601.900971485432;5245.10833158364;5312.043832110257;5314.415414304423;5378.220158077057;5416.241726158341;4552.544745525421;4560.703554268962;4576.222042252825;4591.219492686251;4593.402857628487;5733.254676892061;5734.197212390269;5746.482816546531;5760.596758226884;5765.884682306414;6533.934660653427;6590.1103351046995;6597.934020659828;6605.141331626954;6608.537402381787;5691.886162276731;5714.371419143891;5773.971130144322;5780.306363236438;5796.478316951495;5707;5793.073108302651;5794.275715535558;5818.214541036906;5890.617109887844;6321.96839015802;6369.8726025480155;6389.041643753474;6398.648074355862;6403.423691867754;6514.57655252407;6552.6723663817575;6554.082428459924;6608.273089960005;6613.66931653425;6314.179156709783;6364.586301890362;6370.362963703593;6402.167718196604;6444.613323200623;6445;6446.5165112615805;6497.642629655415;6543.312952140147;6552.180977377828;6553.2136143663065;6587.868242635216;6648.434883034996;6651.235107962646;6679.398854103154;6261.060840873905;6322.241331040304;6329.113924050729;6350.301466838551;6362.268339141058;6292.496600271876;6334.461570766536;6373.267074286517;6393.904091438539;6404.039394090737;4959.876003099951;6265.373462653881;6300;6301.023341382093;6346;6421.486281097595;6428.742850285937;6453.257875344208;6505.186851643544;6517.4134327910715;6203.8138855834395;6211.751529938751;6285.057241413824;6300.2754683212015;6306.337834527492 19:47:30 INFO - PID 3605 | |1;ext.html;766.6856588798594;859.4800145911722;892.5671049540972;898.0704970355681;1172.9120315976304;29087.85456072719;30821.845890770543;30830.075097747074;41682.37476437848;42003.57996420035;41578.37632435516;41908;42176.578234217646;42182.99999999992;42241;7487.25127487251;7523.247675232487;7587.848243035163;7618.314351708345;7683.423743219253;7442.995195648599;7626.389888808882;7689.154193038761;7699.6920123195005;7711.5758633275145;7575.924240757605;7709.421793365492;7758.030246219223;7834.05991281047;7837.216278372174;7741.303282704555;7797.376209903194;7798.337141342992;7801.180876007994;7824.334931530827;7617.314441700273;7686.807829804299;7692.615369231516;7705.422093342966;7734.381249500027;38495.807520962495;38569.228615427535;38617.61382386196;38690.226195476214;38834;3568.5360903082433;3579;3588.102974256436;3604.7656902301264;3608.9819550902075;30375.544366834514;30460.54309185364;30488.847555762302;30519.847400762854;30654.233644158852;4528.27547592387;4689.062187562467;4774.069056533977;4882.292067650206;4885.755712214375;179703;181071;181880;182530;182647.99999999866;42286;48065.27902081471;48473;48526.75736621294;48962.26556601654;51353.74323128435;51460.485395146316;51482.742586286826;51500.48499515032;51534.74232628813;16033.278502467418;16150;16227.675446491005;16276.348946042262;16288.837111628733;13434.93282533581;13446.798298025538;13480.5281815136;13497.730045399234;13549;14376.784348234785;14404.207768572829;14454.27728613586;14579.125252484884;14813.259337033105;5649.519790817826;5800.9129863052085;5864.266966629171;5919.3192782829665;5931.881362372815;1009.9394036357695;1014.8629934958686;1019.7297716105238;1054.0987455725399;1055.614700634263;22141.778582214294;22382;22530;22937.19719809832;23413.882930585238;1074.7055037495004;1084.4306738962107;1104.3594715065242;1127.3563493607478;1127.7800828838297;11543.19197656156;11805.330106543212;11871.525138994344;11957.162998590189;12306.261624302571;231927;232106;232246;232479;234124;52500.474995249555;52559.47440525546;52717;52796;53263.46736532585;1443.227873087893;1474.5502621700484;1505.1947208243537;1521.3154080663746;1523.6419441431256;21710.240141594968;21952.491913887017;22119.889400552893;22385.77614223837;22850.542989140456;36404.27191456209;36420.4536931941;36496;36565.81717091398;36623.45064823976;181171;184461;184851;185178;185395;33611.15972100717;35301.646983529834;35531;37006;37116;46890.296645551025;46900.29649555191;47382.52617473919;47829.76085119552;48400.5159948396;33263.04217469499;33867.49198761971;34007.82996085004;34226.31547368989;34230.82884585561;32740.508892366157;33207.169820753705;33703.4944475838;33789.83105084459;33960;36296;37579.436308454846;37721.62278377181;37824.43263350997;38104.80947595244;31775.841120794248;32294.35411291808;33045.66954330522;33144;33169;23843.880780595988;23917.756486467057;24211.87894060589;24665.753342467062;24727.752722472545 19:47:30 INFO - PID 3605 | |2;jquery.html;577.8959787238296;578.9131630255462;582.1820342418903;587.9941200587995;607.7356349987756;21559.784402155972;22432.55134897301;22457.775422245813;22483.10067597296;22534.323970280897;24285.271441856727;25389.365265868317;26711.599326010124;26893.462130757373;26926.192214233557;6406.359364063603;6582.506312026593;6586.176727909012;6597.142371491699;6602.372774586406;6487.643179625119;6488.870222595545;6526.934730652681;6572.7042283097135;6575.802725918206;4062.5531191568903;4862.756862156895;5998.620317327018;6507.9023814642815;6551.115599394092;6540.542162048659;6553.377429144223;6563.835904102388;6570.901436478457;6579.572327798702;6066.817995460143;6082.239720034996;6121.755129794803;6130.141780150782;6131.141640170335;27753.583696244572;29247.56128658072;29290.267743306376;29516;29522.70477295221;1891.2435025989578;1929.6237233739425;1938.4863011302016;1955.7848636649958;1966.1250743419184;18528.722069168973;19062.428127156207;19211.423657290303;19243.134058967382;19260.614787704166;2345.7888790008983;2349.89425475854;2390.0439824070336;2392.7248366437907;2410.5781488239486;134250.3287483566;138327.30836345855;139044;139251.30374348164;139856.30071849577;13859.445622175203;15113.372790530193;15610.687786244438;15750.369985200692;16219.594510137342;23763;23895.761042389353;23911;23994.28017159488;24068.15761448341;10193.388396696073;10343.173025980435;10348.5343159558;10401.063904248502;10471.42407167613;9529.857052144223;9550.665726699672;9650.227981761442;9674.951625241829;9723.902760972442;9235.907640923639;9237.445753254691;9285;9292.024337444605;9563.760905977268;2608.0097450900153;2725.591161325777;2820.689724130344;2836.8085404130316;2945.1164650604733;941.8069295794346;953.7281874665687;958.1185309515263;989.9703008909744;993.5479356892597;19875.304364347467;20118.69821952672;20285.49286267855;20655.793442065387;20670.79329206719;1008.1783346572666;1025.9025392587691;1044.2429238801808;1050.5115121468555;1061.7398737309409;10905.34567925927;11043.83434248487;11055.502502387411;11224.438778061065;11277.32336059839;479630;488799;502424;511827;512821;115541;122652.38673806573;123533.38233308776;124288;124843;1189.1081202158039;1210.7033776724759;1243.0987534037931;1245.5951815659946;1251.9186252893533;17261.827381726023;17814.821851781315;17843.197056132765;18545;18600.16299266563;49167;51531;53130;54401.72799135979;55229.44770552243;67823;68196;68688.31311686819;69201;69433.65283173551;14581.85418145805;14699.41202351894;14835.03572267799;14840;14863.033902796284;22076.558468830855;22573.43566410787;22733.43166420853;23104.653430198898;23555.29334119979;18292.908535457238;18422.263109475472;18465.53836154107;18619.44141675752;18621.162047708156;16514.339426422808;16788.832111678727;17057.232424540678;17089.743653844955;17331;17800;18907.71638425397;18922;19068.33260835864;19108.808911910703;14504.492342767953;14702.117872927658;14774.261286935825;14776.556703298918;14921.3285402155;17811.643767124846;18384.63230735351;18444.631107378045;18460.81539184591;18590.907045464686 19:47:30 INFO - PID 3605 | |3;mootools.html;1340.162398500937;1409.3587417724937;1410.8377536583296;1421.438531779947;1421.5806337130539;12709.110362274645;13446.798298025526;13449.125806822549;13506.59480215595;13531.93234033831;13200.867991320083;13556.254406007665;13573.11774734644;13621.523246686367;13633.863661363383;2555.2972932443636;2617.2410001099656;2626.829256098357;2631.789456843448;2635.1172357260243;2514.245726282108;2585.28904551249;2585.4699786543715;2588.0812311629384;2593.273883312666;2529;2565.256075738043;2578.419855532509;2579.7807186389086;2581.3675649465813;2329.336139200328;2344.5896968030524;2350.612148995414;2354.587947109249;2363.8463499872455;2412.0713525292713;2416.2509622017233;2434.099383228217;2436.902523899042;2437.9390515237083;12462.12765106443;12899.22604643715;12928.09503334767;12949.611511654666;12999.155054921495;6947.826304342381;7180.1383833939735;7208.315210055089;7220.169680486706;7220.205777364486;4804.483785241897;4889.413270407538;5070.492950704936;5084.79660813567;5129.743512824344;1845.2803406671276;1846.22458567402;1924.3264857299973;1941.631090092892;1954.5797653504424;19686.606267874704;19785.10967006488;19912.103955322043;21446.892765536228;22140.778592214192;6300.621962682254;6394;6613.239477460057;6616.139901812733;6621;14975;15051.849481505264;15070.397184112731;15088.094714317176;15125.924370378298;7173.784786456415;7241.167265764399;7245.673944672502;7249.601271930094;7293.927060729431;6659.500537459709;6731.293214212437;6752.696128674222;6802.965985170142;6869.347411995853;4767.570918617272;4966.577840883493;4973.204287314013;4983.875403114951;5075.086484432763;1456.1845366594741;1460.291758497128;1465.9340329684976;1470.1767010474168;1477.6527516033723;906.9682561110461;913.4747520175926;922.9630814767469;940.041158018817;949.240607513986;7205.531640443354;7208.135023797073;7309.122905251297;8501;8702.390832641655;994.5126887824914;997.5211898288862;1021.1269364693229;1027.440045175381;1032.8140934631688;4995.400551933792;5035.79856805731;5125.384953805493;5167.018266529348;5296.470352964673;15539.378424863105;15783.289751961189;16185.19074046293;16368.918155409146;16370.427035053715;17923.37268195607;18051.63896722058;18094.185761640758;18248.63502729938;18358.082095895417;9082.591283392263;9915.256355773347;10024.54889529973;10058.547365368577;10115.797684046425;7101.680424380812;7949.761507154794;8482.236598706146;8548.871766923377;8614.655413783628;14529.491467798576;15059.096454212782;15469.690606187589;15773.29020194071;15846.92076539656;14647.780283295546;15335.156566388956;15518;15682.451114210948;15936;10672.946635266773;11088.722781930517;11098.389588572383;11182.049525790399;11230.382328971986;12201.877981220074;12305.323207223688;12313;12338.81491777606;12353.567625133437;10028.247881408777;10295.330803497749;10404.531796069045;10434.739131521772;10775;9809.313348065567;10011.749706257111;10238;10328.483575821328;10387;8606.65573377083;8721.171488708562;8741.868871966799;8812.867806982773;8818.603162857558;6325.905111423241;6567.605943643397;6666.2333831609985;6786.357446086818;6829.453643708392;7063.540869843444;7107.502474826712;7199.280071992759;7219.241979592067;7266.564006159648 19:47:30 INFO - PID 3605 | |4;prototype.html;486.1371066357215;489.74777989335485;514.4444000479483;519.9298094757212;533.4798571392893;5891.322497912742;6031.6381017139;6054.424829641188;6084.543659225554;6103.443621876421;5761.596688231825;5922.58541902067;5981.700914954256;6031.72857221425;6033.27600687918;4911.975440122795;4914.361133052698;4929.186684197103;4948.307236986825;4968.35411396518;4853.951460485385;4884.487128851472;4930.580900623451;4936.531029552187;4964.205727083668;4872.707637541741;4899.412070551539;4902.65681402302;4903.215485522317;4904.558589726924;4652.418447694055;4734.313524538957;4801.207800712878;4839.830605928775;4867.951320486803;4260.680448966309;4351.49957754859;4364.258076127066;4365.301551751704;4377.627901628365;5770.509506691937;5796.478316951452;5817.127430885359;5837.824865254049;5924.792632257893;5445.564354851603;5482.479164479368;5547.944520554824;5564.582656300794;5564.749586268587;6227.750889964396;6274.403931626533;6364.236291644986;6376.87533108778;6384.3934826191435;4790.185668436374;4846.878828029292;4853.490383509751;4864.246041863516;4866.31871537985;6711.9664401678165;6722.294159113271;6800.761973330959;6817.965910170417;6848.897266541006;4967.652264341461;4968.428630707443;4977.328060711758;4983;4986.426560945465;5018.172001619765;5027.79888804451;5042.773075211624;5047.520485553867;5060.240963855451;5531.474509921551;5560.388357280696;5564.109742441271;5589.329280486368;5590.8043218487155;6331.873362532723;6347.809565713036;6354.489976459273;6372.968135159387;6432.71052802625;1713.9657206855793;1748.4929370482419;1755.218927577216;1766.6025144342677;1773.7871455425432;1124.746931940307;1225.4118023348842;1234.1484375780683;1234.1977714485477;1237.6534570320325;5514.558835293167;5601.63589366698;5603.355614104348;5666.631668941505;5706.42935706426;6393.16410153904;6547.377999090078;6550.672466376757;6598.47212223021;6604.8348791280605;5664.291963504562;5678.488935995781;5684.744186511617;5695.829125126253;5714.228579141763;3412.8293585320635;3468.3756923753967;3474.8783792567137;3494.668006539375;3511.2099777549847;6273.274849416447;6301.8109456716375;6316.778912738032;6385.361463853577;6467.902981455282;6632.209303488127;6662;6718.260991290954;6758.459323254128;6774.559653622498;6289.063085477878;6312.495000399957;6355.237371515448;6364.772329684573;6451.3226111257645;6459.64347487033;6470.935290647221;6497.707603157774;6531.183602049744;6541.724363749214;6452.935470645421;6468.611883287018;6505.154329937078;6527.967360163168;6571.737130514917;6311.873762524816;6340.161353207703;6370.3370561928;6399.712012959521;6431.356864313531;4745.691530050535;4778.450478194913;4780.067886762048;4801.351817504592;4829.4204695435365;6548.377904099103;6554.4756419487285;6597.27429982692;6618.2203474541775;6631.900521492085;6331.620102793847;6331.9366806331345;6402.455791257609;6402.903956440564;6426.260979987362;6304.432601065926;6322.905156422566;6332.746690132343;6407.487401008001;6408.487321014214;6278.372162783685;6286.811395658137;6339.778107766206;6352.237731472068;6372.490200784019;5942.7920022799;6322.620642761265;6347;6369;6457.160569125984;6108.755649774137;6147.323794382703;6177.444030037318;6185.257769067741;6232.501399887908 19:47:30 INFO - PID 3605 | |5;yui.html;862.7454900804262;882.9470231786092;895.0959530873815;897.2866571075994;906.2432868554756;17798;18050.81949180506;18384.72422913656;18529;18613;14480.479549647293;14495.275236238198;15730.685386292267;15806.13066281354;19985.70021449676;1020.1328870460105;1047.8480620310052;1048.7430579508032;1052.847337136115;1054.3673795722543;1040.6981975227175;1053.010170439788;1057.9947100264487;1058.8941105889426;1061.8194906865813;1108.4291589831244;1109.522905150785;1110;1111.3998440841976;1111.9054880335182;1001.774600714837;1090.738222826516;1099.087757161554;1099.8350247462865;1103.779244151169;795.2047952047952;797.8045378882211;798.6086817459461;798.7683571764181;805.6173317674117;18936.81063189378;19445.027748612512;19685;19699.507512312164;19761;19523.511912202168;20148.496287592927;20463.38609841707;20495;20657.896710516503;15871;15969.600759980976;15984.280707368196;16005.519834404986;16064.277107530072;3284.655111213336;3421.059208717598;3453.8791142309897;3549.8402571884326;3550.5916819565823;104028.47985760022;104160.95839041588;110102;110341;114897;15940;16453.58866028335;16462.83537164613;16516.669666606602;16548;27123.321916952234;28902.71097289042;29094;29097.85451072731;29296.414071718445;8817.647294108292;8983.236424903957;9002.954985225162;9008.864867027;9039.502827344559;4178.373244013362;4283.593058659485;4339.826406943687;4346.978265108654;4389.495208051051;5086.898262034739;5198.2722418861385;5198.81804136861;5203.271541984125;5205.791768329224;987.2595553334999;1032.2309879139939;1037.8443233515034;1047.1099565369375;1047.1151876664208;679.0934102972489;679.2324673119343;682.1064405628642;704.2921863527123;706.4136766483806;12083.45624446902;12131.689867174104;12423.875761242272;12441.875581244252;12962.870371296354;657.6350125680293;699.0667458942369;702.0802748399612;707.9398251148607;721.0302143616827;5179;5454.400015998237;5469.671819690831;5565.805196818173;5583.274174357389;96379;97533.51233243788;99648.5017574922;101628.49185754024;103275;87973.56013219892;92407;94244;94456;95887.52056239675;78058;78700.60649696714;80160.2334264736;81434.18565814385;83960.58019709984;10732.624358147428;10735.463226838783;10808.837867432152;10821.134309255398;10977.176711746491;33789.49315760216;34440.65559344374;35924.46113308355;36201.27597447984;36681.532738690155;63183;65013.67493162504;66337.66831165813;66757.66621166863;67197.3280267191;17867.821321786614;18168.273269069618;18385.356512521998;18777.248910043447;18879.05604719786;20189.79810201938;20280.290189843283;21263.468413289793;21397.89301053547;21556.27549796044;18582.349617763313;18640.720389193903;18953.620927581647;19538.413847584594;19945.301914432926;18073.548161296072;18077.457676269732;19643.803561964196;19703.901480492506;19873.900630496755;18630.347937822655;18992.43022709321;19069.046547672282;19109.426717198505;19228.23087076501;13121.606351809462;13719.382627781973;13788.241646709528;14320.713585728436;14343;13960.720785584028;14161.150330980174;14227.64430889236;14396;14494.130352178903 19:47:30 INFO - PID 3605 | __end_tp_report 19:47:30 INFO - PID 3605 | __start_cc_report 19:47:30 INFO - PID 3605 | _x_x_mozilla_cycle_collect,364 19:47:30 INFO - PID 3605 | __end_cc_report 19:47:30 INFO - PID 3605 | __startTimestamp1499741250422__endTimestamp 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | ------- Summary: start ------- 19:47:30 INFO - PID 3605 | Number of tests: 6 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#0] dojo.html Cycles:165 Average:6031.79 Median:6300.00 stddev:697.68 (11.1%) stddev-sans-first:661.29 19:47:30 INFO - PID 3605 | Values: 3117.3 3178.6 3197.8 3201.1 3227.5 5931.6 6007.2 6054.0 6063.1 6068.9 6027.7 6066.4 6084.7 6127.3 6131.0 5523.9 5574.5 5576.9 5615.3 5632.5 5572.9 5593.9 5601.1 5620.8 5621.8 5601.3 5612.2 5623.2 5624.6 5629.5 5586.0 5594.2 5606.7 5613.6 5622.2 5451.2 5591.2 5600.9 5615.6 5665.0 6106.5 6143.5 6156.4 6172.0 6207.6 6381.8 6486.4 6501.4 6603.8 6604.0 6540.2 6550.3 6594.3 6613.4 6623.8 6079.7 6083.6 6139.9 6143.8 6156.1 6698.0 6725.2 6727.8 6750.0 6801.1 6350.8 6399.6 6432.6 6489.9 6501.5 6472.5 6476.1 6576.1 6599.8 6602.2 6401.2 6439.1 6463.5 6472.6 6473.4 6426.2 6522.9 6526.6 6538.6 6601.9 5245.1 5312.0 5314.4 5378.2 5416.2 4552.5 4560.7 4576.2 4591.2 4593.4 5733.3 5734.2 5746.5 5760.6 5765.9 6533.9 6590.1 6597.9 6605.1 6608.5 5691.9 5714.4 5774.0 5780.3 5796.5 5707.0 5793.1 5794.3 5818.2 5890.6 6322.0 6369.9 6389.0 6398.6 6403.4 6514.6 6552.7 6554.1 6608.3 6613.7 6314.2 6364.6 6370.4 6402.2 6444.6 6445.0 6446.5 6497.6 6543.3 6552.2 6553.2 6587.9 6648.4 6651.2 6679.4 6261.1 6322.2 6329.1 6350.3 6362.3 6292.5 6334.5 6373.3 6393.9 6404.0 4959.9 6265.4 6300.0 6301.0 6346.0 6421.5 6428.7 6453.3 6505.2 6517.4 6203.8 6211.8 6285.1 6300.3 6306.3 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#1] ext.html Cycles:180 Average:37099.87 Median:35416.32 stddev:52034.99 (146.9%) stddev-sans-first:52109.44 19:47:30 INFO - PID 3605 | Values: 766.7 859.5 892.6 898.1 1172.9 29087.9 30821.8 30830.1 41682.4 42003.6 41578.4 41908.0 42176.6 42183.0 42241.0 7487.3 7523.2 7587.8 7618.3 7683.4 7443.0 7626.4 7689.2 7699.7 7711.6 7575.9 7709.4 7758.0 7834.1 7837.2 7741.3 7797.4 7798.3 7801.2 7824.3 7617.3 7686.8 7692.6 7705.4 7734.4 38495.8 38569.2 38617.6 38690.2 38834.0 3568.5 3579.0 3588.1 3604.8 3609.0 30375.5 30460.5 30488.8 30519.8 30654.2 4528.3 4689.1 4774.1 4882.3 4885.8 179703.0 181071.0 181880.0 182530.0 182648.0 42286.0 48065.3 48473.0 48526.8 48962.3 51353.7 51460.5 51482.7 51500.5 51534.7 16033.3 16150.0 16227.7 16276.3 16288.8 13434.9 13446.8 13480.5 13497.7 13549.0 14376.8 14404.2 14454.3 14579.1 14813.3 5649.5 5800.9 5864.3 5919.3 5931.9 1009.9 1014.9 1019.7 1054.1 1055.6 22141.8 22382.0 22530.0 22937.2 23413.9 1074.7 1084.4 1104.4 1127.4 1127.8 11543.2 11805.3 11871.5 11957.2 12306.3 231927.0 232106.0 232246.0 232479.0 234124.0 52500.5 52559.5 52717.0 52796.0 53263.5 1443.2 1474.6 1505.2 1521.3 1523.6 21710.2 21952.5 22119.9 22385.8 22850.5 36404.3 36420.5 36496.0 36565.8 36623.5 181171.0 184461.0 184851.0 185178.0 185395.0 33611.2 35301.6 35531.0 37006.0 37116.0 46890.3 46900.3 47382.5 47829.8 48400.5 33263.0 33867.5 34007.8 34226.3 34230.8 32740.5 33207.2 33703.5 33789.8 33960.0 36296.0 37579.4 37721.6 37824.4 38104.8 31775.8 32294.4 33045.7 33144.0 33169.0 23843.9 23917.8 24211.9 24665.8 24727.8 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#2] jquery.html Cycles:180 Average:35064.81 Median:22553.88 stddev:84125.90 (373.0%) stddev-sans-first:84322.04 19:47:30 INFO - PID 3605 | Values: 577.9 578.9 582.2 588.0 607.7 21559.8 22432.6 22457.8 22483.1 22534.3 24285.3 25389.4 26711.6 26893.5 26926.2 6406.4 6582.5 6586.2 6597.1 6602.4 6487.6 6488.9 6526.9 6572.7 6575.8 4062.6 4862.8 5998.6 6507.9 6551.1 6540.5 6553.4 6563.8 6570.9 6579.6 6066.8 6082.2 6121.8 6130.1 6131.1 27753.6 29247.6 29290.3 29516.0 29522.7 1891.2 1929.6 1938.5 1955.8 1966.1 18528.7 19062.4 19211.4 19243.1 19260.6 2345.8 2349.9 2390.0 2392.7 2410.6 134250.3 138327.3 139044.0 139251.3 139856.3 13859.4 15113.4 15610.7 15750.4 16219.6 23763.0 23895.8 23911.0 23994.3 24068.2 10193.4 10343.2 10348.5 10401.1 10471.4 9529.9 9550.7 9650.2 9675.0 9723.9 9235.9 9237.4 9285.0 9292.0 9563.8 2608.0 2725.6 2820.7 2836.8 2945.1 941.8 953.7 958.1 990.0 993.5 19875.3 20118.7 20285.5 20655.8 20670.8 1008.2 1025.9 1044.2 1050.5 1061.7 10905.3 11043.8 11055.5 11224.4 11277.3 479630.0 488799.0 502424.0 511827.0 512821.0 115541.0 122652.4 123533.4 124288.0 124843.0 1189.1 1210.7 1243.1 1245.6 1251.9 17261.8 17814.8 17843.2 18545.0 18600.2 49167.0 51531.0 53130.0 54401.7 55229.4 67823.0 68196.0 68688.3 69201.0 69433.7 14581.9 14699.4 14835.0 14840.0 14863.0 22076.6 22573.4 22733.4 23104.7 23555.3 18292.9 18422.3 18465.5 18619.4 18621.2 16514.3 16788.8 17057.2 17089.7 17331.0 17800.0 18907.7 18922.0 19068.3 19108.8 14504.5 14702.1 14774.3 14776.6 14921.3 17811.6 18384.6 18444.6 18460.8 18590.9 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#3] mootools.html Cycles:180 Average:8180.15 Median:2414.16 stddev:5334.13 (221.0%) stddev-sans-first:5324.33 19:47:30 INFO - PID 3605 | Values: 1340.2 1409.4 1410.8 1421.4 1421.6 12709.1 13446.8 13449.1 13506.6 13531.9 13200.9 13556.3 13573.1 13621.5 13633.9 2555.3 2617.2 2626.8 2631.8 2635.1 2514.2 2585.3 2585.5 2588.1 2593.3 2529.0 2565.3 2578.4 2579.8 2581.4 2329.3 2344.6 2350.6 2354.6 2363.8 2412.1 2416.3 2434.1 2436.9 2437.9 12462.1 12899.2 12928.1 12949.6 12999.2 6947.8 7180.1 7208.3 7220.2 7220.2 4804.5 4889.4 5070.5 5084.8 5129.7 1845.3 1846.2 1924.3 1941.6 1954.6 19686.6 19785.1 19912.1 21446.9 22140.8 6300.6 6394.0 6613.2 6616.1 6621.0 14975.0 15051.8 15070.4 15088.1 15125.9 7173.8 7241.2 7245.7 7249.6 7293.9 6659.5 6731.3 6752.7 6803.0 6869.3 4767.6 4966.6 4973.2 4983.9 5075.1 1456.2 1460.3 1465.9 1470.2 1477.7 907.0 913.5 923.0 940.0 949.2 7205.5 7208.1 7309.1 8501.0 8702.4 994.5 997.5 1021.1 1027.4 1032.8 4995.4 5035.8 5125.4 5167.0 5296.5 15539.4 15783.3 16185.2 16368.9 16370.4 17923.4 18051.6 18094.2 18248.6 18358.1 9082.6 9915.3 10024.5 10058.5 10115.8 7101.7 7949.8 8482.2 8548.9 8614.7 14529.5 15059.1 15469.7 15773.3 15846.9 14647.8 15335.2 15518.0 15682.5 15936.0 10672.9 11088.7 11098.4 11182.0 11230.4 12201.9 12305.3 12313.0 12338.8 12353.6 10028.2 10295.3 10404.5 10434.7 10775.0 9809.3 10011.7 10238.0 10328.5 10387.0 8606.7 8721.2 8741.9 8812.9 8818.6 6325.9 6567.6 6666.2 6786.4 6829.5 7063.5 7107.5 7199.3 7219.2 7266.6 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#4] prototype.html Cycles:180 Average:5376.99 Median:5906.95 stddev:1497.37 (25.3%) stddev-sans-first:1455.88 19:47:30 INFO - PID 3605 | Values: 486.1 489.7 514.4 519.9 533.5 5891.3 6031.6 6054.4 6084.5 6103.4 5761.6 5922.6 5981.7 6031.7 6033.3 4912.0 4914.4 4929.2 4948.3 4968.4 4854.0 4884.5 4930.6 4936.5 4964.2 4872.7 4899.4 4902.7 4903.2 4904.6 4652.4 4734.3 4801.2 4839.8 4868.0 4260.7 4351.5 4364.3 4365.3 4377.6 5770.5 5796.5 5817.1 5837.8 5924.8 5445.6 5482.5 5547.9 5564.6 5564.7 6227.8 6274.4 6364.2 6376.9 6384.4 4790.2 4846.9 4853.5 4864.2 4866.3 6712.0 6722.3 6800.8 6818.0 6848.9 4967.7 4968.4 4977.3 4983.0 4986.4 5018.2 5027.8 5042.8 5047.5 5060.2 5531.5 5560.4 5564.1 5589.3 5590.8 6331.9 6347.8 6354.5 6373.0 6432.7 1714.0 1748.5 1755.2 1766.6 1773.8 1124.7 1225.4 1234.1 1234.2 1237.7 5514.6 5601.6 5603.4 5666.6 5706.4 6393.2 6547.4 6550.7 6598.5 6604.8 5664.3 5678.5 5684.7 5695.8 5714.2 3412.8 3468.4 3474.9 3494.7 3511.2 6273.3 6301.8 6316.8 6385.4 6467.9 6632.2 6662.0 6718.3 6758.5 6774.6 6289.1 6312.5 6355.2 6364.8 6451.3 6459.6 6470.9 6497.7 6531.2 6541.7 6452.9 6468.6 6505.2 6528.0 6571.7 6311.9 6340.2 6370.3 6399.7 6431.4 4745.7 4778.5 4780.1 4801.4 4829.4 6548.4 6554.5 6597.3 6618.2 6631.9 6331.6 6331.9 6402.5 6402.9 6426.3 6304.4 6322.9 6332.7 6407.5 6408.5 6278.4 6286.8 6339.8 6352.2 6372.5 5942.8 6322.6 6347.0 6369.0 6457.2 6108.8 6147.3 6177.4 6185.3 6232.5 19:47:30 INFO - PID 3605 | 19:47:30 INFO - PID 3605 | [#5] yui.html Cycles:180 Average:22272.62 Median:19692.25 stddev:28985.03 (147.2%) stddev-sans-first:29021.75 19:47:30 INFO - PID 3605 | Values: 862.7 882.9 895.1 897.3 906.2 17798.0 18050.8 18384.7 18529.0 18613.0 14480.5 14495.3 15730.7 15806.1 19985.7 1020.1 1047.8 1048.7 1052.8 1054.4 1040.7 1053.0 1058.0 1058.9 1061.8 1108.4 1109.5 1110.0 1111.4 1111.9 1001.8 1090.7 1099.1 1099.8 1103.8 795.2 797.8 798.6 798.8 805.6 18936.8 19445.0 19685.0 19699.5 19761.0 19523.5 20148.5 20463.4 20495.0 20657.9 15871.0 15969.6 15984.3 16005.5 16064.3 3284.7 3421.1 3453.9 3549.8 3550.6 104028.5 104161.0 110102.0 110341.0 114897.0 15940.0 16453.6 16462.8 16516.7 16548.0 27123.3 28902.7 29094.0 29097.9 29296.4 8817.6 8983.2 9003.0 9008.9 9039.5 4178.4 4283.6 4339.8 4347.0 4389.5 5086.9 5198.3 5198.8 5203.3 5205.8 987.3 1032.2 1037.8 1047.1 1047.1 679.1 679.2 682.1 704.3 706.4 12083.5 12131.7 12423.9 12441.9 12962.9 657.6 699.1 702.1 707.9 721.0 5179.0 5454.4 5469.7 5565.8 5583.3 96379.0 97533.5 99648.5 101628.5 103275.0 87973.6 92407.0 94244.0 94456.0 95887.5 78058.0 78700.6 80160.2 81434.2 83960.6 10732.6 10735.5 10808.8 10821.1 10977.2 33789.5 34440.7 35924.5 36201.3 36681.5 63183.0 65013.7 66337.7 66757.7 67197.3 17867.8 18168.3 18385.4 18777.2 18879.1 20189.8 20280.3 21263.5 21397.9 21556.3 18582.3 18640.7 18953.6 19538.4 19945.3 18073.5 18077.5 19643.8 19703.9 19873.9 18630.3 18992.4 19069.0 19109.4 19228.2 13121.6 13719.4 13788.2 14320.7 14343.0 13960.7 14161.2 14227.6 14396.0 14494.1 19:47:30 INFO - PID 3605 | -------- Summary: end -------- 19:47:30 INFO - PID 3605 | 19:47:30 INFO - TEST-INFO | 3605: exit 0 19:47:30 INFO - TEST-OK | dromaeo_css | took 1115554ms 19:47:30 INFO - TEST-START | kraken 19:47:30 INFO - Initialising browser for kraken test... 19:47:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49350/getInfo.html -profile /tmp/tmpHziMTX/profile 19:47:30 INFO - TEST-INFO | started process 4012 (/builds/slave/test/build/application/firefox/firefox http://localhost:49350/getInfo.html) 19:47:36 INFO - TEST-INFO | 4012: exit 0 19:47:36 INFO - Browser initialized. 19:47:36 INFO - Running cycle 1/1 for kraken test... 19:47:36 INFO - TEST-INFO | started process 4219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHziMTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:48 INFO - PID 4219 | RSS: Main: 170844160 19:47:48 INFO - PID 4219 | 19:47:50 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:51 INFO - PID 4219 | RSS: Main: 176123904 19:47:51 INFO - PID 4219 | 19:47:54 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-dft) 19:47:55 INFO - PID 4219 | RSS: Main: 176570368 19:47:55 INFO - PID 4219 | 19:47:57 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-fft) 19:47:58 INFO - PID 4219 | RSS: Main: 170070016 19:47:58 INFO - PID 4219 | 19:48:00 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49350/tests/kraken/driver.html?testName=audio-oscillator) 19:48:01 INFO - PID 4219 | RSS: Main: 170496000 19:48:01 INFO - PID 4219 | 19:48:03 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:48:03 INFO - PID 4219 | RSS: Main: 170364928 19:48:03 INFO - PID 4219 | 19:48:06 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-darkroom) 19:48:07 INFO - PID 4219 | RSS: Main: 174456832 19:48:07 INFO - PID 4219 | 19:48:10 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49350/tests/kraken/driver.html?testName=imaging-desaturate) 19:48:11 INFO - PID 4219 | RSS: Main: 175837184 19:48:11 INFO - PID 4219 | 19:48:14 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49350/tests/kraken/driver.html?testName=json-parse-financial) 19:48:15 INFO - PID 4219 | RSS: Main: 174907392 19:48:15 INFO - PID 4219 | 19:48:16 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:48:17 INFO - PID 4219 | RSS: Main: 174673920 19:48:17 INFO - PID 4219 | 19:48:18 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:48:19 INFO - PID 4219 | RSS: Main: 174469120 19:48:19 INFO - PID 4219 | 19:48:21 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:48:22 INFO - PID 4219 | RSS: Main: 174309376 19:48:22 INFO - PID 4219 | 19:48:24 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:48:25 INFO - PID 4219 | RSS: Main: 174596096 19:48:25 INFO - PID 4219 | 19:48:28 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:48:29 INFO - PID 4219 | RSS: Main: 173641728 19:48:29 INFO - PID 4219 | 19:48:30 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:49350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49350/tests/kraken/driver.html?testName=ai-astar) 19:48:31 INFO - PID 4219 | RSS: Main: 175919104 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | __start_tp_report 19:48:31 INFO - PID 4219 | _x_x_mozilla_page_load 19:48:31 INFO - PID 4219 | _x_x_mozilla_page_load_details 19:48:31 INFO - PID 4219 | |i|pagename|runs| 19:48:31 INFO - PID 4219 | |0;ai-astar;112;99;110;109;114;111;110;110;110;111 19:48:31 INFO - PID 4219 | |1;audio-beat-detection;148;123;150;174;121;164;149;127;182;119 19:48:31 INFO - PID 4219 | |2;audio-dft;161;165;163;162;161;162;161;164;171;170 19:48:31 INFO - PID 4219 | |3;audio-fft;75;75;76;157;75;76;76;75;94;75 19:48:31 INFO - PID 4219 | |4;audio-oscillator;81;81;137;83;82;81;134;82;81;131 19:48:31 INFO - PID 4219 | |5;imaging-gaussian-blur;113;114;113;113;114;114;114;113;113;114 19:48:31 INFO - PID 4219 | |6;imaging-darkroom;151;150;151;149;151;153;151;151;149;149 19:48:31 INFO - PID 4219 | |7;imaging-desaturate;94;94;94;94;94;94;95;95;96;94 19:48:31 INFO - PID 4219 | |8;json-parse-financial;57;55;56;54;55;55;56;55;55;55 19:48:31 INFO - PID 4219 | |9;json-stringify-tinderbox;53;54;53;55;55;55;55;53;53;54 19:48:31 INFO - PID 4219 | |10;stanford-crypto-aes;82;77;78;79;78;78;87;76;91;76 19:48:31 INFO - PID 4219 | |11;stanford-crypto-ccm;129;127;125;131;123;123;125;128;123;158 19:48:31 INFO - PID 4219 | |12;stanford-crypto-pbkdf2;188;178;185;182;181;196;195;180;180;178 19:48:31 INFO - PID 4219 | |13;stanford-crypto-sha256-iterative;71;76;70;69;69;68;69;70;71;69 19:48:31 INFO - PID 4219 | __end_tp_report 19:48:31 INFO - PID 4219 | __start_cc_report 19:48:31 INFO - PID 4219 | _x_x_mozilla_cycle_collect,943 19:48:31 INFO - PID 4219 | __end_cc_report 19:48:31 INFO - PID 4219 | __startTimestamp1499741311207__endTimestamp 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | ------- Summary: start ------- 19:48:31 INFO - PID 4219 | Number of tests: 14 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.98 (3.6%) stddev-sans-first:4.12 19:48:31 INFO - PID 4219 | Values: 112.0 99.0 110.0 109.0 114.0 111.0 110.0 110.0 110.0 111.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:149.50 stddev:22.79 (15.2%) stddev-sans-first:24.16 19:48:31 INFO - PID 4219 | Values: 148.0 123.0 150.0 174.0 121.0 164.0 149.0 127.0 182.0 119.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.68 (2.3%) stddev-sans-first:3.74 19:48:31 INFO - PID 4219 | Values: 161.0 165.0 163.0 162.0 161.0 162.0 161.0 164.0 171.0 170.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.50 stddev:25.83 (34.2%) stddev-sans-first:27.13 19:48:31 INFO - PID 4219 | Values: 75.0 75.0 76.0 157.0 75.0 76.0 76.0 75.0 94.0 75.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:81.00 stddev:25.37 (31.3%) stddev-sans-first:26.22 19:48:31 INFO - PID 4219 | Values: 81.0 81.0 137.0 83.0 82.0 81.0 134.0 82.0 81.0 131.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:48:31 INFO - PID 4219 | Values: 113.0 114.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 114.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 19:48:31 INFO - PID 4219 | Values: 151.0 150.0 151.0 149.0 151.0 153.0 151.0 151.0 149.0 149.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 19:48:31 INFO - PID 4219 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 96.0 94.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.60 19:48:31 INFO - PID 4219 | Values: 57.0 55.0 56.0 54.0 55.0 55.0 56.0 55.0 55.0 55.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.50 stddev:0.94 (1.7%) stddev-sans-first:0.93 19:48:31 INFO - PID 4219 | Values: 53.0 54.0 53.0 55.0 55.0 55.0 55.0 53.0 53.0 54.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:78.50 stddev:5.03 (6.4%) stddev-sans-first:5.29 19:48:31 INFO - PID 4219 | Values: 82.0 77.0 78.0 79.0 78.0 78.0 87.0 76.0 91.0 76.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:127.50 stddev:10.49 (8.2%) stddev-sans-first:11.12 19:48:31 INFO - PID 4219 | Values: 129.0 127.0 125.0 131.0 123.0 123.0 125.0 128.0 123.0 158.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:183.50 stddev:6.65 (3.6%) stddev-sans-first:6.92 19:48:31 INFO - PID 4219 | Values: 188.0 178.0 185.0 182.0 181.0 196.0 195.0 180.0 180.0 178.0 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.25 (3.2%) stddev-sans-first:2.37 19:48:31 INFO - PID 4219 | Values: 71.0 76.0 70.0 69.0 69.0 68.0 69.0 70.0 71.0 69.0 19:48:31 INFO - PID 4219 | -------- Summary: end -------- 19:48:31 INFO - PID 4219 | 19:48:31 INFO - PID 4219 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:48:31 INFO - TEST-INFO | 4219: exit 0 19:48:31 INFO - TEST-OK | kraken | took 61028ms 19:48:31 INFO - SUITE-END | took 1176s 19:48:32 INFO - Completed test suite (00:19:36) 19:48:32 INFO - javascript benchmark 19:48:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8325.762543051205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.3141908780062, 3178.6185657721076, 3197.7601679874015, 3201.0716892101286, 3227.4997375406806, 5931.584789064767, 6007.189029481019, 6054.0, 6063.120847477118, 6068.939310606893, 6027.728752206151, 6066.4236897494775, 6084.665343406122, 6127.295361033483, 6130.969345153279, 5523.944760552404, 5574.526165275956, 5576.86057848553, 5615.298087739033, 5632.464915832989, 5572.916406253909, 5593.944060559383, 5601.103823388259, 5620.803271885485, 5621.831345059655, 5601.271834661508, 5612.186232996213, 5623.212750214973, 5624.634398764088, 5629.521490673298, 5585.972070139664, 5594.1888426177975, 5606.691631960241, 5613.607047506676, 5622.240997465351, 5451.155070964007, 5591.161325801122, 5600.859978500529, 5615.634983726086, 5665.0, 6106.4809491192855, 6143.539234557426, 6156.353582873823, 6172.0, 6207.596506227081, 6381.840453988641, 6486.416222539947, 6501.414872661483, 6603.834904127387, 6604.0, 6540.247871494744, 6550.312217217172, 6594.274629790719, 6613.371729685672, 6623.768168114093, 6079.665618390986, 6083.574149809515, 6139.938600613981, 6143.754249830002, 6156.138140660311, 6698.0, 6725.19297684281, 6727.764528241488, 6750.0, 6801.081853949752, 6350.7777227796805, 6399.55203135776, 6432.646204458706, 6489.870202595922, 6501.544891857525, 6472.46612115201, 6476.125723027331, 6576.1122248496795, 6599.835004124935, 6602.207735071726, 6401.167848179707, 6439.066335381343, 6463.547551671338, 6472.644004579699, 6473.417392434703, 6426.196725409324, 6522.902156467657, 6526.608403495806, 6538.640374779433, 6601.900971485432, 5245.10833158364, 5312.043832110257, 5314.415414304423, 5378.220158077057, 5416.241726158341, 4552.544745525421, 4560.703554268962, 4576.222042252825, 4591.219492686251, 4593.402857628487, 5733.254676892061, 5734.197212390269, 5746.482816546531, 5760.596758226884, 5765.884682306414, 6533.934660653427, 6590.1103351046995, 6597.934020659828, 6605.141331626954, 6608.537402381787, 5691.886162276731, 5714.371419143891, 5773.971130144322, 5780.306363236438, 5796.478316951495, 5707.0, 5793.073108302651, 5794.275715535558, 5818.214541036906, 5890.617109887844, 6321.96839015802, 6369.8726025480155, 6389.041643753474, 6398.648074355862, 6403.423691867754, 6514.57655252407, 6552.6723663817575, 6554.082428459924, 6608.273089960005, 6613.66931653425, 6314.179156709783, 6364.586301890362, 6370.362963703593, 6402.167718196604, 6444.613323200623, 6445.0, 6446.5165112615805, 6497.642629655415, 6543.312952140147, 6552.180977377828, 6553.2136143663065, 6587.868242635216, 6648.434883034996, 6651.235107962646, 6679.398854103154, 6261.060840873905, 6322.241331040304, 6329.113924050729, 6350.301466838551, 6362.268339141058, 6292.496600271876, 6334.461570766536, 6373.267074286517, 6393.904091438539, 6404.039394090737, 4959.876003099951, 6265.373462653881, 6300.0, 6301.023341382093, 6346.0, 6421.486281097595, 6428.742850285937, 6453.257875344208, 6505.186851643544, 6517.4134327910715, 6203.8138855834395, 6211.751529938751, 6285.057241413824, 6300.2754683212015, 6306.337834527492], "value": 5981.8768411755755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.6856588798594, 859.4800145911722, 892.5671049540972, 898.0704970355681, 1172.9120315976304, 29087.85456072719, 30821.845890770543, 30830.075097747074, 41682.37476437848, 42003.57996420035, 41578.37632435516, 41908.0, 42176.578234217646, 42182.99999999992, 42241.0, 7487.25127487251, 7523.247675232487, 7587.848243035163, 7618.314351708345, 7683.423743219253, 7442.995195648599, 7626.389888808882, 7689.154193038761, 7699.6920123195005, 7711.5758633275145, 7575.924240757605, 7709.421793365492, 7758.030246219223, 7834.05991281047, 7837.216278372174, 7741.303282704555, 7797.376209903194, 7798.337141342992, 7801.180876007994, 7824.334931530827, 7617.314441700273, 7686.807829804299, 7692.615369231516, 7705.422093342966, 7734.381249500027, 38495.807520962495, 38569.228615427535, 38617.61382386196, 38690.226195476214, 38834.0, 3568.5360903082433, 3579.0, 3588.102974256436, 3604.7656902301264, 3608.9819550902075, 30375.544366834514, 30460.54309185364, 30488.847555762302, 30519.847400762854, 30654.233644158852, 4528.27547592387, 4689.062187562467, 4774.069056533977, 4882.292067650206, 4885.755712214375, 179703.0, 181071.0, 181880.0, 182530.0, 182647.99999999866, 42286.0, 48065.27902081471, 48473.0, 48526.75736621294, 48962.26556601654, 51353.74323128435, 51460.485395146316, 51482.742586286826, 51500.48499515032, 51534.74232628813, 16033.278502467418, 16150.0, 16227.675446491005, 16276.348946042262, 16288.837111628733, 13434.93282533581, 13446.798298025538, 13480.5281815136, 13497.730045399234, 13549.0, 14376.784348234785, 14404.207768572829, 14454.27728613586, 14579.125252484884, 14813.259337033105, 5649.519790817826, 5800.9129863052085, 5864.266966629171, 5919.3192782829665, 5931.881362372815, 1009.9394036357695, 1014.8629934958686, 1019.7297716105238, 1054.0987455725399, 1055.614700634263, 22141.778582214294, 22382.0, 22530.0, 22937.19719809832, 23413.882930585238, 1074.7055037495004, 1084.4306738962107, 1104.3594715065242, 1127.3563493607478, 1127.7800828838297, 11543.19197656156, 11805.330106543212, 11871.525138994344, 11957.162998590189, 12306.261624302571, 231927.0, 232106.0, 232246.0, 232479.0, 234124.0, 52500.474995249555, 52559.47440525546, 52717.0, 52796.0, 53263.46736532585, 1443.227873087893, 1474.5502621700484, 1505.1947208243537, 1521.3154080663746, 1523.6419441431256, 21710.240141594968, 21952.491913887017, 22119.889400552893, 22385.77614223837, 22850.542989140456, 36404.27191456209, 36420.4536931941, 36496.0, 36565.81717091398, 36623.45064823976, 181171.0, 184461.0, 184851.0, 185178.0, 185395.0, 33611.15972100717, 35301.646983529834, 35531.0, 37006.0, 37116.0, 46890.296645551025, 46900.29649555191, 47382.52617473919, 47829.76085119552, 48400.5159948396, 33263.04217469499, 33867.49198761971, 34007.82996085004, 34226.31547368989, 34230.82884585561, 32740.508892366157, 33207.169820753705, 33703.4944475838, 33789.83105084459, 33960.0, 36296.0, 37579.436308454846, 37721.62278377181, 37824.43263350997, 38104.80947595244, 31775.841120794248, 32294.35411291808, 33045.66954330522, 33144.0, 33169.0, 23843.880780595988, 23917.756486467057, 24211.87894060589, 24665.753342467062, 24727.752722472545], "value": 17176.13475472376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8959787238296, 578.9131630255462, 582.1820342418903, 587.9941200587995, 607.7356349987756, 21559.784402155972, 22432.55134897301, 22457.775422245813, 22483.10067597296, 22534.323970280897, 24285.271441856727, 25389.365265868317, 26711.599326010124, 26893.462130757373, 26926.192214233557, 6406.359364063603, 6582.506312026593, 6586.176727909012, 6597.142371491699, 6602.372774586406, 6487.643179625119, 6488.870222595545, 6526.934730652681, 6572.7042283097135, 6575.802725918206, 4062.5531191568903, 4862.756862156895, 5998.620317327018, 6507.9023814642815, 6551.115599394092, 6540.542162048659, 6553.377429144223, 6563.835904102388, 6570.901436478457, 6579.572327798702, 6066.817995460143, 6082.239720034996, 6121.755129794803, 6130.141780150782, 6131.141640170335, 27753.583696244572, 29247.56128658072, 29290.267743306376, 29516.0, 29522.70477295221, 1891.2435025989578, 1929.6237233739425, 1938.4863011302016, 1955.7848636649958, 1966.1250743419184, 18528.722069168973, 19062.428127156207, 19211.423657290303, 19243.134058967382, 19260.614787704166, 2345.7888790008983, 2349.89425475854, 2390.0439824070336, 2392.7248366437907, 2410.5781488239486, 134250.3287483566, 138327.30836345855, 139044.0, 139251.30374348164, 139856.30071849577, 13859.445622175203, 15113.372790530193, 15610.687786244438, 15750.369985200692, 16219.594510137342, 23763.0, 23895.761042389353, 23911.0, 23994.28017159488, 24068.15761448341, 10193.388396696073, 10343.173025980435, 10348.5343159558, 10401.063904248502, 10471.42407167613, 9529.857052144223, 9550.665726699672, 9650.227981761442, 9674.951625241829, 9723.902760972442, 9235.907640923639, 9237.445753254691, 9285.0, 9292.024337444605, 9563.760905977268, 2608.0097450900153, 2725.591161325777, 2820.689724130344, 2836.8085404130316, 2945.1164650604733, 941.8069295794346, 953.7281874665687, 958.1185309515263, 989.9703008909744, 993.5479356892597, 19875.304364347467, 20118.69821952672, 20285.49286267855, 20655.793442065387, 20670.79329206719, 1008.1783346572666, 1025.9025392587691, 1044.2429238801808, 1050.5115121468555, 1061.7398737309409, 10905.34567925927, 11043.83434248487, 11055.502502387411, 11224.438778061065, 11277.32336059839, 479630.0, 488799.0, 502424.0, 511827.0, 512821.0, 115541.0, 122652.38673806573, 123533.38233308776, 124288.0, 124843.0, 1189.1081202158039, 1210.7033776724759, 1243.0987534037931, 1245.5951815659946, 1251.9186252893533, 17261.827381726023, 17814.821851781315, 17843.197056132765, 18545.0, 18600.16299266563, 49167.0, 51531.0, 53130.0, 54401.72799135979, 55229.44770552243, 67823.0, 68196.0, 68688.31311686819, 69201.0, 69433.65283173551, 14581.85418145805, 14699.41202351894, 14835.03572267799, 14840.0, 14863.033902796284, 22076.558468830855, 22573.43566410787, 22733.43166420853, 23104.653430198898, 23555.29334119979, 18292.908535457238, 18422.263109475472, 18465.53836154107, 18619.44141675752, 18621.162047708156, 16514.339426422808, 16788.832111678727, 17057.232424540678, 17089.743653844955, 17331.0, 17800.0, 18907.71638425397, 18922.0, 19068.33260835864, 19108.808911910703, 14504.492342767953, 14702.117872927658, 14774.261286935825, 14776.556703298918, 14921.3285402155, 17811.643767124846, 18384.63230735351, 18444.631107378045, 18460.81539184591, 18590.907045464686], "value": 11971.167417813278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.162398500937, 1409.3587417724937, 1410.8377536583296, 1421.438531779947, 1421.5806337130539, 12709.110362274645, 13446.798298025526, 13449.125806822549, 13506.59480215595, 13531.93234033831, 13200.867991320083, 13556.254406007665, 13573.11774734644, 13621.523246686367, 13633.863661363383, 2555.2972932443636, 2617.2410001099656, 2626.829256098357, 2631.789456843448, 2635.1172357260243, 2514.245726282108, 2585.28904551249, 2585.4699786543715, 2588.0812311629384, 2593.273883312666, 2529.0, 2565.256075738043, 2578.419855532509, 2579.7807186389086, 2581.3675649465813, 2329.336139200328, 2344.5896968030524, 2350.612148995414, 2354.587947109249, 2363.8463499872455, 2412.0713525292713, 2416.2509622017233, 2434.099383228217, 2436.902523899042, 2437.9390515237083, 12462.12765106443, 12899.22604643715, 12928.09503334767, 12949.611511654666, 12999.155054921495, 6947.826304342381, 7180.1383833939735, 7208.315210055089, 7220.169680486706, 7220.205777364486, 4804.483785241897, 4889.413270407538, 5070.492950704936, 5084.79660813567, 5129.743512824344, 1845.2803406671276, 1846.22458567402, 1924.3264857299973, 1941.631090092892, 1954.5797653504424, 19686.606267874704, 19785.10967006488, 19912.103955322043, 21446.892765536228, 22140.778592214192, 6300.621962682254, 6394.0, 6613.239477460057, 6616.139901812733, 6621.0, 14975.0, 15051.849481505264, 15070.397184112731, 15088.094714317176, 15125.924370378298, 7173.784786456415, 7241.167265764399, 7245.673944672502, 7249.601271930094, 7293.927060729431, 6659.500537459709, 6731.293214212437, 6752.696128674222, 6802.965985170142, 6869.347411995853, 4767.570918617272, 4966.577840883493, 4973.204287314013, 4983.875403114951, 5075.086484432763, 1456.1845366594741, 1460.291758497128, 1465.9340329684976, 1470.1767010474168, 1477.6527516033723, 906.9682561110461, 913.4747520175926, 922.9630814767469, 940.041158018817, 949.240607513986, 7205.531640443354, 7208.135023797073, 7309.122905251297, 8501.0, 8702.390832641655, 994.5126887824914, 997.5211898288862, 1021.1269364693229, 1027.440045175381, 1032.8140934631688, 4995.400551933792, 5035.79856805731, 5125.384953805493, 5167.018266529348, 5296.470352964673, 15539.378424863105, 15783.289751961189, 16185.19074046293, 16368.918155409146, 16370.427035053715, 17923.37268195607, 18051.63896722058, 18094.185761640758, 18248.63502729938, 18358.082095895417, 9082.591283392263, 9915.256355773347, 10024.54889529973, 10058.547365368577, 10115.797684046425, 7101.680424380812, 7949.761507154794, 8482.236598706146, 8548.871766923377, 8614.655413783628, 14529.491467798576, 15059.096454212782, 15469.690606187589, 15773.29020194071, 15846.92076539656, 14647.780283295546, 15335.156566388956, 15518.0, 15682.451114210948, 15936.0, 10672.946635266773, 11088.722781930517, 11098.389588572383, 11182.049525790399, 11230.382328971986, 12201.877981220074, 12305.323207223688, 12313.0, 12338.81491777606, 12353.567625133437, 10028.247881408777, 10295.330803497749, 10404.531796069045, 10434.739131521772, 10775.0, 9809.313348065567, 10011.749706257111, 10238.0, 10328.483575821328, 10387.0, 8606.65573377083, 8721.171488708562, 8741.868871966799, 8812.867806982773, 8818.603162857558, 6325.905111423241, 6567.605943643397, 6666.2333831609985, 6786.357446086818, 6829.453643708392, 7063.540869843444, 7107.502474826712, 7199.280071992759, 7219.241979592067, 7266.564006159648], "value": 6105.126449728421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.1371066357215, 489.74777989335485, 514.4444000479483, 519.9298094757212, 533.4798571392893, 5891.322497912742, 6031.6381017139, 6054.424829641188, 6084.543659225554, 6103.443621876421, 5761.596688231825, 5922.58541902067, 5981.700914954256, 6031.72857221425, 6033.27600687918, 4911.975440122795, 4914.361133052698, 4929.186684197103, 4948.307236986825, 4968.35411396518, 4853.951460485385, 4884.487128851472, 4930.580900623451, 4936.531029552187, 4964.205727083668, 4872.707637541741, 4899.412070551539, 4902.65681402302, 4903.215485522317, 4904.558589726924, 4652.418447694055, 4734.313524538957, 4801.207800712878, 4839.830605928775, 4867.951320486803, 4260.680448966309, 4351.49957754859, 4364.258076127066, 4365.301551751704, 4377.627901628365, 5770.509506691937, 5796.478316951452, 5817.127430885359, 5837.824865254049, 5924.792632257893, 5445.564354851603, 5482.479164479368, 5547.944520554824, 5564.582656300794, 5564.749586268587, 6227.750889964396, 6274.403931626533, 6364.236291644986, 6376.87533108778, 6384.3934826191435, 4790.185668436374, 4846.878828029292, 4853.490383509751, 4864.246041863516, 4866.31871537985, 6711.9664401678165, 6722.294159113271, 6800.761973330959, 6817.965910170417, 6848.897266541006, 4967.652264341461, 4968.428630707443, 4977.328060711758, 4983.0, 4986.426560945465, 5018.172001619765, 5027.79888804451, 5042.773075211624, 5047.520485553867, 5060.240963855451, 5531.474509921551, 5560.388357280696, 5564.109742441271, 5589.329280486368, 5590.8043218487155, 6331.873362532723, 6347.809565713036, 6354.489976459273, 6372.968135159387, 6432.71052802625, 1713.9657206855793, 1748.4929370482419, 1755.218927577216, 1766.6025144342677, 1773.7871455425432, 1124.746931940307, 1225.4118023348842, 1234.1484375780683, 1234.1977714485477, 1237.6534570320325, 5514.558835293167, 5601.63589366698, 5603.355614104348, 5666.631668941505, 5706.42935706426, 6393.16410153904, 6547.377999090078, 6550.672466376757, 6598.47212223021, 6604.8348791280605, 5664.291963504562, 5678.488935995781, 5684.744186511617, 5695.829125126253, 5714.228579141763, 3412.8293585320635, 3468.3756923753967, 3474.8783792567137, 3494.668006539375, 3511.2099777549847, 6273.274849416447, 6301.8109456716375, 6316.778912738032, 6385.361463853577, 6467.902981455282, 6632.209303488127, 6662.0, 6718.260991290954, 6758.459323254128, 6774.559653622498, 6289.063085477878, 6312.495000399957, 6355.237371515448, 6364.772329684573, 6451.3226111257645, 6459.64347487033, 6470.935290647221, 6497.707603157774, 6531.183602049744, 6541.724363749214, 6452.935470645421, 6468.611883287018, 6505.154329937078, 6527.967360163168, 6571.737130514917, 6311.873762524816, 6340.161353207703, 6370.3370561928, 6399.712012959521, 6431.356864313531, 4745.691530050535, 4778.450478194913, 4780.067886762048, 4801.351817504592, 4829.4204695435365, 6548.377904099103, 6554.4756419487285, 6597.27429982692, 6618.2203474541775, 6631.900521492085, 6331.620102793847, 6331.9366806331345, 6402.455791257609, 6402.903956440564, 6426.260979987362, 6304.432601065926, 6322.905156422566, 6332.746690132343, 6407.487401008001, 6408.487321014214, 6278.372162783685, 6286.811395658137, 6339.778107766206, 6352.237731472068, 6372.490200784019, 5942.7920022799, 6322.620642761265, 6347.0, 6369.0, 6457.160569125984, 6108.755649774137, 6147.323794382703, 6177.444030037318, 6185.257769067741, 6232.501399887908], "value": 4940.262406665836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.7454900804262, 882.9470231786092, 895.0959530873815, 897.2866571075994, 906.2432868554756, 17798.0, 18050.81949180506, 18384.72422913656, 18529.0, 18613.0, 14480.479549647293, 14495.275236238198, 15730.685386292267, 15806.13066281354, 19985.70021449676, 1020.1328870460105, 1047.8480620310052, 1048.7430579508032, 1052.847337136115, 1054.3673795722543, 1040.6981975227175, 1053.010170439788, 1057.9947100264487, 1058.8941105889426, 1061.8194906865813, 1108.4291589831244, 1109.522905150785, 1110.0, 1111.3998440841976, 1111.9054880335182, 1001.774600714837, 1090.738222826516, 1099.087757161554, 1099.8350247462865, 1103.779244151169, 795.2047952047952, 797.8045378882211, 798.6086817459461, 798.7683571764181, 805.6173317674117, 18936.81063189378, 19445.027748612512, 19685.0, 19699.507512312164, 19761.0, 19523.511912202168, 20148.496287592927, 20463.38609841707, 20495.0, 20657.896710516503, 15871.0, 15969.600759980976, 15984.280707368196, 16005.519834404986, 16064.277107530072, 3284.655111213336, 3421.059208717598, 3453.8791142309897, 3549.8402571884326, 3550.5916819565823, 104028.47985760022, 104160.95839041588, 110102.0, 110341.0, 114897.0, 15940.0, 16453.58866028335, 16462.83537164613, 16516.669666606602, 16548.0, 27123.321916952234, 28902.71097289042, 29094.0, 29097.85451072731, 29296.414071718445, 8817.647294108292, 8983.236424903957, 9002.954985225162, 9008.864867027, 9039.502827344559, 4178.373244013362, 4283.593058659485, 4339.826406943687, 4346.978265108654, 4389.495208051051, 5086.898262034739, 5198.2722418861385, 5198.81804136861, 5203.271541984125, 5205.791768329224, 987.2595553334999, 1032.2309879139939, 1037.8443233515034, 1047.1099565369375, 1047.1151876664208, 679.0934102972489, 679.2324673119343, 682.1064405628642, 704.2921863527123, 706.4136766483806, 12083.45624446902, 12131.689867174104, 12423.875761242272, 12441.875581244252, 12962.870371296354, 657.6350125680293, 699.0667458942369, 702.0802748399612, 707.9398251148607, 721.0302143616827, 5179.0, 5454.400015998237, 5469.671819690831, 5565.805196818173, 5583.274174357389, 96379.0, 97533.51233243788, 99648.5017574922, 101628.49185754024, 103275.0, 87973.56013219892, 92407.0, 94244.0, 94456.0, 95887.52056239675, 78058.0, 78700.60649696714, 80160.2334264736, 81434.18565814385, 83960.58019709984, 10732.624358147428, 10735.463226838783, 10808.837867432152, 10821.134309255398, 10977.176711746491, 33789.49315760216, 34440.65559344374, 35924.46113308355, 36201.27597447984, 36681.532738690155, 63183.0, 65013.67493162504, 66337.66831165813, 66757.66621166863, 67197.3280267191, 17867.821321786614, 18168.273269069618, 18385.356512521998, 18777.248910043447, 18879.05604719786, 20189.79810201938, 20280.290189843283, 21263.468413289793, 21397.89301053547, 21556.27549796044, 18582.349617763313, 18640.720389193903, 18953.620927581647, 19538.413847584594, 19945.301914432926, 18073.548161296072, 18077.457676269732, 19643.803561964196, 19703.901480492506, 19873.900630496755, 18630.347937822655, 18992.43022709321, 19069.046547672282, 19109.426717198505, 19228.23087076501, 13121.606351809462, 13719.382627781973, 13788.241646709528, 14320.713585728436, 14343.0, 13960.720785584028, 14161.150330980174, 14227.64430889236, 14396.0, 14494.130352178903], "value": 8977.831077435036, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 99.0, 110.0, 109.0, 114.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 150.0, 174.0, 121.0, 164.0, 149.0, 127.0, 182.0, 119.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 162.0, 161.0, 162.0, 161.0, 164.0, 171.0, 170.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 157.0, 75.0, 76.0, 76.0, 75.0, 94.0, 75.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 137.0, 83.0, 82.0, 81.0, 134.0, 82.0, 81.0, 131.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 149.0, 151.0, 153.0, 151.0, 151.0, 149.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 55.0, 55.0, 55.0, 55.0, 53.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 78.0, 79.0, 78.0, 78.0, 87.0, 76.0, 91.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 125.0, 131.0, 123.0, 123.0, 125.0, 128.0, 123.0, 158.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 178.0, 185.0, 182.0, 181.0, 196.0, 195.0, 180.0, 180.0, 178.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 70.0, 69.0, 69.0, 68.0, 69.0, 70.0, 71.0, 69.0], "value": 70.2, "unit": "score"}]}]} 19:48:32 INFO - Return code: 0 19:48:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:48:32 INFO - # TBPL SUCCESS # 19:48:32 INFO - Running post-action listener: _package_coverage_data 19:48:32 INFO - Running post-action listener: _resource_record_post_action 19:48:32 INFO - [mozharness: 2017-07-11 02:48:32.505718Z] Finished run-tests step (success) 19:48:32 INFO - Running post-run listener: _resource_record_post_run 19:48:32 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5623808; Write bytes: 446410752; Read time: 1756; Write time: 379036 19:48:32 INFO - TinderboxPrint: CPU usage
13.1% 19:48:32 INFO - TinderboxPrint: I/O read bytes / time
5,623,808 / 1,756 19:48:32 INFO - TinderboxPrint: I/O write bytes / time
446,410,752 / 379,036 19:48:32 INFO - TinderboxPrint: CPU idle
8,280.8 (86.9%) 19:48:32 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 19:48:32 INFO - TinderboxPrint: Swap in / out
0 / 0 19:48:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114896896; Read time: 216; Write time: 97836 19:48:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:48:32 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3383296; Write bytes: 331513856; Read time: 1372; Write time: 281200 19:48:33 INFO - Running post-run listener: _upload_blobber_files 19:48:33 INFO - Blob upload gear active. 19:48:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:33 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 19:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:48:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:48:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:34 INFO - (blobuploader) - INFO - Done attempting. 19:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:48:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:35 INFO - (blobuploader) - INFO - Done attempting. 19:48:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:48:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:48:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:36 INFO - (blobuploader) - INFO - Done attempting. 19:48:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:48:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:39 INFO - (blobuploader) - INFO - Done attempting. 19:48:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:39 INFO - Return code: 0 19:48:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1654768377841bfce4b16996fdf8f008f055b40f5960cd3dd0162198d28aff50d6b6f7e9f5e9519984645772456603145add6d50d80e1320036b61a6debd5099", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f89a75463c289412ab3e2cd903fcb82c0bcec9b0c6a08c7f5846fca688cb1f96385179fb22aa50c4bfe3c24aaec3d475c727f2ef2df66064428c747fd86042fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/865587e8568519cae0c7653e76b635f8c0cd48e1028a084fd1159736c4a1312be96ba05dda7a88973a5f0bde2714ef1cf49d3573ff77e1a68f539bcd2fc69f9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0276f0d69117a878f33e03ff3a526011a7f207f66577da4dc6727ce26f72d505025323e86c57eae1bf4888fc4e3830f04906848b927fec63ee3441436b26524"} 19:48:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:39 INFO - Contents: 19:48:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1654768377841bfce4b16996fdf8f008f055b40f5960cd3dd0162198d28aff50d6b6f7e9f5e9519984645772456603145add6d50d80e1320036b61a6debd5099", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f89a75463c289412ab3e2cd903fcb82c0bcec9b0c6a08c7f5846fca688cb1f96385179fb22aa50c4bfe3c24aaec3d475c727f2ef2df66064428c747fd86042fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/865587e8568519cae0c7653e76b635f8c0cd48e1028a084fd1159736c4a1312be96ba05dda7a88973a5f0bde2714ef1cf49d3573ff77e1a68f539bcd2fc69f9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0276f0d69117a878f33e03ff3a526011a7f207f66577da4dc6727ce26f72d505025323e86c57eae1bf4888fc4e3830f04906848b927fec63ee3441436b26524"} 19:48:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:39 INFO - Copying logs to upload dir... 19:48:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.869977 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-10 19:48:39.770657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:48:39.778257) ========= 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=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 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-Non-PGO/sha512/1654768377841bfce4b16996fdf8f008f055b40f5960cd3dd0162198d28aff50d6b6f7e9f5e9519984645772456603145add6d50d80e1320036b61a6debd5099", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f89a75463c289412ab3e2cd903fcb82c0bcec9b0c6a08c7f5846fca688cb1f96385179fb22aa50c4bfe3c24aaec3d475c727f2ef2df66064428c747fd86042fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/865587e8568519cae0c7653e76b635f8c0cd48e1028a084fd1159736c4a1312be96ba05dda7a88973a5f0bde2714ef1cf49d3573ff77e1a68f539bcd2fc69f9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0276f0d69117a878f33e03ff3a526011a7f207f66577da4dc6727ce26f72d505025323e86c57eae1bf4888fc4e3830f04906848b927fec63ee3441436b26524"} build_url:https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/T0hz2tMlQleYKN2v0DASoQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1654768377841bfce4b16996fdf8f008f055b40f5960cd3dd0162198d28aff50d6b6f7e9f5e9519984645772456603145add6d50d80e1320036b61a6debd5099", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f89a75463c289412ab3e2cd903fcb82c0bcec9b0c6a08c7f5846fca688cb1f96385179fb22aa50c4bfe3c24aaec3d475c727f2ef2df66064428c747fd86042fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/865587e8568519cae0c7653e76b635f8c0cd48e1028a084fd1159736c4a1312be96ba05dda7a88973a5f0bde2714ef1cf49d3573ff77e1a68f539bcd2fc69f9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0276f0d69117a878f33e03ff3a526011a7f207f66577da4dc6727ce26f72d505025323e86c57eae1bf4888fc4e3830f04906848b927fec63ee3441436b26524"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:48:39.805176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:48:39.805509) ========= 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=652eb03db935cfc1c15ebda0000001ad-1499737271.288442-1625907034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:48:39.887673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:48:39.889697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:48:39.890003) ========= ========= Total master_lag: 0.17 =========