builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1499740188.55 results: success (0) revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.547607) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.548055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.548352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.563636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.563938) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-10 19:29:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2017-07-10 19:29:49 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.716882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.717197) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.766660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:48.766989) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-10 19:29:49,485 truncating revision to first 12 chars 2017-07-10 19:29:49,485 Setting DEBUG logging. 2017-07-10 19:29:49,485 attempt 1/10 2017-07-10 19:29:49,485 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:29:49,927 unpacking tar archive at: mozilla-central-0e41d07a703f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.538590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.538933) ========= script_repo_revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.539312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.539589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.550201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-10 19:29:49.550527) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:29:50 INFO - MultiFileLogger online at 20170710 19:29:50 in /builds/slave/test 19:29:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:29:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:29:50 INFO - {'append_to_log': False, 19:29:50 INFO - 'base_work_dir': '/builds/slave/test', 19:29:50 INFO - 'blob_upload_branch': 'Firefox', 19:29:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:29:50 INFO - 'branch': 'Firefox', 19:29:50 INFO - 'buildbot_json_path': 'buildprops.json', 19:29:50 INFO - 'code_coverage': False, 19:29:50 INFO - 'config_files': ('talos/linux_config.py',), 19:29:50 INFO - 'default_actions': ('clobber', 19:29:50 INFO - 'read-buildbot-config', 19:29:50 INFO - 'download-and-extract', 19:29:50 INFO - 'populate-webroot', 19:29:50 INFO - 'create-virtualenv', 19:29:50 INFO - 'install', 19:29:50 INFO - 'setup-mitmproxy', 19:29:50 INFO - 'run-tests'), 19:29:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:29:50 INFO - 'disable_ccov_upload': False, 19:29:50 INFO - 'download_minidump_stackwalk': True, 19:29:50 INFO - 'download_symbols': 'ondemand', 19:29:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:29:50 INFO - 'tooltool.py': '/tools/tooltool.py', 19:29:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:29:50 INFO - '/tools/misc-python/virtualenv.py')}, 19:29:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:29:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:29:50 INFO - 'gecko_profile': False, 19:29:50 INFO - 'gecko_profile_interval': 0, 19:29:50 INFO - 'installer_path': 'installer.exe', 19:29:50 INFO - 'log_level': 'info', 19:29:50 INFO - 'log_name': 'talos', 19:29:50 INFO - 'log_to_console': True, 19:29:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:29:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:29:50 INFO - 'opt_config_files': (), 19:29:50 INFO - 'pip_index': False, 19:29:50 INFO - 'suite': 'dromaeojs-e10s', 19:29:50 INFO - 'system_bits': '32', 19:29:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:29:50 INFO - 'title': 'talos-linux64-ix-089', 19:29:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:29:50 INFO - 'use_talos_json': True, 19:29:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:29:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:29:50 INFO - 'work_dir': 'build'} 19:29:50 INFO - [mozharness: 2017-07-11 02:29:50.375505Z] Running clobber step. 19:29:50 INFO - Running pre-action listener: _resource_record_pre_action 19:29:50 INFO - Running main action method: clobber 19:29:50 INFO - rmtree: /builds/slave/test/build 19:29:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:29:51 INFO - Running post-action listener: _resource_record_post_action 19:29:51 INFO - [mozharness: 2017-07-11 02:29:51.413586Z] Finished clobber step (success) 19:29:51 INFO - [mozharness: 2017-07-11 02:29:51.413689Z] Running read-buildbot-config step. 19:29:51 INFO - Running pre-action listener: _resource_record_pre_action 19:29:51 INFO - Running main action method: read_buildbot_config 19:29:51 INFO - Using buildbot properties: 19:29:51 INFO - { 19:29:51 INFO - "project": "", 19:29:51 INFO - "product": "firefox", 19:29:51 INFO - "who": "kwierso@gmail.com", 19:29:51 INFO - "installer_path": "public/build/target.tar.bz2", 19:29:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:29:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:29:51 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:29:51 INFO - "stage_platform": "linux64-stylosequential", 19:29:51 INFO - "basedir": "/builds/slave/test", 19:29:51 INFO - "buildnumber": 112, 19:29:51 INFO - "platform": "ubuntu64_hw_styloseq", 19:29:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:29:51 INFO - "slavebuilddir": "test", 19:29:51 INFO - "taskId": "Yh0aJmxiTgObubKyqWEl_A", 19:29:51 INFO - "branch": "mozilla-central", 19:29:51 INFO - "script_repo_revision": "production", 19:29:51 INFO - "revision": "0e41d07a703f19224f60b01577b2cbb5708046c9", 19:29:51 INFO - "slavename": "talos-linux64-ix-089", 19:29:51 INFO - "repo_path": "mozilla-central" 19:29:51 INFO - } 19:29:51 INFO - Finding installer, test and symbols from parent task. 19:29:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yh0aJmxiTgObubKyqWEl_A'}, attempt #1 19:29:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yh0aJmxiTgObubKyqWEl_A'}, attempt #1 19:29:52 INFO - Task dependencies: OtRgFQB_SSeTZ-Yqm0eoYw 19:29:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw'}, attempt #1 19:29:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:29:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/test_packages.json 19:29:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip 19:29:52 INFO - Running post-action listener: _resource_record_post_action 19:29:52 INFO - [mozharness: 2017-07-11 02:29:52.753134Z] Finished read-buildbot-config step (success) 19:29:52 INFO - [mozharness: 2017-07-11 02:29:52.753403Z] Running download-and-extract step. 19:29:52 INFO - Running pre-action listener: _resource_record_pre_action 19:29:52 INFO - Running main action method: download_and_extract 19:29:52 INFO - mkdir: /builds/slave/test/build/tests 19:29:52 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:29:52 INFO - trying https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json 19:29:52 INFO - Downloading https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:29:53 INFO - Downloaded 989 bytes. 19:29:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:29:53 INFO - Using the following test package requirements: 19:29:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:29:53 INFO - u'common': [u'target.common.tests.zip'], 19:29:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:29:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:29:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:29:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:29:53 INFO - u'mozbase': [u'target.common.tests.zip'], 19:29:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:29:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:29:53 INFO - u'web-platform': [u'target.common.tests.zip', 19:29:53 INFO - u'target.web-platform.tests.tar.gz'], 19:29:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:29:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:29:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip 19:29:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:29:53 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip into memory 19:29:54 INFO - Content-Length response header: 67424567 19:29:54 INFO - Bytes received: 67424567 19:30:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:30:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip 19:30:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:30:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip into memory 19:30:07 INFO - Content-Length response header: 67424567 19:30:07 INFO - Bytes received: 67424567 19:30:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip 19:30:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:30:19 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip into memory 19:30:19 INFO - Content-Length response header: 14474423 19:30:19 INFO - Bytes received: 14474423 19:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:20 INFO - trying https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:20 INFO - Downloading https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:30:21 INFO - Downloaded 62281803 bytes. 19:30:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:21 INFO - mkdir: /builds/slave/test/properties 19:30:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:21 INFO - Contents: 19:30:21 INFO - build_url:https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:21 INFO - Running post-action listener: _resource_record_post_action 19:30:21 INFO - Running post-action listener: set_extra_try_arguments 19:30:21 INFO - [mozharness: 2017-07-11 02:30:21.188030Z] Finished download-and-extract step (success) 19:30:21 INFO - [mozharness: 2017-07-11 02:30:21.188127Z] Running populate-webroot step. 19:30:21 INFO - Running pre-action listener: _resource_record_pre_action 19:30:21 INFO - Running main action method: populate_webroot 19:30:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:30:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:30:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:30:21 INFO - '--tppagecycles', 19:30:21 INFO - '7'], 19:30:21 INFO - 'tests': ['tsvgm']}}, 19:30:21 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:30:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['damp', 'tps']}, 19:30:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'tests': ['damp', 'tps']}, 19:30:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['dromaeo_dom']}, 19:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:30:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:30:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:30:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_many_windows', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_many_windows', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_many_windows', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['a11yr', 19:30:21 INFO - 'ts_paint', 19:30:21 INFO - 'tpaint', 19:30:21 INFO - 'sessionrestore', 19:30:21 INFO - 'sessionrestore_no_auto_restore', 19:30:21 INFO - 'tabpaint']}, 19:30:21 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 19:30:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:30:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:30:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:30:21 INFO - 'talos_options': ['--mitmproxy', 19:30:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:30:21 INFO - '--firstNonBlankPaint'], 19:30:21 INFO - 'tests': ['quantum_pageload_google', 19:30:21 INFO - 'quantum_pageload_youtube', 19:30:21 INFO - 'quantum_pageload_amazon', 19:30:21 INFO - 'quantum_pageload_facebook']}, 19:30:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['tsvgx', 19:30:21 INFO - 'tsvgr_opacity', 19:30:21 INFO - 'tart', 19:30:21 INFO - 'tscrollx', 19:30:21 INFO - 'cart', 19:30:21 INFO - 'tsvg_static']}, 19:30:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:21 INFO - 'tsvgr_opacity', 19:30:21 INFO - 'tart', 19:30:21 INFO - 'tscrollx', 19:30:21 INFO - 'cart', 19:30:21 INFO - 'tsvg_static']}, 19:30:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'talos_options': ['--disable-e10s'], 19:30:21 INFO - 'tests': ['tp5o']}, 19:30:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:30:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'talos_options': ['--disable-e10s', 19:30:21 INFO - '--xperf_path', 19:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:21 INFO - 'tests': ['tp5n']}, 19:30:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:30:21 INFO - 'talos_options': ['--xperf_path', 19:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:21 INFO - 'tests': ['tp5n']}}, 19:30:21 INFO - 'talos.zip': {'path': '', 19:30:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:30:21 INFO - Running post-action listener: _resource_record_post_action 19:30:21 INFO - [mozharness: 2017-07-11 02:30:21.203343Z] Finished populate-webroot step (success) 19:30:21 INFO - [mozharness: 2017-07-11 02:30:21.203433Z] Running create-virtualenv step. 19:30:21 INFO - Running pre-action listener: _resource_record_pre_action 19:30:21 INFO - Running main action method: create_virtualenv 19:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:21 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:30:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:30:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:21 INFO - Using real prefix '/usr' 19:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:21 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:23 INFO - Installing pip.................done. 19:30:23 INFO - Return code: 0 19:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:30:23 INFO - Reading from file tmpfile_stdout 19:30:23 INFO - Output received: 19:30:23 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:30:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:23 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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:23 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:30:23 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:30:23 INFO - Using env: {'DISPLAY': ':0', 19:30:23 INFO - 'HOME': '/home/cltbld', 19:30:23 INFO - 'LANG': 'en_US.UTF-8', 19:30:23 INFO - 'LANGUAGE': 'en_US:en', 19:30:23 INFO - 'LOGNAME': 'cltbld', 19:30:23 INFO - 'MAIL': '/var/mail/cltbld', 19:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:23 INFO - 'MOZ_NO_REMOTE': '1', 19:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:23 INFO - 'NO_EM_RESTART': '1', 19:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:23 INFO - 'PWD': '/builds/slave/test', 19:30:23 INFO - 'SHELL': '/bin/bash', 19:30:23 INFO - 'SHLVL': '1', 19:30:23 INFO - 'TERM': 'linux', 19:30:23 INFO - 'TMOUT': '86400', 19:30:23 INFO - 'USER': 'cltbld', 19:30:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:23 INFO - '_': '/tools/buildbot/bin/python'} 19:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:24 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:30:24 INFO - Cleaning up... 19:30:24 INFO - Return code: 0 19:30:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30: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', '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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:30: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 psutil>=3.1.1 19:30:24 INFO - Using env: {'DISPLAY': ':0', 19:30:24 INFO - 'HOME': '/home/cltbld', 19:30:24 INFO - 'LANG': 'en_US.UTF-8', 19:30:24 INFO - 'LANGUAGE': 'en_US:en', 19:30:24 INFO - 'LOGNAME': 'cltbld', 19:30:24 INFO - 'MAIL': '/var/mail/cltbld', 19:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:24 INFO - 'MOZ_NO_REMOTE': '1', 19:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:24 INFO - 'NO_EM_RESTART': '1', 19:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:24 INFO - 'PWD': '/builds/slave/test', 19:30:24 INFO - 'SHELL': '/bin/bash', 19:30:24 INFO - 'SHLVL': '1', 19:30:24 INFO - 'TERM': 'linux', 19:30:24 INFO - 'TMOUT': '86400', 19:30:24 INFO - 'USER': 'cltbld', 19:30:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:24 INFO - '_': '/tools/buildbot/bin/python'} 19:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:24 INFO - Downloading/unpacking psutil>=3.1.1 19:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:25 INFO - Installing collected packages: psutil 19:30:25 INFO - Running setup.py install for psutil 19:30:25 INFO - building 'psutil._psutil_linux' extension 19:30:25 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:30:25 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:30:25 INFO - building 'psutil._psutil_posix' extension 19:30:25 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:30:26 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:30:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:26 INFO - Successfully installed psutil 19:30:26 INFO - Cleaning up... 19:30:26 INFO - Return code: 0 19:30:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:30:26 INFO - Using env: {'DISPLAY': ':0', 19:30:26 INFO - 'HOME': '/home/cltbld', 19:30:26 INFO - 'LANG': 'en_US.UTF-8', 19:30:26 INFO - 'LANGUAGE': 'en_US:en', 19:30:26 INFO - 'LOGNAME': 'cltbld', 19:30:26 INFO - 'MAIL': '/var/mail/cltbld', 19:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:26 INFO - 'MOZ_NO_REMOTE': '1', 19:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:26 INFO - 'NO_EM_RESTART': '1', 19:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:26 INFO - 'PWD': '/builds/slave/test', 19:30:26 INFO - 'SHELL': '/bin/bash', 19:30:26 INFO - 'SHLVL': '1', 19:30:26 INFO - 'TERM': 'linux', 19:30:26 INFO - 'TMOUT': '86400', 19:30:26 INFO - 'USER': 'cltbld', 19:30:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:26 INFO - '_': '/tools/buildbot/bin/python'} 19:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:30: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:30: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:30: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:30: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:30:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:30:27 INFO - Installing collected packages: mozsystemmonitor 19:30:27 INFO - Running setup.py install for mozsystemmonitor 19:30:27 INFO - Successfully installed mozsystemmonitor 19:30:27 INFO - Cleaning up... 19:30:27 INFO - Return code: 0 19:30:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:30: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:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:30:27 INFO - Using env: {'DISPLAY': ':0', 19:30:27 INFO - 'HOME': '/home/cltbld', 19:30:27 INFO - 'LANG': 'en_US.UTF-8', 19:30:27 INFO - 'LANGUAGE': 'en_US:en', 19:30:27 INFO - 'LOGNAME': 'cltbld', 19:30:27 INFO - 'MAIL': '/var/mail/cltbld', 19:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:27 INFO - 'MOZ_NO_REMOTE': '1', 19:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:27 INFO - 'NO_EM_RESTART': '1', 19:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:27 INFO - 'PWD': '/builds/slave/test', 19:30:27 INFO - 'SHELL': '/bin/bash', 19:30:27 INFO - 'SHLVL': '1', 19:30:27 INFO - 'TERM': 'linux', 19:30:27 INFO - 'TMOUT': '86400', 19:30:27 INFO - 'USER': 'cltbld', 19:30:27 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:27 INFO - '_': '/tools/buildbot/bin/python'} 19:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:27 INFO - Downloading/unpacking jsonschema==2.5.1 19:30:27 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:30:27 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:30:27 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:30:27 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:30:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:29 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:29 INFO - warning: no files found matching '*.txt' 19:30:29 INFO - no previously-included directories found matching 'build' 19:30:29 INFO - no previously-included directories found matching 'dist' 19:30:29 INFO - no previously-included directories found matching '.git*' 19:30:29 INFO - Installing collected packages: jsonschema, functools32 19:30:29 INFO - Running setup.py install for functools32 19:30:29 INFO - warning: no files found matching '*.txt' 19:30:29 INFO - no previously-included directories found matching 'build' 19:30:29 INFO - no previously-included directories found matching 'dist' 19:30:29 INFO - no previously-included directories found matching '.git*' 19:30:29 INFO - Successfully installed jsonschema functools32 19:30:29 INFO - Cleaning up... 19:30:29 INFO - Return code: 0 19:30:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:30:29 INFO - Using env: {'DISPLAY': ':0', 19:30:29 INFO - 'HOME': '/home/cltbld', 19:30:29 INFO - 'LANG': 'en_US.UTF-8', 19:30:29 INFO - 'LANGUAGE': 'en_US:en', 19:30:29 INFO - 'LOGNAME': 'cltbld', 19:30:29 INFO - 'MAIL': '/var/mail/cltbld', 19:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:29 INFO - 'MOZ_NO_REMOTE': '1', 19:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:29 INFO - 'NO_EM_RESTART': '1', 19:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:29 INFO - 'PWD': '/builds/slave/test', 19:30:29 INFO - 'SHELL': '/bin/bash', 19:30:29 INFO - 'SHLVL': '1', 19:30:29 INFO - 'TERM': 'linux', 19:30:29 INFO - 'TMOUT': '86400', 19:30:29 INFO - 'USER': 'cltbld', 19:30:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:29 INFO - '_': '/tools/buildbot/bin/python'} 19:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:30:29 INFO - Cleaning up... 19:30:29 INFO - Return code: 0 19:30:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:30:29 INFO - Using env: {'DISPLAY': ':0', 19:30:29 INFO - 'HOME': '/home/cltbld', 19:30:29 INFO - 'LANG': 'en_US.UTF-8', 19:30:29 INFO - 'LANGUAGE': 'en_US:en', 19:30:29 INFO - 'LOGNAME': 'cltbld', 19:30:29 INFO - 'MAIL': '/var/mail/cltbld', 19:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:29 INFO - 'MOZ_NO_REMOTE': '1', 19:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:29 INFO - 'NO_EM_RESTART': '1', 19:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:29 INFO - 'PWD': '/builds/slave/test', 19:30:29 INFO - 'SHELL': '/bin/bash', 19:30:29 INFO - 'SHLVL': '1', 19:30:29 INFO - 'TERM': 'linux', 19:30:29 INFO - 'TMOUT': '86400', 19:30:29 INFO - 'USER': 'cltbld', 19:30:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:29 INFO - '_': '/tools/buildbot/bin/python'} 19:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30: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:30: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:30: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:30: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:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:30:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:30: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:30: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:30: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:30: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:30:31 INFO - Downloading docopt-0.6.1.tar.gz 19:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:30:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:30:31 INFO - Running setup.py install for blobuploader 19:30:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:30:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:30:31 INFO - Running setup.py install for requests 19:30:32 INFO - Running setup.py install for docopt 19:30:32 INFO - Successfully installed blobuploader requests docopt 19:30:32 INFO - Cleaning up... 19:30:32 INFO - Return code: 0 19:30:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:32 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:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:32 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:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:32 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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:32 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:30:32 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:30:32 INFO - Using env: {'DISPLAY': ':0', 19:30:32 INFO - 'HOME': '/home/cltbld', 19:30:32 INFO - 'LANG': 'en_US.UTF-8', 19:30:32 INFO - 'LANGUAGE': 'en_US:en', 19:30:32 INFO - 'LOGNAME': 'cltbld', 19:30:32 INFO - 'MAIL': '/var/mail/cltbld', 19:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:32 INFO - 'MOZ_NO_REMOTE': '1', 19:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:32 INFO - 'NO_EM_RESTART': '1', 19:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:32 INFO - 'PWD': '/builds/slave/test', 19:30:32 INFO - 'SHELL': '/bin/bash', 19:30:32 INFO - 'SHLVL': '1', 19:30:32 INFO - 'TERM': 'linux', 19:30:32 INFO - 'TMOUT': '86400', 19:30:32 INFO - 'USER': 'cltbld', 19:30:32 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:32 INFO - '_': '/tools/buildbot/bin/python'} 19:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:32 INFO - Running setup.py (path:/tmp/pip-uEq3og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:32 INFO - Running setup.py (path:/tmp/pip-VnqJKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:32 INFO - Running setup.py (path:/tmp/pip-v9P0G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:32 INFO - Running setup.py (path:/tmp/pip-lFEGEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:32 INFO - Running setup.py (path:/tmp/pip-d0S0Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:32 INFO - Running setup.py (path:/tmp/pip-gwHezx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:32 INFO - Running setup.py (path:/tmp/pip-C_giS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:32 INFO - Running setup.py (path:/tmp/pip-6qUNi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:33 INFO - Running setup.py (path:/tmp/pip-jQwShp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:33 INFO - Running setup.py (path:/tmp/pip-El5y3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:33 INFO - Running setup.py (path:/tmp/pip-JoYQMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:33 INFO - Running setup.py (path:/tmp/pip-pqmX11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:33 INFO - Running setup.py (path:/tmp/pip-sYrv7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:33 INFO - Running setup.py (path:/tmp/pip-Bzs0T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:33 INFO - Running setup.py (path:/tmp/pip-nDJ2tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:33 INFO - Running setup.py (path:/tmp/pip-DjjN27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:33 INFO - Running setup.py (path:/tmp/pip-FYTESt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:30:33 INFO - Running setup.py install for manifestparser 19:30:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:30:33 INFO - Running setup.py install for mozcrash 19:30:33 INFO - Running setup.py install for mozdebug 19:30:33 INFO - Running setup.py install for mozdevice 19:30:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for mozfile 19:30:34 INFO - Running setup.py install for mozhttpd 19:30:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for mozinfo 19:30:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for mozInstall 19:30:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for mozleak 19:30:34 INFO - Running setup.py install for mozlog 19:30:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for moznetwork 19:30:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:30:34 INFO - Running setup.py install for mozprocess 19:30:34 INFO - Running setup.py install for mozprofile 19:30:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:30:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:30:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:30:35 INFO - Running setup.py install for mozrunner 19:30:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:30:35 INFO - Running setup.py install for mozscreenshot 19:30:35 INFO - Running setup.py install for moztest 19:30:35 INFO - Running setup.py install for mozversion 19:30:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:30:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:30:35 INFO - Cleaning up... 19:30:35 INFO - Return code: 0 19:30:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:35 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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:35 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:30:35 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:30:35 INFO - Using env: {'DISPLAY': ':0', 19:30:35 INFO - 'HOME': '/home/cltbld', 19:30:35 INFO - 'LANG': 'en_US.UTF-8', 19:30:35 INFO - 'LANGUAGE': 'en_US:en', 19:30:35 INFO - 'LOGNAME': 'cltbld', 19:30:35 INFO - 'MAIL': '/var/mail/cltbld', 19:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:35 INFO - 'MOZ_NO_REMOTE': '1', 19:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:35 INFO - 'NO_EM_RESTART': '1', 19:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:35 INFO - 'PWD': '/builds/slave/test', 19:30:35 INFO - 'SHELL': '/bin/bash', 19:30:35 INFO - 'SHLVL': '1', 19:30:35 INFO - 'TERM': 'linux', 19:30:35 INFO - 'TMOUT': '86400', 19:30:35 INFO - 'USER': 'cltbld', 19:30:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:35 INFO - '_': '/tools/buildbot/bin/python'} 19:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:35 INFO - Running setup.py (path:/tmp/pip-kSU8go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:35 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:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:35 INFO - Running setup.py (path:/tmp/pip-3K92TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:35 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:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:35 INFO - Running setup.py (path:/tmp/pip-__Vsvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:35 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:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:35 INFO - Running setup.py (path:/tmp/pip-bcWbXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:35 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:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:35 INFO - Running setup.py (path:/tmp/pip-nRYLCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:36 INFO - Running setup.py (path:/tmp/pip-CQ8dMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:36 INFO - Running setup.py (path:/tmp/pip-zLu3Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:36 INFO - Running setup.py (path:/tmp/pip-V1IcO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:36 INFO - Running setup.py (path:/tmp/pip-Ji0Yxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:36 INFO - Running setup.py (path:/tmp/pip-5yv0bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:36 INFO - Running setup.py (path:/tmp/pip-jLiDs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:36 INFO - Running setup.py (path:/tmp/pip-5x52If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:36 INFO - Running setup.py (path:/tmp/pip-uoYFdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:36 INFO - Running setup.py (path:/tmp/pip-weQahu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:36 INFO - Running setup.py (path:/tmp/pip-aaWOZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:36 INFO - Running setup.py (path:/tmp/pip-qWJPot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:36 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:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:36 INFO - Running setup.py (path:/tmp/pip-SgdUql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:36 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:30:36 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:30:36 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:30:36 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:30:36 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:30:36 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:30:36 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:30:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:30:36 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:30:36 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:30:36 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:30:36 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:30:37 INFO - Downloading blessings-1.6.tar.gz 19:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:30:38 INFO - Installing collected packages: blessings 19:30:38 INFO - Running setup.py install for blessings 19:30:38 INFO - Successfully installed blessings 19:30:38 INFO - Cleaning up... 19:30:38 INFO - Return code: 0 19:30:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:38 INFO - Reading from file tmpfile_stdout 19:30:38 INFO - Current package versions: 19:30:38 INFO - argparse == 1.2.1 19:30:38 INFO - blessings == 1.6 19:30:38 INFO - blobuploader == 1.2.4 19:30:38 INFO - docopt == 0.6.1 19:30:38 INFO - functools32 == 3.2.3-2 19:30:38 INFO - jsonschema == 2.5.1 19:30:38 INFO - manifestparser == 1.1 19:30:38 INFO - mozInstall == 1.13 19:30:38 INFO - mozcrash == 1.0 19:30:38 INFO - mozdebug == 0.1 19:30:38 INFO - mozdevice == 0.51 19:30:38 INFO - mozfile == 1.2 19:30:38 INFO - mozhttpd == 0.7 19:30:38 INFO - mozinfo == 0.10 19:30:38 INFO - mozleak == 0.1 19:30:38 INFO - mozlog == 3.5 19:30:38 INFO - moznetwork == 0.27 19:30:38 INFO - mozprocess == 0.25 19:30:38 INFO - mozprofile == 0.28 19:30:38 INFO - mozrunner == 6.13 19:30:38 INFO - mozscreenshot == 0.1 19:30:38 INFO - mozsystemmonitor == 0.3 19:30:38 INFO - moztest == 0.8 19:30:38 INFO - mozversion == 1.4 19:30:38 INFO - psutil == 3.1.1 19:30:38 INFO - requests == 1.2.3 19:30:38 INFO - wsgiref == 0.1.2 19:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:38 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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:38 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:30:38 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:30:38 INFO - Using env: {'DISPLAY': ':0', 19:30:38 INFO - 'HOME': '/home/cltbld', 19:30:38 INFO - 'LANG': 'en_US.UTF-8', 19:30:38 INFO - 'LANGUAGE': 'en_US:en', 19:30:38 INFO - 'LOGNAME': 'cltbld', 19:30:38 INFO - 'MAIL': '/var/mail/cltbld', 19:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:38 INFO - 'MOZ_NO_REMOTE': '1', 19:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:38 INFO - 'NO_EM_RESTART': '1', 19:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:38 INFO - 'PWD': '/builds/slave/test', 19:30:38 INFO - 'SHELL': '/bin/bash', 19:30:38 INFO - 'SHLVL': '1', 19:30:38 INFO - 'TERM': 'linux', 19:30:38 INFO - 'TMOUT': '86400', 19:30:38 INFO - 'USER': 'cltbld', 19:30:38 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:38 INFO - '_': '/tools/buildbot/bin/python'} 19:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:38 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:30:38 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:30:38 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:30:38 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:30:38 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:30:38 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:30:38 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:30:38 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:30:38 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:30:38 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:39 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:30:39 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:30:39 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:30:39 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:30:39 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:30:39 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:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:30:40 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:30:40 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:30:40 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:30:40 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:30:40 INFO - Installing collected packages: marionette-driver, simplejson 19:30:40 INFO - Running setup.py install for marionette-driver 19:30:40 INFO - Running setup.py install for simplejson 19:30:40 INFO - building 'simplejson._speedups' extension 19:30:40 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:30:41 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:30:41 INFO - Successfully installed marionette-driver simplejson 19:30:41 INFO - Cleaning up... 19:30:41 INFO - Return code: 0 19:30:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:30:41 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:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:41 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:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:41 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 0xe291f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1198fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', '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:30:41 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:30:41 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:30:41 INFO - Using env: {'DISPLAY': ':0', 19:30:41 INFO - 'HOME': '/home/cltbld', 19:30:41 INFO - 'LANG': 'en_US.UTF-8', 19:30:41 INFO - 'LANGUAGE': 'en_US:en', 19:30:41 INFO - 'LOGNAME': 'cltbld', 19:30:41 INFO - 'MAIL': '/var/mail/cltbld', 19:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:41 INFO - 'MOZ_NO_REMOTE': '1', 19:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:41 INFO - 'NO_EM_RESTART': '1', 19:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:41 INFO - 'PWD': '/builds/slave/test', 19:30:41 INFO - 'SHELL': '/bin/bash', 19:30:41 INFO - 'SHLVL': '1', 19:30:41 INFO - 'TERM': 'linux', 19:30:41 INFO - 'TMOUT': '86400', 19:30:41 INFO - 'USER': 'cltbld', 19:30:41 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:41 INFO - '_': '/tools/buildbot/bin/python'} 19:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:30:41 INFO - Cleaning up... 19:30:41 INFO - Return code: 0 19:30:41 INFO - Running post-action listener: _resource_record_post_action 19:30:41 INFO - Running post-action listener: _start_resource_monitoring 19:30:41 INFO - Starting resource monitoring. 19:30:41 INFO - [mozharness: 2017-07-11 02:30:41.482584Z] Finished create-virtualenv step (success) 19:30:41 INFO - [mozharness: 2017-07-11 02:30:41.483105Z] Running install step. 19:30:41 INFO - Running pre-action listener: _resource_record_pre_action 19:30:41 INFO - Running main action method: install 19:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:41 INFO - Reading from file tmpfile_stdout 19:30:41 INFO - Detecting whether we're running mozinstall >=1.0... 19:30:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:30:41 INFO - Reading from file tmpfile_stdout 19:30:41 INFO - Output received: 19:30:41 INFO - Usage: mozinstall [options] installer 19:30:41 INFO - Options: 19:30:41 INFO - -h, --help show this help message and exit 19:30:41 INFO - -d DEST, --destination=DEST 19:30:41 INFO - Directory to install application into. [default: 19:30:41 INFO - "/builds/slave/test"] 19:30:41 INFO - --app=APP Application being installed. [default: firefox] 19:30:41 INFO - mkdir: /builds/slave/test/build/application 19:30:41 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:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:30:59 INFO - Reading from file tmpfile_stdout 19:30:59 INFO - Output received: 19:30:59 INFO - /builds/slave/test/build/application/firefox/firefox 19:30:59 INFO - Running post-action listener: _resource_record_post_action 19:30:59 INFO - [mozharness: 2017-07-11 02:30:59.910795Z] Finished install step (success) 19:30:59 INFO - [mozharness: 2017-07-11 02:30:59.911049Z] Running setup-mitmproxy step. 19:30:59 INFO - Running pre-action listener: _resource_record_pre_action 19:30:59 INFO - Running main action method: setup_mitmproxy 19:30:59 INFO - Skipping: mitmproxy is not required 19:30:59 INFO - Running post-action listener: _resource_record_post_action 19:30:59 INFO - [mozharness: 2017-07-11 02:30:59.912185Z] Finished setup-mitmproxy step (success) 19:30:59 INFO - [mozharness: 2017-07-11 02:30:59.912424Z] Running run-tests step. 19:30:59 INFO - Running pre-action listener: _resource_record_pre_action 19:30:59 INFO - Running pre-action listener: _set_gcov_prefix 19:30:59 INFO - Running main action method: run_tests 19:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:30:59 INFO - Python 2.7.3 19:30:59 INFO - Return code: 0 19:30:59 INFO - grabbing minidump binary from tooltool 19:30:59 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:30:59 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 0x119c2a0>, '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 0x119d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11974d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:30:59 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:30:59 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:30:59 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:30:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:00 INFO - Return code: 0 19:31:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:00 INFO - ENV: RUST_BACKTRACE is now 1 19:31:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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:31:00 INFO - Using env: {'DISPLAY': ':0', 19:31:00 INFO - 'HOME': '/home/cltbld', 19:31:00 INFO - 'LANG': 'en_US.UTF-8', 19:31:00 INFO - 'LANGUAGE': 'en_US:en', 19:31:00 INFO - 'LOGNAME': 'cltbld', 19:31:00 INFO - 'MAIL': '/var/mail/cltbld', 19:31:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:00 INFO - 'MOZ_NO_REMOTE': '1', 19:31:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:00 INFO - 'NO_EM_RESTART': '1', 19:31:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:00 INFO - 'PWD': '/builds/slave/test', 19:31:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:00 INFO - 'RUST_BACKTRACE': '1', 19:31:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:31:00 INFO - 'SHELL': '/bin/bash', 19:31:00 INFO - 'SHLVL': '1', 19:31:00 INFO - 'TERM': 'linux', 19:31:00 INFO - 'TMOUT': '86400', 19:31:00 INFO - 'USER': 'cltbld', 19:31:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325', 19:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:00 INFO - '_': '/tools/buildbot/bin/python'} 19:31:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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:31:00 INFO - mozversion application_buildid: 20170711014314 19:31:00 INFO - mozversion application_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:31:00 INFO - mozversion application_display_name: Nightly 19:31:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:00 INFO - mozversion application_name: Firefox 19:31:00 INFO - mozversion application_remotingname: firefox 19:31:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:31:00 INFO - mozversion application_vendor: Mozilla 19:31:00 INFO - mozversion application_version: 56.0a1 19:31:00 INFO - mozversion platform_buildid: 20170711014314 19:31:00 INFO - mozversion platform_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:31:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:31:00 INFO - mozversion platform_version: 56.0a1 19:31:00 INFO - using testdate: 1499740260 19:31:00 INFO - actual date: 1499740260 19:31:00 INFO - starting webserver on 'localhost:60688' 19:31:00 INFO - SUITE-START | Running 2 tests 19:31:00 INFO - TEST-START | dromaeo_css 19:31:00 INFO - Initialising browser for dromaeo_css test... 19:31:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60688/getInfo.html -profile /tmp/tmpZlEDAh/profile 19:31:00 INFO - TEST-INFO | started process 6816 (/builds/slave/test/build/application/firefox/firefox http://localhost:60688/getInfo.html) 19:31:06 INFO - TEST-INFO | 6816: exit 0 19:31:07 INFO - Browser initialized. 19:31:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:07 INFO - TEST-INFO | started process 7035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZlEDAh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:18 INFO - PID 7035 | RSS: Main: 173486080 19:31:18 INFO - PID 7035 | 19:34:18 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60688/tests/dromaeo/cssquery-ext.html) 19:34:20 INFO - PID 7035 | RSS: Main: 179212288 19:34:20 INFO - PID 7035 | 19:37:22 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-ext.html (next: http://localhost:60688/tests/dromaeo/cssquery-jquery.html) 19:37:23 INFO - PID 7035 | RSS: Main: 177352704 19:37:23 INFO - PID 7035 | 19:40:24 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60688/tests/dromaeo/cssquery-mootools.html) 19:40:25 INFO - PID 7035 | RSS: Main: 180355072 19:40:25 INFO - PID 7035 | 19:43:27 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60688/tests/dromaeo/cssquery-prototype.html) 19:43:27 INFO - PID 7035 | RSS: Main: 179015680 19:43:27 INFO - PID 7035 | 19:46:31 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60688/tests/dromaeo/cssquery-yui.html) 19:46:31 INFO - PID 7035 | RSS: Main: 178327552 19:46:31 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | Cycle 1(1): loaded http://localhost:60688/tests/dromaeo/cssquery-yui.html (next: http://localhost:60688/tests/dromaeo/cssquery-dojo.html) 19:49:33 INFO - PID 7035 | RSS: Main: 182489088 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | __start_tp_report 19:49:33 INFO - PID 7035 | _x_x_mozilla_page_load 19:49:33 INFO - PID 7035 | _x_x_mozilla_page_load_details 19:49:33 INFO - PID 7035 | |i|pagename|runs| 19:49:33 INFO - PID 7035 | |0;dojo.html;3126.359096385241;3164.398764234795;3185.0444866540033;3188.8405579721007;3199;5951.732172052257;5975.133605627187;5987.4910632596175;5992.640441573509;6020.698965051746;6073.362296958822;6082.939170608292;6087.908681369783;6095.939040609593;6109.3279739228765;5488.039593071197;5524.309461317335;5528.612997090206;5535.391106978229;5544.334679838415;5559.527440167571;5605.775768969257;5616.297962754656;5646.802361917334;5647.915281270784;5610.102383618621;5619.157126431048;5619.381867994538;5633.6619802811965;5634.549236061126;5610.410906854762;5619.269494965669;5626.127950167751;5628.268325117729;5645.32256129263;5533.474319939599;5545.611807173499;5557.888842223133;5577.69322687252;5677.261955945701;6000.18997435345;6033.306169790487;6082.2093127893095;6108.5418593605655;6153.538484613627;6479.125318082046;6493.350664933516;6577.704003319862;6578.572392794453;6583.374579414995;6395.168628078367;6461.773837915697;6499;6499.05763664266;6506.089147519351;6094.177286066369;6098.32918378978;6109.358517355702;6121.908171377478;6126.417990290915;6676.332366763285;6681.7327306908155;6689.0300906369275;6728.394444500019;6755.898661520081;6255.937440625627;6302.684865756693;6315.715792789336;6413.038044293393;6421.068945003042;6397.712102955378;6417.711202995783;6419.45434638061;6508.121403610452;6515.543911926215;6468.223813142453;6485.77299794505;6529.804105876831;6543.1166792483355;6547.148870646785;6460.289368169498;6469;6497.740090396331;6579.47364210862;6591.901121483182;5245;5262.684238945599;5338.012467693411;5338.652987555796;5368.033753924253;4536.228841097021;4551.7724113794175;4565.452145742533;4569.177548041384;4574.062317224961;5620.887582248332;5641.548676105902;5667.093265077568;5675.262215911987;5696.601237913306;6503.219613646393;6511.088447617338;6516.924707423317;6535.8366040848405;6535.836604084936;5578.63738856973;5639.548836093103;5681.0626246668835;5681.34664513578;5686.346070201897;5743.827685169452;5791.305043394819;5800.6809625471005;5805.216295800097;5814.186013958049;6353.30113687494;6358.046293056079;6363.713632886531;6374.936250637527;6427.100205971168;6530.738770449128;6553.115329430657;6615.569987950767;6653.1018312527185;6669.199696036312;6356.872862542816;6358.364163583789;6444.420002199637;6451.41937225652;6467.805965821033;6317.810465686037;6320.4311611955145;6371.362863713592;6376.458001069961;6426.550141490051;5048.924266136084;6524.608523488606;6525.2822189558165;6604.669766511752;6641.037049627874;6346.7143978522;6362.268339140873;6372.139761132188;6467.482601391784;6469.8706025880165;6340.714667839866;6347.68261586928;6435.517336199898;6439.710213040331;6443.323451037573;6137.877242455036;6182.752689892533;6220.688965551795;6243.96878015607;6415.166028416276;6425.646589437626;6448.484121270381;6451.70967306463;6461.709223085067;6465.353464653497;6161.784337548164;6214.347493513116;6215.192025036717;6296.244450665949;6300 19:49:33 INFO - PID 7035 | |1;ext.html;819.1521774962914;859.9355048371372;892.638481415027;897.3942588752591;1181.7163880668643;30281;30817.38365232694;30846.845765771166;41130.794346028226;42076;41466.378004329956;41676.16647667045;41882;41893.371599425955;41993.16013679732;7595.962020189905;7683.462157648967;7726.8454630907345;7746.651400686955;7747;7405.740799072034;7459.813504662399;7470.365018973366;7500.924990750104;7569.886451703229;7415.443841711866;7479.513831600956;7702.306792388684;7734.7679569613;7742.341900938427;7653.923460765377;7658.73194438192;7680.654370553339;7681.231876812302;7700;7474.177840437547;7557.848843023109;7559.168491465989;7580.924190758077;7581.317681408645;38315.808420958;39023.219535609416;39051.41422878659;39091.8045409774;39102.41346379807;3593.838277277529;3617.330793803155;3619;3626.764260323097;3627.038834708778;31501.054968350985;31617.8419107903;31718;31745.841270793728;31795.84102079475;4559.45286565611;4647.581717645395;4848.660593758438;4931.3835770528685;4936.160852655057;198263;199386;199605;199932.00033999883;199987;49821.75089124531;50303.74848125809;50328;50376.496235037914;50558.74720626373;52686;52697;52803.20795188075;52851.20723189155;52958.73520632372;16390.344386224657;16496.34014639401;16516.256768445208;16518.83481165197;16586.170691465377;13681.31593420325;13686.931565342109;13696.452141914211;13745.175289482462;13784.517541885985;14522.927385363217;14538.491152809602;14545.490907818175;14619.92690036543;14622.780658290134;5761.942380576141;5816.79641212564;5850.747462227073;5910.497607703393;5937.495312898452;980.944920391778;986.2110311750571;986.9555869985868;1015.4821041269006;1022.3354819367322;22300.553988920456;22384.664230036564;22527.21154759608;22721.431964201027;30299.394012119636;1122.1303489795473;1123.185690374472;1130.1806190511813;1138.0781566930648;1142.9828552571553;12604.928581070712;12710.809337859939;12756.234625922474;12777.23336599807;12865.48538058486;240723;242960;244611;244693;245125;54204;54339;54429.45570544323;54652.18021729677;54716.45283547193;1437.7771445425976;1539.9692006160037;1546.713857936263;1550.6200980759786;1557.56388211301;22139.446513837283;22576.20983265578;22760.772392275867;23072.4231894204;23477.647835282143;38902.610973889896;39019.21961560696;39051.80474097725;39211.80394098011;39391.80304098461;212875;213760;215329;215383;215394;35892.64107358893;36918.63081369152;37299;39094.80452597719;39181;45896.8525786858;47491.52508474871;47842;48585.757071214415;48633.756831215615;32461.51307730433;33302.33395332031;34794.304113917075;34817;35508.467372989944;33386.4992025115;33937.49093763645;34329.65670343264;34417.82791086029;34654.65345346615;38289.23421531498;38323.80838095792;38334;38466.615333847425;38473;30836.38327233398;32437.18907027343;33171;33338.33323333568;33367.16582085467;24791.752082479667;24799.752002480465;24966;25017.87491062606;25350.74649253484 19:49:33 INFO - PID 7035 | |2;jquery.html;567.5686478276511;580.7444724321296;582.8280657206124;593.7268856326089;606.1998162425598;21523;22366.776332236674;22423.663645045337;22475.438114047156;22515.3245402638;24158.516829663396;25489.235322940294;26621.201363959113;26802.59796103055;26998.460030799422;6421.101045853596;6585.209774827027;6618.602883826961;6621.801345959605;6622.304658010912;6426.260979987314;6429.678516074201;6449.645269510175;6468.547201695883;6488.026795980617;6109.847253818646;6222.906656400158;6386.3613638636;6422.743090276384;6459.321771214025;6398.936010639881;6478.773242936474;6479.157709497758;6487.156669632965;6504.544681872295;5994.790182343597;6029.60807547508;6043.063325184559;6061.696915154269;6076.817695469143;27392.904283828622;28391.85804070987;28682;28792.280192995135;28981.42037159266;1790.176518801353;1815.0924537731134;1825.6805059114736;1834.7706536682915;1836.3389179895228;18544.62910741791;18969.24123035077;19018.71471927922;19041.14314855835;19095.331663391713;2258.085475382473;2262.615355389571;2321.872297023663;2329.685492458513;2336.2874323331375;133992;139000.30499847536;139696;139999;140210;14608.196549189684;14688.017117689189;14767.187804670632;15124.697506049817;15146.621334466507;22345.888270558542;22442.887785560968;22450.214242501435;22525.774742252368;22526.21158259453;9952.059348426987;10220.795584088277;10265.743356416;10274.280800343904;10476.266661333786;9755.073268039525;9813.264005199639;9823.901760982442;9848.409095454295;9856.507174641383;9081.137291957253;9276.814463710689;9277.443353398818;9303.116203960748;9304;2683.8389696618265;2777.250142461524;2797.202797202787;2898.884044638233;2914.7668186545025;941.8257622339889;947.2138125355938;949.7055912667096;973.9321138414052;986.260304771407;19277.22891084369;19432.4170274892;19462.540309476844;19529.609407811764;19951.600967980557;1018.7504061504831;1034.9275550711377;1046.7330830638139;1061.570064124031;1064.1646307648614;10759.3544387337;10801.83797243042;10838.891611083945;10880.12958963281;10995.34027958325;561338;593678;600229;604736;605644;118133;121838;126367.3681631586;130130.34934825265;130378.34810826075;1246.5512415530402;1263.3746295583562;1316.1905428161613;1326.1247576599399;1327.3761332173863;19564.706529401785;20549.89725051365;20609.90217608269;20699.793002069786;21100.366988990354;58001;60034.39965600288;60035.39964600298;60464.79070418479;61143.69428152831;73651.63174184095;76788.23211767811;77307;77345.22654773381;77452.2254777445;14873.92563037178;15039.699206015599;15227.467038653594;15305.540833775005;15425.768613471031;23629;23641.881790590938;23713.52572948566;23798.762012380346;23824.761752382256;18546.072696365398;18616.906915465337;18676.626467470847;18777.718334225272;19263;16169.353225871304;16720.749188761936;17021.14894255307;17285.481435556954;17699.20353584066;17928.462146135636;19713.70429443588;19771.505712357306;19840;19927.501812454804;14991.325390357679;15041.247937603295;15064.171470568786;15092.16993065392;15114.244287785787;17392.130393480023;19184.61630767405;19293.035348232814;19396.12717427691;19511.512212194808 19:49:33 INFO - PID 7035 | |3;mootools.html;1303.7457695749329;1368.555219553645;1369.8972577056718;1370.3148425787106;1374.202962281876;12676.556320528784;13250.801237981426;13264.071514993955;13265.20408775474;13266.66833329166;12876.291803950779;13301.268430236332;13353.465861365557;13364.665883352922;13395.799063014063;2591.520568694788;2669.733026697334;2672.984265978935;2672.997625890291;2673.665791776028;2530.228280374485;2587.1591732686857;2601.5187190369747;2602.154299852546;2607.895684172631;2518.3326418499114;2556.8977240910435;2591.896324147032;2592.5074235895213;2596.0654164500766;2359.964600531002;2367.5975084235547;2374.9050037998545;2378.702662167229;2383.2969274064194;2324.5583339165505;2332.0322066342446;2355.9057637694473;2361.7520160383256;2377;12692.619221423372;12927.612171634866;12929.676758081028;13001.15492492985;13006.829385355364;6969.825754356131;7196.496245262833;7214.67533960973;7269.345758881726;7291.4531410144455;4670.136024835417;4849.466558678542;5012.373453318335;5075.086484432801;5100.668456550312;1787.1332403784284;1810.5473631592101;1869.6821540338176;1870.540239584955;1878.5397577593576;20484;20524.692129618066;20590.176392944264;21379.358619241448;22100.557988840294;6290.874182516415;6383;6592.406683398517;6616.966915165393;6661.633610151488;15463.690726185414;15535.766963495556;15564.221788910736;15582.06507609547;15602.84397156014;7026.297370263035;7120.1099862517185;7140.642967851587;7144.964275178695;7147.392471639865;6551.344865513506;6608.570442921195;6617.9669101655145;6647.434968027772;6683.6324002180345;4783.736894470768;4919.0899683558655;4945.381827271591;4996.225585034325;5032.72320022395;1413.6183230527906;1425.6263321569677;1433.0756661952983;1452.5787521618613;1459.846716094816;892.3441270666056;893.4326702543931;912.3932584831012;921.8018126102786;942.5711301358003;7070.858582828418;7099.6450177490915;7100.68046937889;7698.576578288248;7888.84222315562;721.1670520548774;727.5780047572396;731.3308322884608;745.8806590945422;752.2552672853835;4820.9517904821205;4939.357883475125;5063.11395505785;5179.663321884141;5201.921971170435;17000.149992500574;17167.399141030004;17581.560460988578;17582.032988185772;17606.647867042586;16565;17148.228329725192;17285.481435556954;17292.481225563253;17436.91281543584;10188.745281368025;10207.591696332212;10227.693169204937;10240.897591023995;10587.947060264649;7282.271772822675;7298.744543940937;7499.175090740124;7561.054868141482;7758.689652414066;14639;14905.478308259158;14926.925365373103;15076.623084422978;15305.693886121993;15315.009048823582;16031.118288494245;16130.516084517483;16131.67736645237;16615.169241538115;10652.73368165771;10800.08199303068;11003.33979961205;11006.504707288032;11008.39453830015;12077.577284795341;12208.633740987785;12233.327167005544;12308.199967002116;12319.384030798245;9852.310338276251;10124.645637402655;10407.58369665205;10581.52383142745;10681.679549613213;9862.063104005108;10123.341982771097;10255.84616230772;10460.320079194827;10533.947330263607;9118.863217051618;9257.86113208289;9262.30532710036;9274.165325120772;9304.069593040642;6933.653317334012;7057.188423331382;7136.3220494052985;7158.713651453883;7161.069061022034;6973.010093424611;7038.190608079932;7130.358267755927;7229;7284.016657751135 19:49:33 INFO - PID 7035 | |4;prototype.html;490.38024242184565;499.252615844544;522.271431353262;525.4933964987013;529.4705294705295;5946.956069872485;5995.640261584303;6025.517958563315;6032.607880487765;6037.675494934449;5670.206171136034;5840.970795146029;5911.438413350736;5918.496927761145;5934.258217722785;4824.662273640855;4833.009233107222;4854.951450485503;4873.927735898114;4884.169691152495;4808.783604737795;4820.39745031871;4856.951430485703;4858.659893807435;4895.21676531755;4803.486901625976;4805.879853003668;4837.32277481153;4893.779779909913;4909.705417674933;4617.930731039037;4698.577128058491;4793.3528973588645;4816.807327706888;4831.35733850489;4341.261985462447;4357.9564204358185;4369.1480161368545;4381.802818873159;4391;5768.134779783024;5803.941960580382;5835.562332825055;5846.181534585162;5876.676782776945;5514.80698175562;5548.6948217848;5557.499825015728;5558.416366281523;5572.6625609853745;6323.8735225295695;6328.873422531524;6367.458766004896;6381.808545743589;6401.871962560769;4830.444498882638;4839.782209800533;4845.903081938377;4846.927296090562;4860.562549370574;6666.166729158856;6719.614536839401;6725.461963042945;6738.966305168492;6762.526623136382;4919.852404427873;4930.235813448921;4933.309336692866;4951.207806750903;4956.430010548833;4962.379702537183;4967.950320496821;4979.701217926936;5004.924926126111;5007.774650140753;5420.701861397661;5501.284832971688;5521.3926468088475;5539.25220095282;5560.443955604407;6303.936960630427;6346.143270658495;6358;6362.872742545123;6403.64779937108;1713.8714596405318;1729;1743.494386627889;1754.1580041579857;1756.903370314645;1119.0991252042022;1145.9800777308203;1213.2174747288127;1220.9389530523438;1230.7107829660022;5451.618386712971;5455.781768729206;5477.397486276506;5582.944170558242;5613.494785469327;6439.484841212786;6463.450606698483;6491.253505846794;6536.463930976217;6563.7702680405955;5624.21261023457;5640.717964101778;5664.745086471119;5677.51741102011;5682.659040457503;3356.8992930211643;3433.776804507699;3437.415639341318;3454.671806178409;3459.135216195951;6283.7800676976085;6313.305536390993;6362.84092897672;6431.421172094534;6432.774852880127;6717.395434410926;6728.899066514006;6731.865362692816;6746.831329216809;6798.150231221098;6345.428911397904;6349.238091429058;6365.61806291624;6368.617882927039;6384.138141350858;6454.838629034311;6500.642464664489;6524.3149469305035;6541.247756508063;6577.901331480128;6331.96834015827;6378.585391949508;6406.839829004312;6427.035944608346;6481.217665142123;6397.328280530477;6411.775587854403;6427.292997770148;6429.357064293533;6429.453496452854;4904.558589726942;4945.67853089548;4946.010797840374;4953.702777833341;4961.08219979305;6521.576097553644;6525.184351956005;6544.738210471528;6571.408573228432;6574.145361103026;6228.314885362697;6252.280987686474;6276.497880169667;6285.277193122849;6297.4017468340435;6255.843603909939;6258.874822503615;6274.592151510137;6331.683415829098;6368.77709280173;6201.844953876189;6203.193584833943;6236.688165591793;6267.592606480564;6277.18396608438;6342.365763423621;6345.460635846005;6356.618602883842;6363.3636636336;6377.506429944889;5808.477237048686;6150.661713605795;6164.260288765377;6180.227471566054;6183.96908015457 19:49:33 INFO - PID 7035 | |5;yui.html;876.4872549558507;891.2691592893827;903.5708038681623;920.2591913509626;924.6809850601541;18418.07909604521;18439.44681659549;18744.625107497875;18760.343387981422;18837.62324753506;19132.90433547834;20057.899710501464;20488.69266960997;21018.159273629037;21131.47171320718;1028.8611037509934;1036.2280101324525;1040.2302296300759;1043.2175868098925;1044.4986406524872;1043.0247718383337;1047.308776207703;1049.5277125293649;1053.836655318427;1055.5988724284762;1018.1345856022359;1062.2458054781075;1122.9382383968878;1127.334872425269;1129.412705393195;1096.5778175402447;1102.167863263239;1103.0072934359061;1103.8399432082383;1113.4544073404054;808.5835794565803;809.607340439892;810.7729835646029;810.8864758933754;812.1066826490871;18366.632667346712;18678.25286988519;19102.2359105637;19122.904385477985;19539.90230048855;20084.79915200844;20189.495262618406;20325.390238292875;20394.796052039437;20647.17411303546;15387.461438849587;15710.371585136581;15961.76057359129;15965;16006.279717412628;3519.1554027033326;3541.5750109986707;3546.66306700863;3547.3792086385038;3559.0212691509782;102588.48705756424;103128.48435757848;106249;107793.46103269434;108681;14885.33016014282;14925.328360223815;15127.470538531099;15187.164705941279;15328;28517.85741071323;28881.71118288832;29159.854200729285;29176.854115729286;30395.848020759753;8659.913400866037;8669.826603467895;8672.262857657044;8676.652933882575;8678.175573320525;3997.4403583498333;4017.819198136091;4084.4690190275073;4093.9181216375505;4099.754014759124;4876.561109500162;4951.257311403318;4978.502149785065;5001.349824522861;5007;899.821234183222;1005.1908213887745;1030.3354336453096;1038.3406536849154;1040.8126537223372;583.5475323283321;678.6301465701205;684.9931500685029;702.0837806662355;708.727140051084;11891.227070240408;12335.814962775386;12401.565945192055;12456.75086498283;12494.50021999128;709.1950636028042;710.8862581986857;715.9463040272001;716.688240615334;726.5785844210345;5332.440093790096;5505.642133261325;5594.1888426177975;5624.268845050199;5701.230333904869;91901.54049229845;92271;95866;100659;102245.48877255566;88623.55688221646;88920.5553972226;89869;90998;93575.53212233895;73591.26408735845;75513;75622;76020;78210.21789782144;10384.480775961323;10444.373337599769;10596.735081623021;10656.307340023184;10680.57277708883;33812;34110.147246319044;35052.82473587718;35072;35513.82243088768;43264.35103473513;43287.783561083255;43712.34431483594;43814.12371752611;44558.331625025;15653.217339133225;16176.514704558882;16430.917845410695;16437.09595972233;16441.17794110266;17112.401065962633;17596.82403175952;17691.646167076844;17836.55408614795;18094;15773.921130394274;15882.841171588136;15887.52337429879;15924.44264450785;16109;15082.17048062367;15098.39606415731;15157.166355850533;15170.544883653509;15270.847291526943;15377.38490460369;15975.840241597436;16010.980783628649;16229.513114606581;16253.837461625233;12052.276863387873;12103.273803571814;12167.878321216675;12219.633410997685;12286.508539658671;11862.82205766897;11975.64073077809;12047.457864395948;12135.757284854077;12170.817437738264 19:49:33 INFO - PID 7035 | __end_tp_report 19:49:33 INFO - PID 7035 | __start_cc_report 19:49:33 INFO - PID 7035 | _x_x_mozilla_cycle_collect,352 19:49:33 INFO - PID 7035 | __end_cc_report 19:49:33 INFO - PID 7035 | __startTimestamp1499741373552__endTimestamp 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | ------- Summary: start ------- 19:49:33 INFO - PID 7035 | Number of tests: 6 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#0] dojo.html Cycles:165 Average:6006.21 Median:6243.97 stddev:693.57 (11.1%) stddev-sans-first:657.88 19:49:33 INFO - PID 7035 | Values: 3126.4 3164.4 3185.0 3188.8 3199.0 5951.7 5975.1 5987.5 5992.6 6020.7 6073.4 6082.9 6087.9 6095.9 6109.3 5488.0 5524.3 5528.6 5535.4 5544.3 5559.5 5605.8 5616.3 5646.8 5647.9 5610.1 5619.2 5619.4 5633.7 5634.5 5610.4 5619.3 5626.1 5628.3 5645.3 5533.5 5545.6 5557.9 5577.7 5677.3 6000.2 6033.3 6082.2 6108.5 6153.5 6479.1 6493.4 6577.7 6578.6 6583.4 6395.2 6461.8 6499.0 6499.1 6506.1 6094.2 6098.3 6109.4 6121.9 6126.4 6676.3 6681.7 6689.0 6728.4 6755.9 6255.9 6302.7 6315.7 6413.0 6421.1 6397.7 6417.7 6419.5 6508.1 6515.5 6468.2 6485.8 6529.8 6543.1 6547.1 6460.3 6469.0 6497.7 6579.5 6591.9 5245.0 5262.7 5338.0 5338.7 5368.0 4536.2 4551.8 4565.5 4569.2 4574.1 5620.9 5641.5 5667.1 5675.3 5696.6 6503.2 6511.1 6516.9 6535.8 6535.8 5578.6 5639.5 5681.1 5681.3 5686.3 5743.8 5791.3 5800.7 5805.2 5814.2 6353.3 6358.0 6363.7 6374.9 6427.1 6530.7 6553.1 6615.6 6653.1 6669.2 6356.9 6358.4 6444.4 6451.4 6467.8 6317.8 6320.4 6371.4 6376.5 6426.6 5048.9 6524.6 6525.3 6604.7 6641.0 6346.7 6362.3 6372.1 6467.5 6469.9 6340.7 6347.7 6435.5 6439.7 6443.3 6137.9 6182.8 6220.7 6244.0 6415.2 6425.6 6448.5 6451.7 6461.7 6465.4 6161.8 6214.3 6215.2 6296.2 6300.0 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#1] ext.html Cycles:180 Average:39238.98 Median:3626.90 stddev:57062.04 (1573.3%) stddev-sans-first:57149.19 19:49:33 INFO - PID 7035 | Values: 819.2 859.9 892.6 897.4 1181.7 30281.0 30817.4 30846.8 41130.8 42076.0 41466.4 41676.2 41882.0 41893.4 41993.2 7596.0 7683.5 7726.8 7746.7 7747.0 7405.7 7459.8 7470.4 7500.9 7569.9 7415.4 7479.5 7702.3 7734.8 7742.3 7653.9 7658.7 7680.7 7681.2 7700.0 7474.2 7557.8 7559.2 7580.9 7581.3 38315.8 39023.2 39051.4 39091.8 39102.4 3593.8 3617.3 3619.0 3626.8 3627.0 31501.1 31617.8 31718.0 31745.8 31795.8 4559.5 4647.6 4848.7 4931.4 4936.2 198263.0 199386.0 199605.0 199932.0 199987.0 49821.8 50303.7 50328.0 50376.5 50558.7 52686.0 52697.0 52803.2 52851.2 52958.7 16390.3 16496.3 16516.3 16518.8 16586.2 13681.3 13686.9 13696.5 13745.2 13784.5 14522.9 14538.5 14545.5 14619.9 14622.8 5761.9 5816.8 5850.7 5910.5 5937.5 980.9 986.2 987.0 1015.5 1022.3 22300.6 22384.7 22527.2 22721.4 30299.4 1122.1 1123.2 1130.2 1138.1 1143.0 12604.9 12710.8 12756.2 12777.2 12865.5 240723.0 242960.0 244611.0 244693.0 245125.0 54204.0 54339.0 54429.5 54652.2 54716.5 1437.8 1540.0 1546.7 1550.6 1557.6 22139.4 22576.2 22760.8 23072.4 23477.6 38902.6 39019.2 39051.8 39211.8 39391.8 212875.0 213760.0 215329.0 215383.0 215394.0 35892.6 36918.6 37299.0 39094.8 39181.0 45896.9 47491.5 47842.0 48585.8 48633.8 32461.5 33302.3 34794.3 34817.0 35508.5 33386.5 33937.5 34329.7 34417.8 34654.7 38289.2 38323.8 38334.0 38466.6 38473.0 30836.4 32437.2 33171.0 33338.3 33367.2 24791.8 24799.8 24966.0 25017.9 25350.7 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#2] jquery.html Cycles:180 Average:38263.38 Median:22495.38 stddev:98969.09 (440.0%) stddev-sans-first:99206.26 19:49:33 INFO - PID 7035 | Values: 567.6 580.7 582.8 593.7 606.2 21523.0 22366.8 22423.7 22475.4 22515.3 24158.5 25489.2 26621.2 26802.6 26998.5 6421.1 6585.2 6618.6 6621.8 6622.3 6426.3 6429.7 6449.6 6468.5 6488.0 6109.8 6222.9 6386.4 6422.7 6459.3 6398.9 6478.8 6479.2 6487.2 6504.5 5994.8 6029.6 6043.1 6061.7 6076.8 27392.9 28391.9 28682.0 28792.3 28981.4 1790.2 1815.1 1825.7 1834.8 1836.3 18544.6 18969.2 19018.7 19041.1 19095.3 2258.1 2262.6 2321.9 2329.7 2336.3 133992.0 139000.3 139696.0 139999.0 140210.0 14608.2 14688.0 14767.2 15124.7 15146.6 22345.9 22442.9 22450.2 22525.8 22526.2 9952.1 10220.8 10265.7 10274.3 10476.3 9755.1 9813.3 9823.9 9848.4 9856.5 9081.1 9276.8 9277.4 9303.1 9304.0 2683.8 2777.3 2797.2 2898.9 2914.8 941.8 947.2 949.7 973.9 986.3 19277.2 19432.4 19462.5 19529.6 19951.6 1018.8 1034.9 1046.7 1061.6 1064.2 10759.4 10801.8 10838.9 10880.1 10995.3 561338.0 593678.0 600229.0 604736.0 605644.0 118133.0 121838.0 126367.4 130130.3 130378.3 1246.6 1263.4 1316.2 1326.1 1327.4 19564.7 20549.9 20609.9 20699.8 21100.4 58001.0 60034.4 60035.4 60464.8 61143.7 73651.6 76788.2 77307.0 77345.2 77452.2 14873.9 15039.7 15227.5 15305.5 15425.8 23629.0 23641.9 23713.5 23798.8 23824.8 18546.1 18616.9 18676.6 18777.7 19263.0 16169.4 16720.7 17021.1 17285.5 17699.2 17928.5 19713.7 19771.5 19840.0 19927.5 14991.3 15041.2 15064.2 15092.2 15114.2 17392.1 19184.6 19293.0 19396.1 19511.5 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#3] mootools.html Cycles:180 Average:8191.94 Median:2377.85 stddev:5409.62 (227.5%) stddev-sans-first:5400.03 19:49:33 INFO - PID 7035 | Values: 1303.7 1368.6 1369.9 1370.3 1374.2 12676.6 13250.8 13264.1 13265.2 13266.7 12876.3 13301.3 13353.5 13364.7 13395.8 2591.5 2669.7 2673.0 2673.0 2673.7 2530.2 2587.2 2601.5 2602.2 2607.9 2518.3 2556.9 2591.9 2592.5 2596.1 2360.0 2367.6 2374.9 2378.7 2383.3 2324.6 2332.0 2355.9 2361.8 2377.0 12692.6 12927.6 12929.7 13001.2 13006.8 6969.8 7196.5 7214.7 7269.3 7291.5 4670.1 4849.5 5012.4 5075.1 5100.7 1787.1 1810.5 1869.7 1870.5 1878.5 20484.0 20524.7 20590.2 21379.4 22100.6 6290.9 6383.0 6592.4 6617.0 6661.6 15463.7 15535.8 15564.2 15582.1 15602.8 7026.3 7120.1 7140.6 7145.0 7147.4 6551.3 6608.6 6618.0 6647.4 6683.6 4783.7 4919.1 4945.4 4996.2 5032.7 1413.6 1425.6 1433.1 1452.6 1459.8 892.3 893.4 912.4 921.8 942.6 7070.9 7099.6 7100.7 7698.6 7888.8 721.2 727.6 731.3 745.9 752.3 4821.0 4939.4 5063.1 5179.7 5201.9 17000.1 17167.4 17581.6 17582.0 17606.6 16565.0 17148.2 17285.5 17292.5 17436.9 10188.7 10207.6 10227.7 10240.9 10587.9 7282.3 7298.7 7499.2 7561.1 7758.7 14639.0 14905.5 14926.9 15076.6 15305.7 15315.0 16031.1 16130.5 16131.7 16615.2 10652.7 10800.1 11003.3 11006.5 11008.4 12077.6 12208.6 12233.3 12308.2 12319.4 9852.3 10124.6 10407.6 10581.5 10681.7 9862.1 10123.3 10255.8 10460.3 10533.9 9118.9 9257.9 9262.3 9274.2 9304.1 6933.7 7057.2 7136.3 7158.7 7161.1 6973.0 7038.2 7130.4 7229.0 7284.0 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#4] prototype.html Cycles:180 Average:5353.59 Median:5843.58 stddev:1493.25 (25.6%) stddev-sans-first:1452.14 19:49:33 INFO - PID 7035 | Values: 490.4 499.3 522.3 525.5 529.5 5947.0 5995.6 6025.5 6032.6 6037.7 5670.2 5841.0 5911.4 5918.5 5934.3 4824.7 4833.0 4855.0 4873.9 4884.2 4808.8 4820.4 4857.0 4858.7 4895.2 4803.5 4805.9 4837.3 4893.8 4909.7 4617.9 4698.6 4793.4 4816.8 4831.4 4341.3 4358.0 4369.1 4381.8 4391.0 5768.1 5803.9 5835.6 5846.2 5876.7 5514.8 5548.7 5557.5 5558.4 5572.7 6323.9 6328.9 6367.5 6381.8 6401.9 4830.4 4839.8 4845.9 4846.9 4860.6 6666.2 6719.6 6725.5 6739.0 6762.5 4919.9 4930.2 4933.3 4951.2 4956.4 4962.4 4968.0 4979.7 5004.9 5007.8 5420.7 5501.3 5521.4 5539.3 5560.4 6303.9 6346.1 6358.0 6362.9 6403.6 1713.9 1729.0 1743.5 1754.2 1756.9 1119.1 1146.0 1213.2 1220.9 1230.7 5451.6 5455.8 5477.4 5582.9 5613.5 6439.5 6463.5 6491.3 6536.5 6563.8 5624.2 5640.7 5664.7 5677.5 5682.7 3356.9 3433.8 3437.4 3454.7 3459.1 6283.8 6313.3 6362.8 6431.4 6432.8 6717.4 6728.9 6731.9 6746.8 6798.2 6345.4 6349.2 6365.6 6368.6 6384.1 6454.8 6500.6 6524.3 6541.2 6577.9 6332.0 6378.6 6406.8 6427.0 6481.2 6397.3 6411.8 6427.3 6429.4 6429.5 4904.6 4945.7 4946.0 4953.7 4961.1 6521.6 6525.2 6544.7 6571.4 6574.1 6228.3 6252.3 6276.5 6285.3 6297.4 6255.8 6258.9 6274.6 6331.7 6368.8 6201.8 6203.2 6236.7 6267.6 6277.2 6342.4 6345.5 6356.6 6363.4 6377.5 5808.5 6150.7 6164.3 6180.2 6184.0 19:49:33 INFO - PID 7035 | 19:49:33 INFO - PID 7035 | [#5] yui.html Cycles:180 Average:20791.88 Median:18752.48 stddev:27414.14 (146.2%) stddev-sans-first:27450.26 19:49:33 INFO - PID 7035 | Values: 876.5 891.3 903.6 920.3 924.7 18418.1 18439.4 18744.6 18760.3 18837.6 19132.9 20057.9 20488.7 21018.2 21131.5 1028.9 1036.2 1040.2 1043.2 1044.5 1043.0 1047.3 1049.5 1053.8 1055.6 1018.1 1062.2 1122.9 1127.3 1129.4 1096.6 1102.2 1103.0 1103.8 1113.5 808.6 809.6 810.8 810.9 812.1 18366.6 18678.3 19102.2 19122.9 19539.9 20084.8 20189.5 20325.4 20394.8 20647.2 15387.5 15710.4 15961.8 15965.0 16006.3 3519.2 3541.6 3546.7 3547.4 3559.0 102588.5 103128.5 106249.0 107793.5 108681.0 14885.3 14925.3 15127.5 15187.2 15328.0 28517.9 28881.7 29159.9 29176.9 30395.8 8659.9 8669.8 8672.3 8676.7 8678.2 3997.4 4017.8 4084.5 4093.9 4099.8 4876.6 4951.3 4978.5 5001.3 5007.0 899.8 1005.2 1030.3 1038.3 1040.8 583.5 678.6 685.0 702.1 708.7 11891.2 12335.8 12401.6 12456.8 12494.5 709.2 710.9 715.9 716.7 726.6 5332.4 5505.6 5594.2 5624.3 5701.2 91901.5 92271.0 95866.0 100659.0 102245.5 88623.6 88920.6 89869.0 90998.0 93575.5 73591.3 75513.0 75622.0 76020.0 78210.2 10384.5 10444.4 10596.7 10656.3 10680.6 33812.0 34110.1 35052.8 35072.0 35513.8 43264.4 43287.8 43712.3 43814.1 44558.3 15653.2 16176.5 16430.9 16437.1 16441.2 17112.4 17596.8 17691.6 17836.6 18094.0 15773.9 15882.8 15887.5 15924.4 16109.0 15082.2 15098.4 15157.2 15170.5 15270.8 15377.4 15975.8 16011.0 16229.5 16253.8 12052.3 12103.3 12167.9 12219.6 12286.5 11862.8 11975.6 12047.5 12135.8 12170.8 19:49:33 INFO - PID 7035 | -------- Summary: end -------- 19:49:33 INFO - PID 7035 | 19:49:34 INFO - TEST-INFO | 7035: exit 0 19:49:34 INFO - TEST-OK | dromaeo_css | took 1113813ms 19:49:34 INFO - TEST-START | kraken 19:49:34 INFO - Initialising browser for kraken test... 19:49:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60688/getInfo.html -profile /tmp/tmpvlG7cm/profile 19:49:34 INFO - TEST-INFO | started process 7449 (/builds/slave/test/build/application/firefox/firefox http://localhost:60688/getInfo.html) 19:49:40 INFO - TEST-INFO | 7449: exit 0 19:49:40 INFO - Browser initialized. 19:49:40 INFO - Running cycle 1/1 for kraken test... 19:49:40 INFO - TEST-INFO | started process 7670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlG7cm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:51 INFO - PID 7670 | RSS: Main: 173846528 19:49:51 INFO - PID 7670 | 19:49:54 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60688/tests/kraken/driver.html?testName=audio-beat-detection) 19:49:55 INFO - PID 7670 | RSS: Main: 177664000 19:49:55 INFO - PID 7670 | 19:49:58 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60688/tests/kraken/driver.html?testName=audio-dft) 19:49:58 INFO - PID 7670 | RSS: Main: 178618368 19:49:58 INFO - PID 7670 | 19:50:01 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60688/tests/kraken/driver.html?testName=audio-fft) 19:50:02 INFO - PID 7670 | RSS: Main: 171900928 19:50:02 INFO - PID 7670 | 19:50:04 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60688/tests/kraken/driver.html?testName=audio-oscillator) 19:50:04 INFO - PID 7670 | RSS: Main: 173158400 19:50:04 INFO - PID 7670 | 19:50:07 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:07 INFO - PID 7670 | RSS: Main: 173236224 19:50:07 INFO - PID 7670 | 19:50:10 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60688/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:11 INFO - PID 7670 | RSS: Main: 177549312 19:50:11 INFO - PID 7670 | 19:50:14 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60688/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:15 INFO - PID 7670 | RSS: Main: 178044928 19:50:15 INFO - PID 7670 | 19:50:18 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60688/tests/kraken/driver.html?testName=json-parse-financial) 19:50:18 INFO - PID 7670 | RSS: Main: 177065984 19:50:18 INFO - PID 7670 | 19:50:20 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:21 INFO - PID 7670 | RSS: Main: 176865280 19:50:21 INFO - PID 7670 | 19:50:22 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:23 INFO - PID 7670 | RSS: Main: 177139712 19:50:23 INFO - PID 7670 | 19:50:25 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:50:26 INFO - PID 7670 | RSS: Main: 176680960 19:50:26 INFO - PID 7670 | 19:50:28 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:50:29 INFO - PID 7670 | RSS: Main: 176664576 19:50:29 INFO - PID 7670 | 19:50:32 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:50:33 INFO - PID 7670 | RSS: Main: 176881664 19:50:33 INFO - PID 7670 | 19:50:34 INFO - PID 7670 | Cycle 1(1): loaded http://localhost:60688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60688/tests/kraken/driver.html?testName=ai-astar) 19:50:35 INFO - PID 7670 | RSS: Main: 178233344 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | __start_tp_report 19:50:35 INFO - PID 7670 | _x_x_mozilla_page_load 19:50:35 INFO - PID 7670 | _x_x_mozilla_page_load_details 19:50:35 INFO - PID 7670 | |i|pagename|runs| 19:50:35 INFO - PID 7670 | |0;ai-astar;101;108;109;109;110;109;109;107;108;112 19:50:35 INFO - PID 7670 | |1;audio-beat-detection;143;119;149;188;121;153;153;130;174;121 19:50:35 INFO - PID 7670 | |2;audio-dft;163;162;163;162;163;168;162;163;166;166 19:50:35 INFO - PID 7670 | |3;audio-fft;74;75;75;170;76;74;84;76;98;73 19:50:35 INFO - PID 7670 | |4;audio-oscillator;83;82;128;83;82;83;131;81;82;130 19:50:35 INFO - PID 7670 | |5;imaging-gaussian-blur;113;113;114;114;114;114;113;113;113;114 19:50:35 INFO - PID 7670 | |6;imaging-darkroom;149;150;149;150;149;150;150;150;149;149 19:50:35 INFO - PID 7670 | |7;imaging-desaturate;94;94;95;94;94;95;96;95;94;94 19:50:35 INFO - PID 7670 | |8;json-parse-financial;54;54;59;54;55;54;55;55;59;58 19:50:35 INFO - PID 7670 | |9;json-stringify-tinderbox;53;54;53;55;54;54;56;54;54;54 19:50:35 INFO - PID 7670 | |10;stanford-crypto-aes;78;79;82;78;90;78;78;77;87;79 19:50:35 INFO - PID 7670 | |11;stanford-crypto-ccm;131;131;130;127;127;134;126;123;127;149 19:50:35 INFO - PID 7670 | |12;stanford-crypto-pbkdf2;180;187;180;188;179;181;181;183;190;193 19:50:35 INFO - PID 7670 | |13;stanford-crypto-sha256-iterative;72;68;68;70;69;69;70;70;72;68 19:50:35 INFO - PID 7670 | __end_tp_report 19:50:35 INFO - PID 7670 | __start_cc_report 19:50:35 INFO - PID 7670 | _x_x_mozilla_cycle_collect,952 19:50:35 INFO - PID 7670 | __end_cc_report 19:50:35 INFO - PID 7670 | __startTimestamp1499741435141__endTimestamp 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | ------- Summary: start ------- 19:50:35 INFO - PID 7670 | Number of tests: 14 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.86 (2.6%) stddev-sans-first:1.41 19:50:35 INFO - PID 7670 | Values: 101.0 108.0 109.0 109.0 110.0 109.0 109.0 107.0 108.0 112.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:151.00 stddev:23.31 (15.4%) stddev-sans-first:24.71 19:50:35 INFO - PID 7670 | Values: 143.0 119.0 149.0 188.0 121.0 153.0 153.0 130.0 174.0 121.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.20 19:50:35 INFO - PID 7670 | Values: 163.0 162.0 163.0 162.0 163.0 168.0 162.0 163.0 166.0 166.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#3] audio-fft Cycles:10 Average:87.50 Median:75.50 stddev:29.96 (39.7%) stddev-sans-first:31.38 19:50:35 INFO - PID 7670 | Values: 74.0 75.0 75.0 170.0 76.0 74.0 84.0 76.0 98.0 73.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:82.00 stddev:22.91 (27.9%) stddev-sans-first:23.77 19:50:35 INFO - PID 7670 | Values: 83.0 82.0 128.0 83.0 82.0 83.0 131.0 81.0 82.0 130.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:50:35 INFO - PID 7670 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:50:35 INFO - PID 7670 | Values: 149.0 150.0 149.0 150.0 149.0 150.0 150.0 150.0 149.0 149.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:50:35 INFO - PID 7670 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 94.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:2.11 (3.8%) stddev-sans-first:2.15 19:50:35 INFO - PID 7670 | Values: 54.0 54.0 59.0 54.0 55.0 54.0 55.0 55.0 59.0 58.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.83 19:50:35 INFO - PID 7670 | Values: 53.0 54.0 53.0 55.0 54.0 54.0 56.0 54.0 54.0 54.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.00 stddev:4.43 (5.6%) stddev-sans-first:4.59 19:50:35 INFO - PID 7670 | Values: 78.0 79.0 82.0 78.0 90.0 78.0 78.0 77.0 87.0 79.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:130.50 stddev:7.21 (5.5%) stddev-sans-first:7.65 19:50:35 INFO - PID 7670 | Values: 131.0 131.0 130.0 127.0 127.0 134.0 126.0 123.0 127.0 149.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:185.00 stddev:4.92 (2.7%) stddev-sans-first:4.97 19:50:35 INFO - PID 7670 | Values: 180.0 187.0 180.0 188.0 179.0 181.0 181.0 183.0 190.0 193.0 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.51 (2.2%) stddev-sans-first:1.32 19:50:35 INFO - PID 7670 | Values: 72.0 68.0 68.0 70.0 69.0 69.0 70.0 70.0 72.0 68.0 19:50:35 INFO - PID 7670 | -------- Summary: end -------- 19:50:35 INFO - PID 7670 | 19:50:35 INFO - PID 7670 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:50:35 INFO - TEST-INFO | 7670: exit 0 19:50:35 INFO - TEST-OK | kraken | took 61771ms 19:50:35 INFO - SUITE-END | took 1175s 19:50:36 INFO - Completed test suite (00:19:36) 19:50:36 INFO - javascript benchmark 19:50:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8287.254902095377, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.359096385241, 3164.398764234795, 3185.0444866540033, 3188.8405579721007, 3199.0, 5951.732172052257, 5975.133605627187, 5987.4910632596175, 5992.640441573509, 6020.698965051746, 6073.362296958822, 6082.939170608292, 6087.908681369783, 6095.939040609593, 6109.3279739228765, 5488.039593071197, 5524.309461317335, 5528.612997090206, 5535.391106978229, 5544.334679838415, 5559.527440167571, 5605.775768969257, 5616.297962754656, 5646.802361917334, 5647.915281270784, 5610.102383618621, 5619.157126431048, 5619.381867994538, 5633.6619802811965, 5634.549236061126, 5610.410906854762, 5619.269494965669, 5626.127950167751, 5628.268325117729, 5645.32256129263, 5533.474319939599, 5545.611807173499, 5557.888842223133, 5577.69322687252, 5677.261955945701, 6000.18997435345, 6033.306169790487, 6082.2093127893095, 6108.5418593605655, 6153.538484613627, 6479.125318082046, 6493.350664933516, 6577.704003319862, 6578.572392794453, 6583.374579414995, 6395.168628078367, 6461.773837915697, 6499.0, 6499.05763664266, 6506.089147519351, 6094.177286066369, 6098.32918378978, 6109.358517355702, 6121.908171377478, 6126.417990290915, 6676.332366763285, 6681.7327306908155, 6689.0300906369275, 6728.394444500019, 6755.898661520081, 6255.937440625627, 6302.684865756693, 6315.715792789336, 6413.038044293393, 6421.068945003042, 6397.712102955378, 6417.711202995783, 6419.45434638061, 6508.121403610452, 6515.543911926215, 6468.223813142453, 6485.77299794505, 6529.804105876831, 6543.1166792483355, 6547.148870646785, 6460.289368169498, 6469.0, 6497.740090396331, 6579.47364210862, 6591.901121483182, 5245.0, 5262.684238945599, 5338.012467693411, 5338.652987555796, 5368.033753924253, 4536.228841097021, 4551.7724113794175, 4565.452145742533, 4569.177548041384, 4574.062317224961, 5620.887582248332, 5641.548676105902, 5667.093265077568, 5675.262215911987, 5696.601237913306, 6503.219613646393, 6511.088447617338, 6516.924707423317, 6535.8366040848405, 6535.836604084936, 5578.63738856973, 5639.548836093103, 5681.0626246668835, 5681.34664513578, 5686.346070201897, 5743.827685169452, 5791.305043394819, 5800.6809625471005, 5805.216295800097, 5814.186013958049, 6353.30113687494, 6358.046293056079, 6363.713632886531, 6374.936250637527, 6427.100205971168, 6530.738770449128, 6553.115329430657, 6615.569987950767, 6653.1018312527185, 6669.199696036312, 6356.872862542816, 6358.364163583789, 6444.420002199637, 6451.41937225652, 6467.805965821033, 6317.810465686037, 6320.4311611955145, 6371.362863713592, 6376.458001069961, 6426.550141490051, 5048.924266136084, 6524.608523488606, 6525.2822189558165, 6604.669766511752, 6641.037049627874, 6346.7143978522, 6362.268339140873, 6372.139761132188, 6467.482601391784, 6469.8706025880165, 6340.714667839866, 6347.68261586928, 6435.517336199898, 6439.710213040331, 6443.323451037573, 6137.877242455036, 6182.752689892533, 6220.688965551795, 6243.96878015607, 6415.166028416276, 6425.646589437626, 6448.484121270381, 6451.70967306463, 6461.709223085067, 6465.353464653497, 6161.784337548164, 6214.347493513116, 6215.192025036717, 6296.244450665949, 6300.0], "value": 5956.8518064947175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.1521774962914, 859.9355048371372, 892.638481415027, 897.3942588752591, 1181.7163880668643, 30281.0, 30817.38365232694, 30846.845765771166, 41130.794346028226, 42076.0, 41466.378004329956, 41676.16647667045, 41882.0, 41893.371599425955, 41993.16013679732, 7595.962020189905, 7683.462157648967, 7726.8454630907345, 7746.651400686955, 7747.0, 7405.740799072034, 7459.813504662399, 7470.365018973366, 7500.924990750104, 7569.886451703229, 7415.443841711866, 7479.513831600956, 7702.306792388684, 7734.7679569613, 7742.341900938427, 7653.923460765377, 7658.73194438192, 7680.654370553339, 7681.231876812302, 7700.0, 7474.177840437547, 7557.848843023109, 7559.168491465989, 7580.924190758077, 7581.317681408645, 38315.808420958, 39023.219535609416, 39051.41422878659, 39091.8045409774, 39102.41346379807, 3593.838277277529, 3617.330793803155, 3619.0, 3626.764260323097, 3627.038834708778, 31501.054968350985, 31617.8419107903, 31718.0, 31745.841270793728, 31795.84102079475, 4559.45286565611, 4647.581717645395, 4848.660593758438, 4931.3835770528685, 4936.160852655057, 198263.0, 199386.0, 199605.0, 199932.00033999883, 199987.0, 49821.75089124531, 50303.74848125809, 50328.0, 50376.496235037914, 50558.74720626373, 52686.0, 52697.0, 52803.20795188075, 52851.20723189155, 52958.73520632372, 16390.344386224657, 16496.34014639401, 16516.256768445208, 16518.83481165197, 16586.170691465377, 13681.31593420325, 13686.931565342109, 13696.452141914211, 13745.175289482462, 13784.517541885985, 14522.927385363217, 14538.491152809602, 14545.490907818175, 14619.92690036543, 14622.780658290134, 5761.942380576141, 5816.79641212564, 5850.747462227073, 5910.497607703393, 5937.495312898452, 980.944920391778, 986.2110311750571, 986.9555869985868, 1015.4821041269006, 1022.3354819367322, 22300.553988920456, 22384.664230036564, 22527.21154759608, 22721.431964201027, 30299.394012119636, 1122.1303489795473, 1123.185690374472, 1130.1806190511813, 1138.0781566930648, 1142.9828552571553, 12604.928581070712, 12710.809337859939, 12756.234625922474, 12777.23336599807, 12865.48538058486, 240723.0, 242960.0, 244611.0, 244693.0, 245125.0, 54204.0, 54339.0, 54429.45570544323, 54652.18021729677, 54716.45283547193, 1437.7771445425976, 1539.9692006160037, 1546.713857936263, 1550.6200980759786, 1557.56388211301, 22139.446513837283, 22576.20983265578, 22760.772392275867, 23072.4231894204, 23477.647835282143, 38902.610973889896, 39019.21961560696, 39051.80474097725, 39211.80394098011, 39391.80304098461, 212875.0, 213760.0, 215329.0, 215383.0, 215394.0, 35892.64107358893, 36918.63081369152, 37299.0, 39094.80452597719, 39181.0, 45896.8525786858, 47491.52508474871, 47842.0, 48585.757071214415, 48633.756831215615, 32461.51307730433, 33302.33395332031, 34794.304113917075, 34817.0, 35508.467372989944, 33386.4992025115, 33937.49093763645, 34329.65670343264, 34417.82791086029, 34654.65345346615, 38289.23421531498, 38323.80838095792, 38334.0, 38466.615333847425, 38473.0, 30836.38327233398, 32437.18907027343, 33171.0, 33338.33323333568, 33367.16582085467, 24791.752082479667, 24799.752002480465, 24966.0, 25017.87491062606, 25350.74649253484], "value": 17583.853745605735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.5686478276511, 580.7444724321296, 582.8280657206124, 593.7268856326089, 606.1998162425598, 21523.0, 22366.776332236674, 22423.663645045337, 22475.438114047156, 22515.3245402638, 24158.516829663396, 25489.235322940294, 26621.201363959113, 26802.59796103055, 26998.460030799422, 6421.101045853596, 6585.209774827027, 6618.602883826961, 6621.801345959605, 6622.304658010912, 6426.260979987314, 6429.678516074201, 6449.645269510175, 6468.547201695883, 6488.026795980617, 6109.847253818646, 6222.906656400158, 6386.3613638636, 6422.743090276384, 6459.321771214025, 6398.936010639881, 6478.773242936474, 6479.157709497758, 6487.156669632965, 6504.544681872295, 5994.790182343597, 6029.60807547508, 6043.063325184559, 6061.696915154269, 6076.817695469143, 27392.904283828622, 28391.85804070987, 28682.0, 28792.280192995135, 28981.42037159266, 1790.176518801353, 1815.0924537731134, 1825.6805059114736, 1834.7706536682915, 1836.3389179895228, 18544.62910741791, 18969.24123035077, 19018.71471927922, 19041.14314855835, 19095.331663391713, 2258.085475382473, 2262.615355389571, 2321.872297023663, 2329.685492458513, 2336.2874323331375, 133992.0, 139000.30499847536, 139696.0, 139999.0, 140210.0, 14608.196549189684, 14688.017117689189, 14767.187804670632, 15124.697506049817, 15146.621334466507, 22345.888270558542, 22442.887785560968, 22450.214242501435, 22525.774742252368, 22526.21158259453, 9952.059348426987, 10220.795584088277, 10265.743356416, 10274.280800343904, 10476.266661333786, 9755.073268039525, 9813.264005199639, 9823.901760982442, 9848.409095454295, 9856.507174641383, 9081.137291957253, 9276.814463710689, 9277.443353398818, 9303.116203960748, 9304.0, 2683.8389696618265, 2777.250142461524, 2797.202797202787, 2898.884044638233, 2914.7668186545025, 941.8257622339889, 947.2138125355938, 949.7055912667096, 973.9321138414052, 986.260304771407, 19277.22891084369, 19432.4170274892, 19462.540309476844, 19529.609407811764, 19951.600967980557, 1018.7504061504831, 1034.9275550711377, 1046.7330830638139, 1061.570064124031, 1064.1646307648614, 10759.3544387337, 10801.83797243042, 10838.891611083945, 10880.12958963281, 10995.34027958325, 561338.0, 593678.0, 600229.0, 604736.0, 605644.0, 118133.0, 121838.0, 126367.3681631586, 130130.34934825265, 130378.34810826075, 1246.5512415530402, 1263.3746295583562, 1316.1905428161613, 1326.1247576599399, 1327.3761332173863, 19564.706529401785, 20549.89725051365, 20609.90217608269, 20699.793002069786, 21100.366988990354, 58001.0, 60034.39965600288, 60035.39964600298, 60464.79070418479, 61143.69428152831, 73651.63174184095, 76788.23211767811, 77307.0, 77345.22654773381, 77452.2254777445, 14873.92563037178, 15039.699206015599, 15227.467038653594, 15305.540833775005, 15425.768613471031, 23629.0, 23641.881790590938, 23713.52572948566, 23798.762012380346, 23824.761752382256, 18546.072696365398, 18616.906915465337, 18676.626467470847, 18777.718334225272, 19263.0, 16169.353225871304, 16720.749188761936, 17021.14894255307, 17285.481435556954, 17699.20353584066, 17928.462146135636, 19713.70429443588, 19771.505712357306, 19840.0, 19927.501812454804, 14991.325390357679, 15041.247937603295, 15064.171470568786, 15092.16993065392, 15114.244287785787, 17392.130393480023, 19184.61630767405, 19293.035348232814, 19396.12717427691, 19511.512212194808], "value": 12176.364569419487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.7457695749329, 1368.555219553645, 1369.8972577056718, 1370.3148425787106, 1374.202962281876, 12676.556320528784, 13250.801237981426, 13264.071514993955, 13265.20408775474, 13266.66833329166, 12876.291803950779, 13301.268430236332, 13353.465861365557, 13364.665883352922, 13395.799063014063, 2591.520568694788, 2669.733026697334, 2672.984265978935, 2672.997625890291, 2673.665791776028, 2530.228280374485, 2587.1591732686857, 2601.5187190369747, 2602.154299852546, 2607.895684172631, 2518.3326418499114, 2556.8977240910435, 2591.896324147032, 2592.5074235895213, 2596.0654164500766, 2359.964600531002, 2367.5975084235547, 2374.9050037998545, 2378.702662167229, 2383.2969274064194, 2324.5583339165505, 2332.0322066342446, 2355.9057637694473, 2361.7520160383256, 2377.0, 12692.619221423372, 12927.612171634866, 12929.676758081028, 13001.15492492985, 13006.829385355364, 6969.825754356131, 7196.496245262833, 7214.67533960973, 7269.345758881726, 7291.4531410144455, 4670.136024835417, 4849.466558678542, 5012.373453318335, 5075.086484432801, 5100.668456550312, 1787.1332403784284, 1810.5473631592101, 1869.6821540338176, 1870.540239584955, 1878.5397577593576, 20484.0, 20524.692129618066, 20590.176392944264, 21379.358619241448, 22100.557988840294, 6290.874182516415, 6383.0, 6592.406683398517, 6616.966915165393, 6661.633610151488, 15463.690726185414, 15535.766963495556, 15564.221788910736, 15582.06507609547, 15602.84397156014, 7026.297370263035, 7120.1099862517185, 7140.642967851587, 7144.964275178695, 7147.392471639865, 6551.344865513506, 6608.570442921195, 6617.9669101655145, 6647.434968027772, 6683.6324002180345, 4783.736894470768, 4919.0899683558655, 4945.381827271591, 4996.225585034325, 5032.72320022395, 1413.6183230527906, 1425.6263321569677, 1433.0756661952983, 1452.5787521618613, 1459.846716094816, 892.3441270666056, 893.4326702543931, 912.3932584831012, 921.8018126102786, 942.5711301358003, 7070.858582828418, 7099.6450177490915, 7100.68046937889, 7698.576578288248, 7888.84222315562, 721.1670520548774, 727.5780047572396, 731.3308322884608, 745.8806590945422, 752.2552672853835, 4820.9517904821205, 4939.357883475125, 5063.11395505785, 5179.663321884141, 5201.921971170435, 17000.149992500574, 17167.399141030004, 17581.560460988578, 17582.032988185772, 17606.647867042586, 16565.0, 17148.228329725192, 17285.481435556954, 17292.481225563253, 17436.91281543584, 10188.745281368025, 10207.591696332212, 10227.693169204937, 10240.897591023995, 10587.947060264649, 7282.271772822675, 7298.744543940937, 7499.175090740124, 7561.054868141482, 7758.689652414066, 14639.0, 14905.478308259158, 14926.925365373103, 15076.623084422978, 15305.693886121993, 15315.009048823582, 16031.118288494245, 16130.516084517483, 16131.67736645237, 16615.169241538115, 10652.73368165771, 10800.08199303068, 11003.33979961205, 11006.504707288032, 11008.39453830015, 12077.577284795341, 12208.633740987785, 12233.327167005544, 12308.199967002116, 12319.384030798245, 9852.310338276251, 10124.645637402655, 10407.58369665205, 10581.52383142745, 10681.679549613213, 9862.063104005108, 10123.341982771097, 10255.84616230772, 10460.320079194827, 10533.947330263607, 9118.863217051618, 9257.86113208289, 9262.30532710036, 9274.165325120772, 9304.069593040642, 6933.653317334012, 7057.188423331382, 7136.3220494052985, 7158.713651453883, 7161.069061022034, 6973.010093424611, 7038.190608079932, 7130.358267755927, 7229.0, 7284.016657751135], "value": 6035.138309964709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.38024242184565, 499.252615844544, 522.271431353262, 525.4933964987013, 529.4705294705295, 5946.956069872485, 5995.640261584303, 6025.517958563315, 6032.607880487765, 6037.675494934449, 5670.206171136034, 5840.970795146029, 5911.438413350736, 5918.496927761145, 5934.258217722785, 4824.662273640855, 4833.009233107222, 4854.951450485503, 4873.927735898114, 4884.169691152495, 4808.783604737795, 4820.39745031871, 4856.951430485703, 4858.659893807435, 4895.21676531755, 4803.486901625976, 4805.879853003668, 4837.32277481153, 4893.779779909913, 4909.705417674933, 4617.930731039037, 4698.577128058491, 4793.3528973588645, 4816.807327706888, 4831.35733850489, 4341.261985462447, 4357.9564204358185, 4369.1480161368545, 4381.802818873159, 4391.0, 5768.134779783024, 5803.941960580382, 5835.562332825055, 5846.181534585162, 5876.676782776945, 5514.80698175562, 5548.6948217848, 5557.499825015728, 5558.416366281523, 5572.6625609853745, 6323.8735225295695, 6328.873422531524, 6367.458766004896, 6381.808545743589, 6401.871962560769, 4830.444498882638, 4839.782209800533, 4845.903081938377, 4846.927296090562, 4860.562549370574, 6666.166729158856, 6719.614536839401, 6725.461963042945, 6738.966305168492, 6762.526623136382, 4919.852404427873, 4930.235813448921, 4933.309336692866, 4951.207806750903, 4956.430010548833, 4962.379702537183, 4967.950320496821, 4979.701217926936, 5004.924926126111, 5007.774650140753, 5420.701861397661, 5501.284832971688, 5521.3926468088475, 5539.25220095282, 5560.443955604407, 6303.936960630427, 6346.143270658495, 6358.0, 6362.872742545123, 6403.64779937108, 1713.8714596405318, 1729.0, 1743.494386627889, 1754.1580041579857, 1756.903370314645, 1119.0991252042022, 1145.9800777308203, 1213.2174747288127, 1220.9389530523438, 1230.7107829660022, 5451.618386712971, 5455.781768729206, 5477.397486276506, 5582.944170558242, 5613.494785469327, 6439.484841212786, 6463.450606698483, 6491.253505846794, 6536.463930976217, 6563.7702680405955, 5624.21261023457, 5640.717964101778, 5664.745086471119, 5677.51741102011, 5682.659040457503, 3356.8992930211643, 3433.776804507699, 3437.415639341318, 3454.671806178409, 3459.135216195951, 6283.7800676976085, 6313.305536390993, 6362.84092897672, 6431.421172094534, 6432.774852880127, 6717.395434410926, 6728.899066514006, 6731.865362692816, 6746.831329216809, 6798.150231221098, 6345.428911397904, 6349.238091429058, 6365.61806291624, 6368.617882927039, 6384.138141350858, 6454.838629034311, 6500.642464664489, 6524.3149469305035, 6541.247756508063, 6577.901331480128, 6331.96834015827, 6378.585391949508, 6406.839829004312, 6427.035944608346, 6481.217665142123, 6397.328280530477, 6411.775587854403, 6427.292997770148, 6429.357064293533, 6429.453496452854, 4904.558589726942, 4945.67853089548, 4946.010797840374, 4953.702777833341, 4961.08219979305, 6521.576097553644, 6525.184351956005, 6544.738210471528, 6571.408573228432, 6574.145361103026, 6228.314885362697, 6252.280987686474, 6276.497880169667, 6285.277193122849, 6297.4017468340435, 6255.843603909939, 6258.874822503615, 6274.592151510137, 6331.683415829098, 6368.77709280173, 6201.844953876189, 6203.193584833943, 6236.688165591793, 6267.592606480564, 6277.18396608438, 6342.365763423621, 6345.460635846005, 6356.618602883842, 6363.3636636336, 6377.506429944889, 5808.477237048686, 6150.661713605795, 6164.260288765377, 6180.227471566054, 6183.96908015457], "value": 4918.038480065551, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.4872549558507, 891.2691592893827, 903.5708038681623, 920.2591913509626, 924.6809850601541, 18418.07909604521, 18439.44681659549, 18744.625107497875, 18760.343387981422, 18837.62324753506, 19132.90433547834, 20057.899710501464, 20488.69266960997, 21018.159273629037, 21131.47171320718, 1028.8611037509934, 1036.2280101324525, 1040.2302296300759, 1043.2175868098925, 1044.4986406524872, 1043.0247718383337, 1047.308776207703, 1049.5277125293649, 1053.836655318427, 1055.5988724284762, 1018.1345856022359, 1062.2458054781075, 1122.9382383968878, 1127.334872425269, 1129.412705393195, 1096.5778175402447, 1102.167863263239, 1103.0072934359061, 1103.8399432082383, 1113.4544073404054, 808.5835794565803, 809.607340439892, 810.7729835646029, 810.8864758933754, 812.1066826490871, 18366.632667346712, 18678.25286988519, 19102.2359105637, 19122.904385477985, 19539.90230048855, 20084.79915200844, 20189.495262618406, 20325.390238292875, 20394.796052039437, 20647.17411303546, 15387.461438849587, 15710.371585136581, 15961.76057359129, 15965.0, 16006.279717412628, 3519.1554027033326, 3541.5750109986707, 3546.66306700863, 3547.3792086385038, 3559.0212691509782, 102588.48705756424, 103128.48435757848, 106249.0, 107793.46103269434, 108681.0, 14885.33016014282, 14925.328360223815, 15127.470538531099, 15187.164705941279, 15328.0, 28517.85741071323, 28881.71118288832, 29159.854200729285, 29176.854115729286, 30395.848020759753, 8659.913400866037, 8669.826603467895, 8672.262857657044, 8676.652933882575, 8678.175573320525, 3997.4403583498333, 4017.819198136091, 4084.4690190275073, 4093.9181216375505, 4099.754014759124, 4876.561109500162, 4951.257311403318, 4978.502149785065, 5001.349824522861, 5007.0, 899.821234183222, 1005.1908213887745, 1030.3354336453096, 1038.3406536849154, 1040.8126537223372, 583.5475323283321, 678.6301465701205, 684.9931500685029, 702.0837806662355, 708.727140051084, 11891.227070240408, 12335.814962775386, 12401.565945192055, 12456.75086498283, 12494.50021999128, 709.1950636028042, 710.8862581986857, 715.9463040272001, 716.688240615334, 726.5785844210345, 5332.440093790096, 5505.642133261325, 5594.1888426177975, 5624.268845050199, 5701.230333904869, 91901.54049229845, 92271.0, 95866.0, 100659.0, 102245.48877255566, 88623.55688221646, 88920.5553972226, 89869.0, 90998.0, 93575.53212233895, 73591.26408735845, 75513.0, 75622.0, 76020.0, 78210.21789782144, 10384.480775961323, 10444.373337599769, 10596.735081623021, 10656.307340023184, 10680.57277708883, 33812.0, 34110.147246319044, 35052.82473587718, 35072.0, 35513.82243088768, 43264.35103473513, 43287.783561083255, 43712.34431483594, 43814.12371752611, 44558.331625025, 15653.217339133225, 16176.514704558882, 16430.917845410695, 16437.09595972233, 16441.17794110266, 17112.401065962633, 17596.82403175952, 17691.646167076844, 17836.55408614795, 18094.0, 15773.921130394274, 15882.841171588136, 15887.52337429879, 15924.44264450785, 16109.0, 15082.17048062367, 15098.39606415731, 15157.166355850533, 15170.544883653509, 15270.847291526943, 15377.38490460369, 15975.840241597436, 16010.980783628649, 16229.513114606581, 16253.837461625233, 12052.276863387873, 12103.273803571814, 12167.878321216675, 12219.633410997685, 12286.508539658671, 11862.82205766897, 11975.64073077809, 12047.457864395948, 12135.757284854077, 12170.817437738264], "value": 8556.707280257564, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 107.0, 108.0, 112.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 149.0, 188.0, 121.0, 153.0, 153.0, 130.0, 174.0, 121.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 163.0, 168.0, 162.0, 163.0, 166.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 170.0, 76.0, 74.0, 84.0, 76.0, 98.0, 73.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 128.0, 83.0, 82.0, 83.0, 131.0, 81.0, 82.0, 130.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 150.0, 150.0, 149.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 59.0, 54.0, 55.0, 54.0, 55.0, 55.0, 59.0, 58.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 82.0, 78.0, 90.0, 78.0, 78.0, 77.0, 87.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 130.0, 127.0, 127.0, 134.0, 126.0, 123.0, 127.0, 149.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 187.0, 180.0, 188.0, 179.0, 181.0, 181.0, 183.0, 190.0, 193.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 70.0, 69.0, 69.0, 70.0, 70.0, 72.0, 68.0], "value": 69.6, "unit": "score"}]}]} 19:50:36 INFO - Return code: 0 19:50:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:50:36 INFO - # TBPL SUCCESS # 19:50:36 INFO - Running post-action listener: _package_coverage_data 19:50:36 INFO - Running post-action listener: _resource_record_post_action 19:50:36 INFO - [mozharness: 2017-07-11 02:50:36.436951Z] Finished run-tests step (success) 19:50:36 INFO - Running post-run listener: _resource_record_post_run 19:50:36 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 437686272; Read time: 284; Write time: 258804 19:50:36 INFO - TinderboxPrint: CPU usage
13.1% 19:50:36 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 284 19:50:36 INFO - TinderboxPrint: I/O write bytes / time
437,686,272 / 258,804 19:50:36 INFO - TinderboxPrint: CPU idle
8,271.6 (86.9%) 19:50:36 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 19:50:36 INFO - TinderboxPrint: Swap in / out
0 / 0 19:50:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107106304; Read time: 0; Write time: 85256 19:50:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:50:36 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 329457664; Read time: 272; Write time: 173500 19:50:37 INFO - Running post-run listener: _upload_blobber_files 19:50:37 INFO - Blob upload gear active. 19:50:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:50:37 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:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:50:37 INFO - (blobuploader) - INFO - Open directory for files ... 19:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:50:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:38 INFO - (blobuploader) - INFO - Done attempting. 19:50:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:50:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:39 INFO - (blobuploader) - INFO - Done attempting. 19:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:40 INFO - (blobuploader) - INFO - Done attempting. 19:50:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:50:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:50:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:42 INFO - (blobuploader) - INFO - Done attempting. 19:50:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:50:42 INFO - Return code: 0 19:50:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:50:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:50:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/798667636a7bb93048558d9274b064f4515a550c8ecdcde6d88a923009bad850a50c910e705d412765abfaa92d21147a222fd1e9ab294eee558bc333a2c0ed61", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/390b2b48e49753aaae296428e16363c47e7bb6f96ff0a30eae8db69d54ef725bc52ab1d5b8adc457109fc7a754f48aec93e1893316eb780567434799996ffc74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dce534cf251de66ba690ba81ad5e66128e8c3e72155fd29108c7d2fc42a6b75ad0b0efd88a2db0b90636fb84bfdd6c2d8a7190f11855cfbdf90d349a3e73c97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b78ea96ce53460636c3d9a2d22282bb6d0aa9afd258f59c6da34c3a26a9b38dda15e11efc9adf47f098d2c39432cd788cb65c901ea2b7a4193895c2ee6e0806"} 19:50:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:50:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:50:43 INFO - Contents: 19:50:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/798667636a7bb93048558d9274b064f4515a550c8ecdcde6d88a923009bad850a50c910e705d412765abfaa92d21147a222fd1e9ab294eee558bc333a2c0ed61", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/390b2b48e49753aaae296428e16363c47e7bb6f96ff0a30eae8db69d54ef725bc52ab1d5b8adc457109fc7a754f48aec93e1893316eb780567434799996ffc74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dce534cf251de66ba690ba81ad5e66128e8c3e72155fd29108c7d2fc42a6b75ad0b0efd88a2db0b90636fb84bfdd6c2d8a7190f11855cfbdf90d349a3e73c97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b78ea96ce53460636c3d9a2d22282bb6d0aa9afd258f59c6da34c3a26a9b38dda15e11efc9adf47f098d2c39432cd788cb65c901ea2b7a4193895c2ee6e0806"} 19:50:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:50:43 INFO - Copying logs to upload dir... 19:50:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:50:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.807617 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-10 19:50:42.362942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:42.366257) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/798667636a7bb93048558d9274b064f4515a550c8ecdcde6d88a923009bad850a50c910e705d412765abfaa92d21147a222fd1e9ab294eee558bc333a2c0ed61", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/390b2b48e49753aaae296428e16363c47e7bb6f96ff0a30eae8db69d54ef725bc52ab1d5b8adc457109fc7a754f48aec93e1893316eb780567434799996ffc74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dce534cf251de66ba690ba81ad5e66128e8c3e72155fd29108c7d2fc42a6b75ad0b0efd88a2db0b90636fb84bfdd6c2d8a7190f11855cfbdf90d349a3e73c97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b78ea96ce53460636c3d9a2d22282bb6d0aa9afd258f59c6da34c3a26a9b38dda15e11efc9adf47f098d2c39432cd788cb65c901ea2b7a4193895c2ee6e0806"} build_url:https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/798667636a7bb93048558d9274b064f4515a550c8ecdcde6d88a923009bad850a50c910e705d412765abfaa92d21147a222fd1e9ab294eee558bc333a2c0ed61", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/390b2b48e49753aaae296428e16363c47e7bb6f96ff0a30eae8db69d54ef725bc52ab1d5b8adc457109fc7a754f48aec93e1893316eb780567434799996ffc74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dce534cf251de66ba690ba81ad5e66128e8c3e72155fd29108c7d2fc42a6b75ad0b0efd88a2db0b90636fb84bfdd6c2d8a7190f11855cfbdf90d349a3e73c97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b78ea96ce53460636c3d9a2d22282bb6d0aa9afd258f59c6da34c3a26a9b38dda15e11efc9adf47f098d2c39432cd788cb65c901ea2b7a4193895c2ee6e0806"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:42.390390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:42.390679) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1499737331.663326-62728325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:42.474497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:50:42.474777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:50:42.475099) ========= ========= Total master_lag: 0.15 =========