builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1497874180.61 results: success (0) revision: d39cd452b52bf82fa4a717172a62d62ab9e5366f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.606157) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.606566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.606824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.623642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.623924) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-19 05:09:41-- 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% 94.9M=0s 2017-06-19 05:09:41 (94.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091858 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.727944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.728217) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016510 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:40.777509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 05:09:40.777912) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d39cd452b52bf82fa4a717172a62d62ab9e5366f --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 d39cd452b52bf82fa4a717172a62d62ab9e5366f --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=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-19 05:09:41,814 truncating revision to first 12 chars 2017-06-19 05:09:41,814 Setting DEBUG logging. 2017-06-19 05:09:41,814 attempt 1/10 2017-06-19 05:09:41,814 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d39cd452b52b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-19 05:09:42,984 unpacking tar archive at: mozilla-central-d39cd452b52b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-19 05:09:42.270193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:42.270495) ========= script_repo_revision: d39cd452b52bf82fa4a717172a62d62ab9e5366f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:42.270904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:42.271171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-19 05:09:42.279116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-19 05:09:42.279412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:43 INFO - MultiFileLogger online at 20170619 05:09:43 in /builds/slave/test 05:09:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:09:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:43 INFO - {'append_to_log': False, 05:09:43 INFO - 'base_work_dir': '/builds/slave/test', 05:09:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:09:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:43 INFO - 'branch': 'Firefox-Non-PGO', 05:09:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:43 INFO - 'config_files': ('talos/linux_config.py',), 05:09:43 INFO - 'default_actions': ('clobber', 05:09:43 INFO - 'read-buildbot-config', 05:09:43 INFO - 'download-and-extract', 05:09:43 INFO - 'populate-webroot', 05:09:43 INFO - 'create-virtualenv', 05:09:43 INFO - 'install', 05:09:43 INFO - 'setup-mitmproxy', 05:09:43 INFO - 'run-tests'), 05:09:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:43 INFO - 'download_minidump_stackwalk': True, 05:09:43 INFO - 'download_symbols': 'ondemand', 05:09:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:43 INFO - 'gecko_profile': False, 05:09:43 INFO - 'gecko_profile_interval': 0, 05:09:43 INFO - 'installer_path': 'installer.exe', 05:09:43 INFO - 'log_level': 'info', 05:09:43 INFO - 'log_name': 'talos', 05:09:43 INFO - 'log_to_console': True, 05:09:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:43 INFO - 'opt_config_files': (), 05:09:43 INFO - 'pip_index': False, 05:09:43 INFO - 'suite': 'dromaeojs-e10s', 05:09:43 INFO - 'system_bits': '32', 05:09:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:43 INFO - 'title': 'talos-linux64-ix-064', 05:09:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:43 INFO - 'use_talos_json': True, 05:09:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:43 INFO - 'work_dir': 'build'} 05:09:43 INFO - [mozharness: 2017-06-19 12:09:43.421906Z] Running clobber step. 05:09:43 INFO - Running pre-action listener: _resource_record_pre_action 05:09:43 INFO - Running main action method: clobber 05:09:43 INFO - rmtree: /builds/slave/test/build 05:09:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:44 INFO - Running post-action listener: _resource_record_post_action 05:09:44 INFO - [mozharness: 2017-06-19 12:09:44.954561Z] Finished clobber step (success) 05:09:44 INFO - [mozharness: 2017-06-19 12:09:44.954658Z] Running read-buildbot-config step. 05:09:44 INFO - Running pre-action listener: _resource_record_pre_action 05:09:44 INFO - Running main action method: read_buildbot_config 05:09:44 INFO - Using buildbot properties: 05:09:44 INFO - { 05:09:44 INFO - "project": "", 05:09:44 INFO - "product": "firefox", 05:09:44 INFO - "who": "cbook@mozilla.com", 05:09:44 INFO - "installer_path": "public/build/target.tar.bz2", 05:09:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:09:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:09:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:09:44 INFO - "stage_platform": "linux64", 05:09:44 INFO - "basedir": "/builds/slave/test", 05:09:44 INFO - "buildnumber": 967, 05:09:44 INFO - "platform": "ubuntu64_hw", 05:09:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:09:44 INFO - "slavebuilddir": "test", 05:09:44 INFO - "taskId": "XoBmIVmtRFmumLU10QpG-g", 05:09:44 INFO - "branch": "mozilla-central", 05:09:44 INFO - "script_repo_revision": "production", 05:09:44 INFO - "revision": "d39cd452b52bf82fa4a717172a62d62ab9e5366f", 05:09:44 INFO - "slavename": "talos-linux64-ix-064", 05:09:44 INFO - "repo_path": "mozilla-central" 05:09:44 INFO - } 05:09:44 INFO - Finding installer, test and symbols from parent task. 05:09:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XoBmIVmtRFmumLU10QpG-g'}, attempt #1 05:09:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XoBmIVmtRFmumLU10QpG-g'}, attempt #1 05:09:45 INFO - Task dependencies: CSC6dMU4Q_6PNZ3mMFIC_w 05:09:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w'}, attempt #1 05:09:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 05:09:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/test_packages.json 05:09:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.crashreporter-symbols.zip 05:09:46 INFO - Running post-action listener: _resource_record_post_action 05:09:46 INFO - [mozharness: 2017-06-19 12:09:46.320776Z] Finished read-buildbot-config step (success) 05:09:46 INFO - [mozharness: 2017-06-19 12:09:46.320994Z] Running download-and-extract step. 05:09:46 INFO - Running pre-action listener: _resource_record_pre_action 05:09:46 INFO - Running main action method: download_and_extract 05:09:46 INFO - mkdir: /builds/slave/test/build/tests 05:09:46 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')]} 05:09:46 INFO - trying https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.test_packages.json 05:09:46 INFO - Downloading https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:09:46 INFO - Downloaded 989 bytes. 05:09:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:09:46 INFO - Using the following test package requirements: 05:09:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:09:46 INFO - u'common': [u'target.common.tests.zip'], 05:09:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:09:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:09:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:09:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:09:46 INFO - u'mozbase': [u'target.common.tests.zip'], 05:09:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:09:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:09:46 INFO - u'web-platform': [u'target.common.tests.zip', 05:09:46 INFO - u'target.web-platform.tests.tar.gz'], 05:09:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:09:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:09:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip 05:09:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:09:46 INFO - Fetch https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip into memory 05:09:48 INFO - Content-Length response header: 67979580 05:09:48 INFO - Bytes received: 67979580 05:09:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:09:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip 05:09:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:09:59 INFO - Fetch https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.common.tests.zip into memory 05:10:01 INFO - Content-Length response header: 67979580 05:10:01 INFO - Bytes received: 67979580 05:10:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.talos.tests.zip 05:10:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:10:13 INFO - Fetch https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.talos.tests.zip into memory 05:10:14 INFO - Content-Length response header: 14454970 05:10:14 INFO - Bytes received: 14454970 05:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:14 INFO - trying https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 05:10:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:10:15 INFO - Downloaded 59424590 bytes. 05:10:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 05:10:15 INFO - mkdir: /builds/slave/test/properties 05:10:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:15 INFO - Contents: 05:10:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 05:10:15 INFO - Running post-action listener: _resource_record_post_action 05:10:15 INFO - Running post-action listener: set_extra_try_arguments 05:10:15 INFO - [mozharness: 2017-06-19 12:10:15.744396Z] Finished download-and-extract step (success) 05:10:15 INFO - [mozharness: 2017-06-19 12:10:15.744548Z] Running populate-webroot step. 05:10:15 INFO - Running pre-action listener: _resource_record_pre_action 05:10:15 INFO - Running main action method: populate_webroot 05:10:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:15 INFO - '--tppagecycles', 05:10:15 INFO - '7'], 05:10:15 INFO - 'tests': ['tsvgm']}}, 05:10:15 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['damp', 'tps']}, 05:10:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'tests': ['damp', 'tps']}, 05:10:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['dromaeo_dom']}, 05:10:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:10:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:10:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:10:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['a11yr', 05:10:15 INFO - 'ts_paint', 05:10:15 INFO - 'tpaint', 05:10:15 INFO - 'sessionrestore', 05:10:15 INFO - 'sessionrestore_no_auto_restore', 05:10:15 INFO - 'tabpaint']}, 05:10:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:10:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:10:15 INFO - 'bloom_basic_ref']}, 05:10:15 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:10:15 INFO - 'talos_options': ['--mitmproxy', 05:10:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:10:15 INFO - '--firstNonBlankPaint'], 05:10:15 INFO - 'tests': ['quantum_pageload_google', 05:10:15 INFO - 'quantum_pageload_youtube', 05:10:15 INFO - 'quantum_pageload_amazon', 05:10:15 INFO - 'quantum_pageload_facebook']}, 05:10:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['tsvgx', 05:10:15 INFO - 'tsvgr_opacity', 05:10:15 INFO - 'tart', 05:10:15 INFO - 'tscrollx', 05:10:15 INFO - 'cart', 05:10:15 INFO - 'tsvg_static']}, 05:10:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:15 INFO - 'tsvgr_opacity', 05:10:15 INFO - 'tart', 05:10:15 INFO - 'tscrollx', 05:10:15 INFO - 'cart', 05:10:15 INFO - 'tsvg_static']}, 05:10:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'talos_options': ['--disable-e10s'], 05:10:15 INFO - 'tests': ['tp5o']}, 05:10:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:10:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'talos_options': ['--disable-e10s', 05:10:15 INFO - '--xperf_path', 05:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:15 INFO - 'tests': ['tp5n']}, 05:10:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:10:15 INFO - 'talos_options': ['--xperf_path', 05:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:15 INFO - 'tests': ['tp5n']}}, 05:10:15 INFO - 'talos.zip': {'path': '', 05:10:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:15 INFO - Running post-action listener: _resource_record_post_action 05:10:15 INFO - [mozharness: 2017-06-19 12:10:15.765213Z] Finished populate-webroot step (success) 05:10:15 INFO - [mozharness: 2017-06-19 12:10:15.765302Z] Running create-virtualenv step. 05:10:15 INFO - Running pre-action listener: _resource_record_pre_action 05:10:15 INFO - Running main action method: create_virtualenv 05:10:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:10:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:10:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:15 INFO - Using real prefix '/usr' 05:10:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:18 INFO - Installing pip.................done. 05:10:18 INFO - Return code: 0 05:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Output received: 05:10:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:10:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:10:18 INFO - Using env: {'DISPLAY': ':0', 05:10:18 INFO - 'HOME': '/home/cltbld', 05:10:18 INFO - 'LANG': 'en_US.UTF-8', 05:10:18 INFO - 'LANGUAGE': 'en_US:en', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MAIL': '/var/mail/cltbld', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SHLVL': '1', 05:10:18 INFO - 'TERM': 'linux', 05:10:18 INFO - 'TMOUT': '86400', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - '_': '/tools/buildbot/bin/python'} 05:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:10:18 INFO - Cleaning up... 05:10:18 INFO - Return code: 0 05:10:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:10:18 INFO - Using env: {'DISPLAY': ':0', 05:10:18 INFO - 'HOME': '/home/cltbld', 05:10:18 INFO - 'LANG': 'en_US.UTF-8', 05:10:18 INFO - 'LANGUAGE': 'en_US:en', 05:10:18 INFO - 'LOGNAME': 'cltbld', 05:10:18 INFO - 'MAIL': '/var/mail/cltbld', 05:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:18 INFO - 'MOZ_NO_REMOTE': '1', 05:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:18 INFO - 'NO_EM_RESTART': '1', 05:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:18 INFO - 'PWD': '/builds/slave/test', 05:10:18 INFO - 'SHELL': '/bin/bash', 05:10:18 INFO - 'SHLVL': '1', 05:10:18 INFO - 'TERM': 'linux', 05:10:18 INFO - 'TMOUT': '86400', 05:10:18 INFO - 'USER': 'cltbld', 05:10:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:18 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:19 INFO - Downloading/unpacking psutil>=3.1.1 05:10:19 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 05:10:19 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 05:10:19 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 05:10:19 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 05:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:20 INFO - Installing collected packages: psutil 05:10:20 INFO - Running setup.py install for psutil 05:10:20 INFO - building 'psutil._psutil_linux' extension 05:10:20 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 05:10:20 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 05:10:20 INFO - building 'psutil._psutil_posix' extension 05:10:20 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 05:10:20 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 05:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:20 INFO - Successfully installed psutil 05:10:20 INFO - Cleaning up... 05:10:20 INFO - Return code: 0 05:10:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:20 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 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:20 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 05:10:20 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 05:10:20 INFO - Using env: {'DISPLAY': ':0', 05:10:20 INFO - 'HOME': '/home/cltbld', 05:10:20 INFO - 'LANG': 'en_US.UTF-8', 05:10:20 INFO - 'LANGUAGE': 'en_US:en', 05:10:20 INFO - 'LOGNAME': 'cltbld', 05:10:20 INFO - 'MAIL': '/var/mail/cltbld', 05:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:20 INFO - 'MOZ_NO_REMOTE': '1', 05:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:20 INFO - 'NO_EM_RESTART': '1', 05:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:20 INFO - 'PWD': '/builds/slave/test', 05:10:20 INFO - 'SHELL': '/bin/bash', 05:10:20 INFO - 'SHLVL': '1', 05:10:20 INFO - 'TERM': 'linux', 05:10:20 INFO - 'TMOUT': '86400', 05:10:20 INFO - 'USER': 'cltbld', 05:10:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:20 INFO - '_': '/tools/buildbot/bin/python'} 05:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:22 INFO - Installing collected packages: mozsystemmonitor 05:10:22 INFO - Running setup.py install for mozsystemmonitor 05:10:22 INFO - Successfully installed mozsystemmonitor 05:10:22 INFO - Cleaning up... 05:10:22 INFO - Return code: 0 05:10:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:10:22 INFO - Using env: {'DISPLAY': ':0', 05:10:22 INFO - 'HOME': '/home/cltbld', 05:10:22 INFO - 'LANG': 'en_US.UTF-8', 05:10:22 INFO - 'LANGUAGE': 'en_US:en', 05:10:22 INFO - 'LOGNAME': 'cltbld', 05:10:22 INFO - 'MAIL': '/var/mail/cltbld', 05:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:22 INFO - 'MOZ_NO_REMOTE': '1', 05:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:22 INFO - 'NO_EM_RESTART': '1', 05:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:22 INFO - 'PWD': '/builds/slave/test', 05:10:22 INFO - 'SHELL': '/bin/bash', 05:10:22 INFO - 'SHLVL': '1', 05:10:22 INFO - 'TERM': 'linux', 05:10:22 INFO - 'TMOUT': '86400', 05:10:22 INFO - 'USER': 'cltbld', 05:10:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:22 INFO - '_': '/tools/buildbot/bin/python'} 05:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:23 INFO - warning: no files found matching '*.txt' 05:10:23 INFO - no previously-included directories found matching 'build' 05:10:23 INFO - no previously-included directories found matching 'dist' 05:10:23 INFO - no previously-included directories found matching '.git*' 05:10:23 INFO - Installing collected packages: jsonschema, functools32 05:10:23 INFO - Running setup.py install for functools32 05:10:23 INFO - warning: no files found matching '*.txt' 05:10:23 INFO - no previously-included directories found matching 'build' 05:10:23 INFO - no previously-included directories found matching 'dist' 05:10:23 INFO - no previously-included directories found matching '.git*' 05:10:23 INFO - Successfully installed jsonschema functools32 05:10:23 INFO - Cleaning up... 05:10:24 INFO - Return code: 0 05:10:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:10:24 INFO - Using env: {'DISPLAY': ':0', 05:10:24 INFO - 'HOME': '/home/cltbld', 05:10:24 INFO - 'LANG': 'en_US.UTF-8', 05:10:24 INFO - 'LANGUAGE': 'en_US:en', 05:10:24 INFO - 'LOGNAME': 'cltbld', 05:10:24 INFO - 'MAIL': '/var/mail/cltbld', 05:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:24 INFO - 'MOZ_NO_REMOTE': '1', 05:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:24 INFO - 'NO_EM_RESTART': '1', 05:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:24 INFO - 'PWD': '/builds/slave/test', 05:10:24 INFO - 'SHELL': '/bin/bash', 05:10:24 INFO - 'SHLVL': '1', 05:10:24 INFO - 'TERM': 'linux', 05:10:24 INFO - 'TMOUT': '86400', 05:10:24 INFO - 'USER': 'cltbld', 05:10:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:24 INFO - '_': '/tools/buildbot/bin/python'} 05:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:24 INFO - Cleaning up... 05:10:24 INFO - Return code: 0 05:10:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:24 INFO - Using env: {'DISPLAY': ':0', 05:10:24 INFO - 'HOME': '/home/cltbld', 05:10:24 INFO - 'LANG': 'en_US.UTF-8', 05:10:24 INFO - 'LANGUAGE': 'en_US:en', 05:10:24 INFO - 'LOGNAME': 'cltbld', 05:10:24 INFO - 'MAIL': '/var/mail/cltbld', 05:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:24 INFO - 'MOZ_NO_REMOTE': '1', 05:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:24 INFO - 'NO_EM_RESTART': '1', 05:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:24 INFO - 'PWD': '/builds/slave/test', 05:10:24 INFO - 'SHELL': '/bin/bash', 05:10:24 INFO - 'SHLVL': '1', 05:10:24 INFO - 'TERM': 'linux', 05:10:24 INFO - 'TMOUT': '86400', 05:10:24 INFO - 'USER': 'cltbld', 05:10:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:24 INFO - '_': '/tools/buildbot/bin/python'} 05:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:10: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 05:10: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 05:10: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 05:10: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 05:10:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:26 INFO - Downloading docopt-0.6.1.tar.gz 05:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:26 INFO - Running setup.py install for blobuploader 05:10:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:26 INFO - Running setup.py install for requests 05:10:26 INFO - Running setup.py install for docopt 05:10:26 INFO - Successfully installed blobuploader requests docopt 05:10:26 INFO - Cleaning up... 05:10:26 INFO - Return code: 0 05:10:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:26 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 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:26 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 05:10:26 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 05:10:26 INFO - Using env: {'DISPLAY': ':0', 05:10:26 INFO - 'HOME': '/home/cltbld', 05:10:26 INFO - 'LANG': 'en_US.UTF-8', 05:10:26 INFO - 'LANGUAGE': 'en_US:en', 05:10:26 INFO - 'LOGNAME': 'cltbld', 05:10:26 INFO - 'MAIL': '/var/mail/cltbld', 05:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:26 INFO - 'MOZ_NO_REMOTE': '1', 05:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:26 INFO - 'NO_EM_RESTART': '1', 05:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:26 INFO - 'PWD': '/builds/slave/test', 05:10:26 INFO - 'SHELL': '/bin/bash', 05:10:26 INFO - 'SHLVL': '1', 05:10:26 INFO - 'TERM': 'linux', 05:10:26 INFO - 'TMOUT': '86400', 05:10:26 INFO - 'USER': 'cltbld', 05:10:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:26 INFO - '_': '/tools/buildbot/bin/python'} 05:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:26 INFO - Running setup.py (path:/tmp/pip-fbBP3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:27 INFO - Running setup.py (path:/tmp/pip-ZMyFVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:27 INFO - Running setup.py (path:/tmp/pip-HEDwr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:27 INFO - Running setup.py (path:/tmp/pip-_lUXsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:27 INFO - Running setup.py (path:/tmp/pip-JuUXbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:27 INFO - Running setup.py (path:/tmp/pip-dRuyw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:27 INFO - Running setup.py (path:/tmp/pip-zfgfGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:27 INFO - Running setup.py (path:/tmp/pip-dPGG_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:27 INFO - Running setup.py (path:/tmp/pip-bYJXSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:27 INFO - Running setup.py (path:/tmp/pip-22oX2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:27 INFO - Running setup.py (path:/tmp/pip-P_L1L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:27 INFO - Running setup.py (path:/tmp/pip-Cu2Eqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:27 INFO - Running setup.py (path:/tmp/pip-klbcar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:27 INFO - Running setup.py (path:/tmp/pip-FsCIxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:27 INFO - Running setup.py (path:/tmp/pip-hX4vJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:28 INFO - Running setup.py (path:/tmp/pip-SFJSp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:28 INFO - Running setup.py (path:/tmp/pip-eNaS1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:28 INFO - Running setup.py install for manifestparser 05:10:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Running setup.py install for mozcrash 05:10:28 INFO - Running setup.py install for mozdebug 05:10:28 INFO - Running setup.py install for mozdevice 05:10:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Running setup.py install for mozfile 05:10:28 INFO - Running setup.py install for mozhttpd 05:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Running setup.py install for mozinfo 05:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Running setup.py install for mozInstall 05:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:28 INFO - Running setup.py install for mozleak 05:10:29 INFO - Running setup.py install for mozlog 05:10:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Running setup.py install for moznetwork 05:10:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Running setup.py install for mozprocess 05:10:29 INFO - Running setup.py install for mozprofile 05:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Running setup.py install for mozrunner 05:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Running setup.py install for mozscreenshot 05:10:29 INFO - Running setup.py install for moztest 05:10:29 INFO - Running setup.py install for mozversion 05:10:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:29 INFO - Cleaning up... 05:10:29 INFO - Return code: 0 05:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 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 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:29 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 05:10:29 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 05:10:29 INFO - Using env: {'DISPLAY': ':0', 05:10:29 INFO - 'HOME': '/home/cltbld', 05:10:29 INFO - 'LANG': 'en_US.UTF-8', 05:10:29 INFO - 'LANGUAGE': 'en_US:en', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MAIL': '/var/mail/cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SHLVL': '1', 05:10:29 INFO - 'TERM': 'linux', 05:10:29 INFO - 'TMOUT': '86400', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - '_': '/tools/buildbot/bin/python'} 05:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:30 INFO - Running setup.py (path:/tmp/pip-xwDaGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:30 INFO - Running setup.py (path:/tmp/pip-WI1zso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:30 INFO - Running setup.py (path:/tmp/pip-E9dfr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:30 INFO - Running setup.py (path:/tmp/pip-SuyJt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:30 INFO - Running setup.py (path:/tmp/pip-0evyhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:30 INFO - Running setup.py (path:/tmp/pip-KVTYND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:30 INFO - Running setup.py (path:/tmp/pip-Vx_jAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:30 INFO - Running setup.py (path:/tmp/pip-zhR6eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:30 INFO - Running setup.py (path:/tmp/pip-oARMJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:30 INFO - Running setup.py (path:/tmp/pip-2HJAL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:30 INFO - Running setup.py (path:/tmp/pip-zE_MV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:30 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)) 05:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:31 INFO - Running setup.py (path:/tmp/pip-caTopS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:31 INFO - Running setup.py (path:/tmp/pip-12jdG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:31 INFO - Running setup.py (path:/tmp/pip-QGH3vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:31 INFO - Running setup.py (path:/tmp/pip-PnOgtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:31 INFO - Running setup.py (path:/tmp/pip-pCkiG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:31 INFO - Running setup.py (path:/tmp/pip-a9Nplt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10: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 05:10: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 05:10: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 05:10: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 05:10:32 INFO - Downloading blessings-1.6.tar.gz 05:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:32 INFO - Installing collected packages: blessings 05:10:32 INFO - Running setup.py install for blessings 05:10:32 INFO - Successfully installed blessings 05:10:32 INFO - Cleaning up... 05:10:32 INFO - Return code: 0 05:10:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:32 INFO - Reading from file tmpfile_stdout 05:10:32 INFO - Current package versions: 05:10:32 INFO - argparse == 1.2.1 05:10:32 INFO - blessings == 1.6 05:10:32 INFO - blobuploader == 1.2.4 05:10:32 INFO - docopt == 0.6.1 05:10:32 INFO - functools32 == 3.2.3-2 05:10:32 INFO - jsonschema == 2.5.1 05:10:32 INFO - manifestparser == 1.1 05:10:32 INFO - mozInstall == 1.13 05:10:32 INFO - mozcrash == 1.0 05:10:32 INFO - mozdebug == 0.1 05:10:32 INFO - mozdevice == 0.51 05:10:32 INFO - mozfile == 1.2 05:10:32 INFO - mozhttpd == 0.7 05:10:32 INFO - mozinfo == 0.10 05:10:32 INFO - mozleak == 0.1 05:10:32 INFO - mozlog == 3.4 05:10:32 INFO - moznetwork == 0.27 05:10:32 INFO - mozprocess == 0.25 05:10:32 INFO - mozprofile == 0.28 05:10:32 INFO - mozrunner == 6.13 05:10:32 INFO - mozscreenshot == 0.1 05:10:32 INFO - mozsystemmonitor == 0.3 05:10:32 INFO - moztest == 0.8 05:10:32 INFO - mozversion == 1.4 05:10:32 INFO - psutil == 3.1.1 05:10:32 INFO - requests == 1.2.3 05:10:32 INFO - wsgiref == 0.1.2 05:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10: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')]} 05:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10: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')]} 05:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:32 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 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:32 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 05:10:32 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 05:10:32 INFO - Using env: {'DISPLAY': ':0', 05:10:32 INFO - 'HOME': '/home/cltbld', 05:10:32 INFO - 'LANG': 'en_US.UTF-8', 05:10:32 INFO - 'LANGUAGE': 'en_US:en', 05:10:32 INFO - 'LOGNAME': 'cltbld', 05:10:32 INFO - 'MAIL': '/var/mail/cltbld', 05:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:32 INFO - 'MOZ_NO_REMOTE': '1', 05:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:32 INFO - 'NO_EM_RESTART': '1', 05:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:32 INFO - 'PWD': '/builds/slave/test', 05:10:32 INFO - 'SHELL': '/bin/bash', 05:10:32 INFO - 'SHLVL': '1', 05:10:32 INFO - 'TERM': 'linux', 05:10:32 INFO - 'TMOUT': '86400', 05:10:32 INFO - 'USER': 'cltbld', 05:10:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:32 INFO - '_': '/tools/buildbot/bin/python'} 05:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:10:33 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:34 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:10:34 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)) 05:10:34 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)) 05:10:34 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)) 05:10:34 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)) 05:10:34 INFO - Installing collected packages: marionette-driver 05:10:34 INFO - Running setup.py install for marionette-driver 05:10:34 INFO - Successfully installed marionette-driver 05:10:34 INFO - Cleaning up... 05:10:34 INFO - Return code: 0 05:10:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:34 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')]} 05:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:34 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')]} 05:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:34 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 0x19e23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', '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 05:10:34 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 05:10:34 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 05:10:34 INFO - Using env: {'DISPLAY': ':0', 05:10:34 INFO - 'HOME': '/home/cltbld', 05:10:34 INFO - 'LANG': 'en_US.UTF-8', 05:10:34 INFO - 'LANGUAGE': 'en_US:en', 05:10:34 INFO - 'LOGNAME': 'cltbld', 05:10:34 INFO - 'MAIL': '/var/mail/cltbld', 05:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:34 INFO - 'MOZ_NO_REMOTE': '1', 05:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:34 INFO - 'NO_EM_RESTART': '1', 05:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:34 INFO - 'PWD': '/builds/slave/test', 05:10:34 INFO - 'SHELL': '/bin/bash', 05:10:34 INFO - 'SHLVL': '1', 05:10:34 INFO - 'TERM': 'linux', 05:10:34 INFO - 'TMOUT': '86400', 05:10:34 INFO - 'USER': 'cltbld', 05:10:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:34 INFO - '_': '/tools/buildbot/bin/python'} 05:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:34 INFO - Cleaning up... 05:10:34 INFO - Return code: 0 05:10:34 INFO - Running post-action listener: _resource_record_post_action 05:10:34 INFO - Running post-action listener: _start_resource_monitoring 05:10:34 INFO - Starting resource monitoring. 05:10:34 INFO - [mozharness: 2017-06-19 12:10:34.797892Z] Finished create-virtualenv step (success) 05:10:34 INFO - [mozharness: 2017-06-19 12:10:34.798401Z] Running install step. 05:10:34 INFO - Running pre-action listener: _resource_record_pre_action 05:10:34 INFO - Running main action method: install 05:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:35 INFO - Reading from file tmpfile_stdout 05:10:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:35 INFO - Reading from file tmpfile_stdout 05:10:35 INFO - Output received: 05:10:35 INFO - Usage: mozinstall [options] installer 05:10:35 INFO - Options: 05:10:35 INFO - -h, --help show this help message and exit 05:10:35 INFO - -d DEST, --destination=DEST 05:10:35 INFO - Directory to install application into. [default: 05:10:35 INFO - "/builds/slave/test"] 05:10:35 INFO - --app=APP Application being installed. [default: firefox] 05:10:35 INFO - mkdir: /builds/slave/test/build/application 05:10:35 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'] 05:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:10:52 INFO - Reading from file tmpfile_stdout 05:10:52 INFO - Output received: 05:10:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:52 INFO - Running post-action listener: _resource_record_post_action 05:10:52 INFO - [mozharness: 2017-06-19 12:10:52.378131Z] Finished install step (success) 05:10:52 INFO - [mozharness: 2017-06-19 12:10:52.378413Z] Running setup-mitmproxy step. 05:10:52 INFO - Running pre-action listener: _resource_record_pre_action 05:10:52 INFO - Running main action method: setup_mitmproxy 05:10:52 INFO - Skipping: mitmproxy is not required 05:10:52 INFO - Running post-action listener: _resource_record_post_action 05:10:52 INFO - [mozharness: 2017-06-19 12:10:52.379555Z] Finished setup-mitmproxy step (success) 05:10:52 INFO - [mozharness: 2017-06-19 12:10:52.379776Z] Running run-tests step. 05:10:52 INFO - Running pre-action listener: _resource_record_pre_action 05:10:52 INFO - Running main action method: run_tests 05:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:52 INFO - Python 2.7.3 05:10:52 INFO - Return code: 0 05:10:52 INFO - grabbing minidump binary from tooltool 05:10: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')]} 05:10:52 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 0x1d5e140>, '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 0x1d5ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5eed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:52 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 05:10:52 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 05:10:52 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 05:10:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:52 INFO - Return code: 0 05:10:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:52 INFO - ENV: RUST_BACKTRACE is now 1 05:10:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 05:10:52 INFO - Using env: {'DISPLAY': ':0', 05:10:52 INFO - 'HOME': '/home/cltbld', 05:10:52 INFO - 'LANG': 'en_US.UTF-8', 05:10:52 INFO - 'LANGUAGE': 'en_US:en', 05:10:52 INFO - 'LOGNAME': 'cltbld', 05:10:52 INFO - 'MAIL': '/var/mail/cltbld', 05:10:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:52 INFO - 'MOZ_NO_REMOTE': '1', 05:10:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:52 INFO - 'NO_EM_RESTART': '1', 05:10:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:52 INFO - 'PWD': '/builds/slave/test', 05:10:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:52 INFO - 'RUST_BACKTRACE': '1', 05:10:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:10:52 INFO - 'SHELL': '/bin/bash', 05:10:52 INFO - 'SHLVL': '1', 05:10:52 INFO - 'TERM': 'linux', 05:10:52 INFO - 'TMOUT': '86400', 05:10:52 INFO - 'USER': 'cltbld', 05:10:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750', 05:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:52 INFO - '_': '/tools/buildbot/bin/python'} 05:10:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 05:10:52 INFO - mozversion application_buildid: 20170619113733 05:10:52 INFO - mozversion application_changeset: d39cd452b52bf82fa4a717172a62d62ab9e5366f 05:10:52 INFO - mozversion application_display_name: Nightly 05:10:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:52 INFO - mozversion application_name: Firefox 05:10:52 INFO - mozversion application_remotingname: firefox 05:10:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:10:52 INFO - mozversion application_vendor: Mozilla 05:10:52 INFO - mozversion application_version: 56.0a1 05:10:52 INFO - mozversion platform_buildid: 20170619113733 05:10:52 INFO - mozversion platform_changeset: d39cd452b52bf82fa4a717172a62d62ab9e5366f 05:10:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:10:52 INFO - mozversion platform_version: 56.0a1 05:10:52 INFO - using testdate: 1497874252 05:10:52 INFO - actual date: 1497874252 05:10:52 INFO - starting webserver on 'localhost:42338' 05:10:52 INFO - SUITE-START | Running 2 tests 05:10:52 INFO - TEST-START | dromaeo_css 05:10:52 INFO - operating with platform_type : linux_ 05:10:52 INFO - Initialising browser for dromaeo_css test... 05:10:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42338/getInfo.html -profile /tmp/tmpBF4yis/profile 05:10:52 INFO - TEST-INFO | started process 26831 (/builds/slave/test/build/application/firefox/firefox http://localhost:42338/getInfo.html) 05:10:59 INFO - TEST-INFO | 26831: exit 0 05:11:00 INFO - Browser initialized. 05:11:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:00 INFO - TEST-INFO | started process 27038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBF4yis/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:11 INFO - PID 27038 | RSS: Main: 175497216 05:11:11 INFO - PID 27038 | 05:14:16 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42338/tests/dromaeo/cssquery-ext.html) 05:14:17 INFO - PID 27038 | RSS: Main: 181321728 05:14:17 INFO - PID 27038 | 05:17:19 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-ext.html (next: http://localhost:42338/tests/dromaeo/cssquery-jquery.html) 05:17:19 INFO - PID 27038 | RSS: Main: 179978240 05:17:19 INFO - PID 27038 | 05:20:21 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42338/tests/dromaeo/cssquery-mootools.html) 05:20:21 INFO - PID 27038 | RSS: Main: 183017472 05:20:21 INFO - PID 27038 | 05:23:23 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42338/tests/dromaeo/cssquery-prototype.html) 05:23:24 INFO - PID 27038 | RSS: Main: 178061312 05:23:24 INFO - PID 27038 | 05:26:26 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42338/tests/dromaeo/cssquery-yui.html) 05:26:27 INFO - PID 27038 | RSS: Main: 183496704 05:26:27 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | Cycle 1(1): loaded http://localhost:42338/tests/dromaeo/cssquery-yui.html (next: http://localhost:42338/tests/dromaeo/cssquery-dojo.html) 05:29:29 INFO - PID 27038 | RSS: Main: 180793344 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | __start_tp_report 05:29:29 INFO - PID 27038 | _x_x_mozilla_page_load 05:29:29 INFO - PID 27038 | _x_x_mozilla_page_load_details 05:29:29 INFO - PID 27038 | |i|pagename|runs| 05:29:29 INFO - PID 27038 | |0;dojo.html;3068.9386212275767;3098.163495856119;3109.797863138896;3116.0340294508705;3122.765792565558;6045.941960156972;6092.573519853601;6119.9595720210555;6126.853582554522;6131.693415329238;6016.067509536029;6124.683193113479;6145.832291864543;6165.290991535975;6165.691715414223;5710.371859095496;5711.8000869969555;5756.424357564252;5765.596408251424;5788.884222315552;5739.741711622966;5781;5822.214001109859;5850.444207800273;5851.736671849756;5516.696581688006;5597.916031259534;5684.687342196177;5703.828885133411;5707.086866101404;5587.497125258747;5600.52395546379;5631.18347839561;5686.5735069869925;5699.857503562403;5587.552995760329;5619.578531610146;5620.5503559715125;5665.1502274658715;5671.234383358235;6095.786647467362;6123.8162855114415;6136.294326152461;6140.324564297968;6143.139960405547;6587.374199451045;6607.075009498674;6607.900881486781;6643.335666433366;6689.8662026759675;6536.607803531756;6551.93448065518;6614.404703576702;6630.801075967729;6653.002049692536;6177.938220617736;6222.315545290015;6241.095041218998;6259.0924315973925;6263.843403914848;6886.896696549556;6888.758893438706;6894.172699276119;6895.931040689629;6917.481188910851;6273.435390814758;6354.110424540568;6372.74509019634;6379.744810207632;6380.106785050097;6482.935170648328;6548.410643042053;6569.868602627921;6619.304972977864;6658.6337751424135;6589.934100658932;6655.800325990228;6667.933320666828;6688.632125233062;6688.966555167291;6601.405873471411;6667.86664266712;6675.766348177791;6676.632785196861;6682.398584127452;5331.1470164773455;5346.572274218053;5364.463553644604;5370.167624018283;5384.138537833927;4410.25025745624;4411.955880441219;4421.447319085114;4470.307102399133;4480.641548676098;5751.079827227623;5767.596268261182;5801.274840644919;5869.236999190078;5887.322957859901;6714.865702686016;6715.798526044129;6730.596164230162;6734.966325168343;6749.42629876466;5807.128930660435;5807.88384232313;5808.970955145197;5828.213191219216;5833.241678581757;5890.410958904075;5898.705064746746;5905.1142328650185;5911.497522710618;5917.970410147922;6292.244930608356;6358.395952384516;6378.425941665272;6378.649174295459;6488.480921526267;6663.400293973566;6665.200175978914;6688.966555167193;6721.93278067213;6731.091302674076;6440.162778838721;6467.223933128054;6499.025146228104;6514.120593719787;6514.315996820265;6521.543491955517;6536.6731663415685;6548.869022619616;6560.475161986934;6570.244421891352;6522.5760325578685;6709.993500974698;6736.528443008942;6740.730370785113;6772.55978361405;6327.050942358683;6364.713587888648;6364.872702546016;6427.55007149495;6433.067205255305;6367.87264254703;6441.3880681335195;6459.095726598374;6463.612183269019;6480.060391243338;6354.93645063562;6355.523335749745;6397.360263973565;6405.775797847053;6421.454176395058;6382.936170638234;6453.419192272718;6551.80344589663;6552.049952756919;6560.967195163994;6236.220472440945;6277.74889004453;6327.588706734047;6335.746570137143;6346 05:29:29 INFO - PID 27038 | |1;ext.html;806.7620052084634;816.9019717633885;851.0595791650227;864.6671031652812;874.8687696845476;39614.60385396145;40279.19441611166;40428.79785601075;40611.59388406115;40656.796716016455;36068;36329.818350908274;36503.26993460129;36573;36611.4508282376;6814.761483348071;6958.304169583026;6992;6993.230744618088;7003.509754317174;6855.177378714537;6856.965715171417;6909.516333856632;6944.861102777942;6965.616891070989;6870.656467176646;6872.656367181621;6910.965445172767;6923.480738944574;6924.099867017306;6878.209005964303;6881.896771548406;6896.862017767063;6916;6926.411255043327;6245.3442388549;6264.091706702548;6288.559800813945;6293.2762732285455;6320.93679063208;32302.838485807657;32431.189220269684;32563.6743632563;32812.8359358204;32846.17884552881;3286.720628746559;3332.8833490827706;3338.7329013678846;3541.4687796830426;3603.5135256740527;29932.551011734842;30033;30202.69797302043;30211;30235;3661.359262129117;3728.720345974036;3733.383991641376;3750.587435382106;3753.2118255166447;178356;180150;185915;186622;187480.99999999863;41539.1692166155;47655.5234447658;47756.7612161937;47815.76092119587;47829;50249.49750502521;50293.74853125711;50490;50508.49491505112;50878.675312598105;14915.850841491447;15176.317065732068;15186.392544298325;15198.848011519744;15203.467878624417;12187.207831490925;12295.815562766566;12299.139060265696;12299.323537205539;12319.938400307941;13943.302834858216;14078.788818167735;14126.50557230492;14134.293285335692;14214.28928553589;5722.656640601577;5772.480476757112;5891.263592050994;5912.836632401644;5919.200907877467;1008.8537162111453;1022.897710228986;1034.6430481484026;1040.105509262034;1060.5015642648098;22282.777172228394;22932;22995;23139.3058208254;23241.186558470712;1100.1034157161887;1102.2009043443438;1132.7394699219226;1134.8241022641503;1142.360278244186;12197.39013049344;16287.51137465878;16655.41706040283;16727.83272167263;16908.40820571274;220239;221511;221608;222375;224036;53855;54485;54490;54592;54696;1415.0872687116753;1463.9341229644692;1490.7763835424773;1491.4258010665756;1494.9327280272414;26267.343316417242;28422.43155136844;28563;28576.57135143016;28686.856565717037;37279.06802329855;37322;37440.81279593694;37448.438273426465;37636;192706;193602;194412;194571;195854;31383;31979.84010079935;32159.03522894317;32265;32730.34539309248;39453.60546394614;39652;39750;39751.60248397595;41004.79497602493;28297;29221.269468263465;30330.848345759012;30435.39129217359;30939.83421160497;29114.27214319659;29235.415291693622;29305;30041.849790750908;30794.846025770625;31520.52719209168;33559;33844.3231135371;33955.830220849726;33980;27145.72854271432;28652;29490.52547372666;29754;33185.33629327352;23660.88169559141;25498.362540936625;25704;25756.356091097874;25835.22494325173 05:29:29 INFO - PID 27038 | |2;jquery.html;554.2849723856226;563.228377123341;563.7857614106639;568.4741614007044;579.9942000579995;21195.894020529897;22250.109995600156;22281;22292.331230063122;22370.664440033393;23913.521729565397;25107.37231569207;26064.60903086455;26241.73758262417;26396.736032639667;6387.840303992414;6537.967310163443;6544.607323560578;6551.541392102555;6552.868942621145;6459.289478157399;6490.4807615390655;6500.187476565429;6504;6509.088727578142;6084.421979911901;6469.191351081115;6487.253965793947;6633.800985970404;6682.532222744409;6679.231888332831;6729.899051514231;6744.9325506745045;6751.527393082486;6762.3237676232475;6635.303293154246;6648.368405001517;6654.168228971379;6668.466522678174;6674.733010679567;29048.70951290481;30517.237069073228;30612.08163755091;30694;30920.072397828102;2013.456366780961;2060.6393881070903;2061.494933741228;2072.108993132952;2073.844461665366;19514.512137196543;19550.80449195504;19783.901080494506;19827.40517784469;19858.60282794336;2452.889619967088;2470.147799009339;2547.337692200041;2559.270607876746;2571.0744132112422;120074.3996280013;122059.77940220574;123832;124207;124222.37888810589;18921.48628109748;20630.896845515676;21034.263800767207;21559.676604850938;22034.33896983093;43138.35292470615;43230.7838460812;43252.1886077404;43374.56625433768;43448;10735.624253151102;10865.891341086646;10934.671959841218;11035.558577656964;11113.110951124052;8925.598348074353;8932.687355942511;8935;8955.686550970684;9064.818703626022;11053;11204.551817927355;11280.774384512264;11403.315801051964;11539.596114135966;2718.8130279369548;2756.3109222694325;2763.281845776578;2803.5093858575074;4217.873463796091;980.3088822380205;991.1426615977127;991.6340167121468;1015.1827778638267;1022.1158697726413;19426.70859937102;19775.703364449546;19916.50208744793;20156.496087597927;20400.489987750425;992;1012.6506355307407;1041.796849614333;1058.25921854702;1068.6900798768424;10779.568817247378;10787;10985.670429887115;11025.558977640805;11078.778424431466;492236;498136;502431;502957;518162;99672.5016374928;99996;102351;102515.48742256241;105794;1163.365965548778;1172.2556176827775;1202.8676845546984;1209.1354681402838;1211.993940030312;16343.264553094901;20159.39521814348;21692.783072169077;21841;21955.121795128016;46065;49346.259806103655;49780.25329619986;50299.49700502948;50319.49680503295;59707.70146149241;60138.39861601503;60307.396926030175;61430.38569614247;61936.69031654813;12973;13108.803367949678;13114.60656180316;13169.275689837152;13175.2753598553;13241.337933103114;13547.187168769906;17191.226394812013;18924.43226703201;19245.326413575458;14306.427742890168;14868;15194.012389194668;15478.226088695745;15493.457728979432;13609.094726738067;13862.861371386158;14138.717225655635;14528.418863245775;15046.473373432314;15237.923810380877;16342.264598092877;16380.180990950166;16397.91801040987;16455;12703.110782245523;12807.935960320512;12827.10210285271;12840.293783841606;12853.93573032129;15950;15982.200889955688;16021;16106.275217615;16144 05:29:29 INFO - PID 27038 | |3;mootools.html;1366.8564800695926;1433.4409580263698;1435.9066660667063;1437.2598111972336;1449.833269174045;12505.187162834409;13156.210627362365;13199.34003299836;13220.933895330521;13223.93388033061;12630.873691263085;12884.484620615187;12912.612621621367;12966.935165324183;13004.34978251086;2333.7666233376654;2360.126753101355;2371.8695471749047;2376.5722170009476;2380.5238952209543;2293.151533932439;2354.3290162303747;2370.277065495023;2383.356493746687;2387.6060450025725;2254.1434254983083;2314.2478694424294;2333.5216280662426;2339.7075365579303;2408.650745641881;2377.3937645900273;2410.8312418130736;2411.397150712322;2413.7706917842775;2414.4567472318586;2290.9656355154684;2305.884705764705;2309.157157637467;2339.94150146246;2344.765523447659;12353.320567368792;12502.187357821713;12537.498500059986;12585.559505417357;12586.559470418582;6937.930620693779;7198.316159964795;7211.387032102278;7217.963910180468;7233.348998590152;3965.20695860829;4074.348104303327;4194.832206711728;4213.894652633678;4236.724612900182;1473.749462591362;1503.1582313904248;1505.396752458639;1545.6522282486462;1558.8752899767992;19449.708254376055;19525.316613918443;19676.40970770879;19725.80274197254;19818.3063592775;5745.569082318842;5797.36229014808;5804.738786754606;5918.644881307136;5945.524358051432;14054;14089.013769036274;14097.36561854719;14101.929490352482;14118;6798;6938.722451102;6938.722451102;6964.26875178099;6999.615021173782;6392.968035159794;6456.644884531396;6462.1276127723095;6548.738050477928;6595.934040659628;4313.762743049162;4452.933206001912;4479.148961697267;4524.366588677588;4528.343390208402;1263.2231177825572;1266.1769849597652;1268.3531398986584;1275.3611609082284;1285.8199852020725;896.5651658945407;908.6138391183721;910.153557191818;952.2572393533055;960.9183219426427;7038.577685338896;7095.077639906883;7273.127224733066;7282.854342913112;7471.70113195477;986.3440811860177;1013.3514550687565;1017.4556612212431;1043.6503771236569;1050.1231471721198;4759.9524004759505;5167.586593072545;5173.974130129325;5290.809567847281;5311.282976798083;16628.3348666052;17270.309187632607;17318;17334.133293335282;17383.826161738474;17318.913405433144;17353.479395618153;17382.217800198767;17416.303347866196;17427.56431089233;9284;9525;9734.805303893883;9865.112139907444;10053.145482633912;7430.777076687708;7620.504667196615;7819.139894611474;8049.39629527776;8361.665533378597;14572.85427145715;15389.153596552296;15511.767323490383;15868.68262634764;15981.600459988593;15085.622859428602;15629.218539072774;15952;16111;16249.59376015609;10310.175185985254;10533.157347412036;10694.73263168427;10773.353598784099;10803.135749140207;12312.692182695504;12316.938415307866;12431.378431078228;12445.439955201857;12446.190997585129;9405.576749046446;9921.751956201153;10065.647702330383;10231.590736370461;10246.333988290737;9682;9863.358881672668;9941.602335906482;10009.649662261785;10106.49467526606;8940.284777217677;9022.909770902206;9041.547922603975;9043.140901614335;9077.092290771134;6172.290186628596;6463.935360646521;6471.158749362553;6495.74017039332;6654.4676425884845;6185.165002724574;6268.091126786681;6406.455451286693;6493.026046093124;6663 05:29:29 INFO - PID 27038 | |4;prototype.html;492.1610655677674;492.3911989919549;517.2448225590638;518.7276679743136;523.4948274914707;6343.936560634393;6368.586041907272;6368.904466433008;6433.710483028269;6455;6099.817005489843;6283.183186185801;6290.339514350996;6297.401746834055;6306.211723534559;5065.772040258188;5089.567386772129;5112.437631860493;5123;5151.742412879341;5099.388073431193;5106.361704786902;5116.820911268106;5126.128558145106;5179.2749015137915;5074.797008119689;5084.211947148198;5088.389393272812;5096.261042148886;5106.668066575679;4880.731559764212;5021.824236151717;5034.622403319729;5054.21659642756;5108.8211912583065;4475.590189090426;4485.680596358704;4505.617022553087;4523.434570678665;4564.589186973189;6155.846103847395;6181.805459062013;6189.81430557084;6191.876162476725;6222.62664240147;5836.708164591796;5839.708014599296;5853.707314634294;5858.531317494633;5868;6615.140031795836;6666.533342666015;6695;6714.462842972599;6726.495512836557;4928.778204980748;4929.359183306147;4930.753462326905;4955.578775804061;4969.4036715594;6977.302269773033;7065.399441047517;7088.291170882871;7089.0075389445;7117.252688467688;5069.619778516626;5097.337346144977;5119.462456442095;5120.769565369567;5121.4622464641425;5191.896162076738;5200.2199670049795;5204.4535323791215;5206.349206349207;5211.843644690665;5838.211841401441;5842.211301474332;5848.5321174305955;5861.794837180678;5865.501432378211;6729.5625784323865;6798;6834.624095674686;6841.213260475109;6861.142357205349;1695.5761059735066;1781.1806568978416;1795.371619933039;1810.7736532933384;1816.400587806021;1219.9878001220052;1225.2587184753097;1242.5713128970672;1246.2273390497949;1262.4129779652505;5729.9713501432225;5731.684757338303;5861.9413805861395;5882.647041177457;5890.204822349014;6852.760153394707;6905.689243983932;6911.7926462206215;6923.965380173167;6956.826079348057;5806.767729290781;5835.252276507636;5850.338096166234;5854.268216472941;5860.296764388216;3630.9818450908106;3648.7810731356203;3654.2775632154217;3658.414653655402;3684.613115622821;6620.437262832713;6653.567518111307;6676.899846502306;6710.664466776641;6723.22682891464;7053.788386348418;7058.9294107059295;7060.505764596532;7067.293270672892;7073.540219885691;6607.603543787388;6620.9006864897065;6642.833929151713;6673.799786006428;6676.332366763382;6777.491688123312;6827.93172068273;6834.316568343324;6841.760538381132;6862.794116176323;6814.2163651180745;6817.8636427270185;6821.317868213139;6822.761203357859;6881.759138430131;6369.9044514333245;6658.533902626769;6658.933410666025;6666.400023997863;6691.498137639599;5012.77442515095;5042.294078828893;5044.0920634286185;5049.38968637426;5065.113605119016;6761.411068398824;6867.931320686929;6928.549644273106;6944.305569443015;6967.651617419007;6557.9344206557325;6615;6644.435223006099;6665.500087493554;6706.497012723968;6564.5076619252795;6648.468122550088;6653.700583473658;6674.632895190811;6695.363940425652;6541.803745887631;6551.44312733423;6551.6069035858;6597.934020659732;6644.534882558174;6713.362230588086;6741.59550426976;6743.538608407994;6756.155480564929;6760.256371799196;6487.286398496068;6490.058941453557;6492.220933488012;6506.186726659168;6530.412262896362 05:29:29 INFO - PID 27038 | |5;yui.html;864.038632304668;873.8601823708206;889.235257678396;890.4612709310867;893.3969570539888;16878.409255676055;17317.82682173178;17373.7393939091;17551.38570150045;20569.588608227827;19806.504837379074;20733.377998660028;20751.481212969684;20802.375928722162;21068.8946555267;983.2969426859794;1037.906588407045;1052.794705032519;1071.314358810362;1075.4300220882944;1090.7982023325671;1090.8581884355024;1096.1450068946235;1096.3915027159924;1097.1223021582741;1137.2266858536193;1143.1197977557276;1143.4054291768275;1143.4397145398736;1145.123980155182;1057.7567159553269;1102.4102105373668;1120.9439528023606;1128.785530749159;1129.1531351486385;811.2455416462687;811.772703642975;813.780279324585;814.5316443045273;815.5147687126209;17465.039422831866;17490.212940417583;17557.473275801618;17563.473095807145;17584.736228956448;18658;19870.503237419034;19924.3026494072;19924.402267931986;20142.597148057102;15192.848071519255;15910.124943128123;15951.042937423792;15963.760543591856;16087.678246435124;3532.8056956867363;3559.1458050068054;3566.6076731559765;3575.0704816747834;3577.2845430913662;100845;103779.481102594;107405;109732.4513377436;110458;14554;15613.765793513106;15835.366585336687;15875;15900;27751;28468.145955621363;28496.715032849406;28712.425751485272;28966;8780.78048048804;8825.602847871733;8852.513111778786;8860.202581767542;8930.330225233134;3766.717496187742;3859.1702783901596;3865.7100717446306;3906.00396898789;4101.938470922939;5502.422245664227;5674.914876276859;5698.145278208219;5698.373178950312;5709.942900571024;1037.2324479884983;1037.2428127466992;1040.1210976724656;1041.6666666666595;1064.989350106489;683.3849535418065;687.1925487552106;696.5507247825226;722.5195245162014;727.6325455644971;11815;12064.75870482603;12068.275903445821;12734.235945843278;12843.48626054966;658.7957733102753;693.4972145194795;713.6253466929903;720.0135813934838;725.7024619905814;5175.249588809676;5534.252875861787;5621.269234999424;5691.7438715257085;5695.316562012585;94852;95665.52167239119;96175;101488.49255753674;101518;87866;89052.5547372259;90050.09949900548;90063.09936900547;91555;71417.28582714107;74043.62978185074;77311;77830.2216977823;77830.6108469454;10368.429736364573;10420.635277765241;10629.94685026601;10748.731281718019;10818.673985093243;33738.49392259069;34472.655273446944;35437.64562354344;35540.644593553734;36184.63815361918;43000.56999429966;43052.13895722131;43563.12873742571;43905;44485.33272000858;16064.43774467888;16078.67842643164;16091.114988675736;16224.107674078039;16405.589860253112;16580.502584922473;16769.66460670804;17332.13339333003;17663.205155767766;17737.37919172823;18795;19505.122269497624;19636;19671;19713.1129099188;18668.90665546718;19670.21319147218;19684.409467715992;19878.403647890587;19964.70052949178;16821.747673785147;17955.102244887963;18076.819231807513;18175.363862264756;18590.25638974426;12963.092583519063;13267.137636053625;13634.549771544058;13834;13975.510857119953;13945.511907083204;14275.286235688382;14695.11829290246;15007.624809379853;15056.924715376792 05:29:29 INFO - PID 27038 | __end_tp_report 05:29:29 INFO - PID 27038 | __start_cc_report 05:29:29 INFO - PID 27038 | _x_x_mozilla_cycle_collect,385 05:29:29 INFO - PID 27038 | __end_cc_report 05:29:29 INFO - PID 27038 | __startTimestamp1497875369507__endTimestamp 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | ------- Summary: start ------- 05:29:29 INFO - PID 27038 | Number of tests: 6 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#0] dojo.html Cycles:165 Average:6103.55 Median:6346.00 stddev:730.49 (11.5%) stddev-sans-first:692.86 05:29:29 INFO - PID 27038 | Values: 3068.9 3098.2 3109.8 3116.0 3122.8 6045.9 6092.6 6120.0 6126.9 6131.7 6016.1 6124.7 6145.8 6165.3 6165.7 5710.4 5711.8 5756.4 5765.6 5788.9 5739.7 5781.0 5822.2 5850.4 5851.7 5516.7 5597.9 5684.7 5703.8 5707.1 5587.5 5600.5 5631.2 5686.6 5699.9 5587.6 5619.6 5620.6 5665.2 5671.2 6095.8 6123.8 6136.3 6140.3 6143.1 6587.4 6607.1 6607.9 6643.3 6689.9 6536.6 6551.9 6614.4 6630.8 6653.0 6177.9 6222.3 6241.1 6259.1 6263.8 6886.9 6888.8 6894.2 6895.9 6917.5 6273.4 6354.1 6372.7 6379.7 6380.1 6482.9 6548.4 6569.9 6619.3 6658.6 6589.9 6655.8 6667.9 6688.6 6689.0 6601.4 6667.9 6675.8 6676.6 6682.4 5331.1 5346.6 5364.5 5370.2 5384.1 4410.3 4412.0 4421.4 4470.3 4480.6 5751.1 5767.6 5801.3 5869.2 5887.3 6714.9 6715.8 6730.6 6735.0 6749.4 5807.1 5807.9 5809.0 5828.2 5833.2 5890.4 5898.7 5905.1 5911.5 5918.0 6292.2 6358.4 6378.4 6378.6 6488.5 6663.4 6665.2 6689.0 6721.9 6731.1 6440.2 6467.2 6499.0 6514.1 6514.3 6521.5 6536.7 6548.9 6560.5 6570.2 6522.6 6710.0 6736.5 6740.7 6772.6 6327.1 6364.7 6364.9 6427.6 6433.1 6367.9 6441.4 6459.1 6463.6 6480.1 6354.9 6355.5 6397.4 6405.8 6421.5 6382.9 6453.4 6551.8 6552.0 6561.0 6236.2 6277.7 6327.6 6335.7 6346.0 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#1] ext.html Cycles:180 Average:36326.68 Median:32497.43 stddev:51979.63 (159.9%) stddev-sans-first:52057.02 05:29:29 INFO - PID 27038 | Values: 806.8 816.9 851.1 864.7 874.9 39614.6 40279.2 40428.8 40611.6 40656.8 36068.0 36329.8 36503.3 36573.0 36611.5 6814.8 6958.3 6992.0 6993.2 7003.5 6855.2 6857.0 6909.5 6944.9 6965.6 6870.7 6872.7 6911.0 6923.5 6924.1 6878.2 6881.9 6896.9 6916.0 6926.4 6245.3 6264.1 6288.6 6293.3 6320.9 32302.8 32431.2 32563.7 32812.8 32846.2 3286.7 3332.9 3338.7 3541.5 3603.5 29932.6 30033.0 30202.7 30211.0 30235.0 3661.4 3728.7 3733.4 3750.6 3753.2 178356.0 180150.0 185915.0 186622.0 187481.0 41539.2 47655.5 47756.8 47815.8 47829.0 50249.5 50293.7 50490.0 50508.5 50878.7 14915.9 15176.3 15186.4 15198.8 15203.5 12187.2 12295.8 12299.1 12299.3 12319.9 13943.3 14078.8 14126.5 14134.3 14214.3 5722.7 5772.5 5891.3 5912.8 5919.2 1008.9 1022.9 1034.6 1040.1 1060.5 22282.8 22932.0 22995.0 23139.3 23241.2 1100.1 1102.2 1132.7 1134.8 1142.4 12197.4 16287.5 16655.4 16727.8 16908.4 220239.0 221511.0 221608.0 222375.0 224036.0 53855.0 54485.0 54490.0 54592.0 54696.0 1415.1 1463.9 1490.8 1491.4 1494.9 26267.3 28422.4 28563.0 28576.6 28686.9 37279.1 37322.0 37440.8 37448.4 37636.0 192706.0 193602.0 194412.0 194571.0 195854.0 31383.0 31979.8 32159.0 32265.0 32730.3 39453.6 39652.0 39750.0 39751.6 41004.8 28297.0 29221.3 30330.8 30435.4 30939.8 29114.3 29235.4 29305.0 30041.8 30794.8 31520.5 33559.0 33844.3 33955.8 33980.0 27145.7 28652.0 29490.5 29754.0 33185.3 23660.9 25498.4 25704.0 25756.4 25835.2 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#2] jquery.html Cycles:180 Average:34167.01 Median:21626.23 stddev:83615.42 (386.6%) stddev-sans-first:83811.89 05:29:29 INFO - PID 27038 | Values: 554.3 563.2 563.8 568.5 580.0 21195.9 22250.1 22281.0 22292.3 22370.7 23913.5 25107.4 26064.6 26241.7 26396.7 6387.8 6538.0 6544.6 6551.5 6552.9 6459.3 6490.5 6500.2 6504.0 6509.1 6084.4 6469.2 6487.3 6633.8 6682.5 6679.2 6729.9 6744.9 6751.5 6762.3 6635.3 6648.4 6654.2 6668.5 6674.7 29048.7 30517.2 30612.1 30694.0 30920.1 2013.5 2060.6 2061.5 2072.1 2073.8 19514.5 19550.8 19783.9 19827.4 19858.6 2452.9 2470.1 2547.3 2559.3 2571.1 120074.4 122059.8 123832.0 124207.0 124222.4 18921.5 20630.9 21034.3 21559.7 22034.3 43138.4 43230.8 43252.2 43374.6 43448.0 10735.6 10865.9 10934.7 11035.6 11113.1 8925.6 8932.7 8935.0 8955.7 9064.8 11053.0 11204.6 11280.8 11403.3 11539.6 2718.8 2756.3 2763.3 2803.5 4217.9 980.3 991.1 991.6 1015.2 1022.1 19426.7 19775.7 19916.5 20156.5 20400.5 992.0 1012.7 1041.8 1058.3 1068.7 10779.6 10787.0 10985.7 11025.6 11078.8 492236.0 498136.0 502431.0 502957.0 518162.0 99672.5 99996.0 102351.0 102515.5 105794.0 1163.4 1172.3 1202.9 1209.1 1212.0 16343.3 20159.4 21692.8 21841.0 21955.1 46065.0 49346.3 49780.3 50299.5 50319.5 59707.7 60138.4 60307.4 61430.4 61936.7 12973.0 13108.8 13114.6 13169.3 13175.3 13241.3 13547.2 17191.2 18924.4 19245.3 14306.4 14868.0 15194.0 15478.2 15493.5 13609.1 13862.9 14138.7 14528.4 15046.5 15237.9 16342.3 16380.2 16397.9 16455.0 12703.1 12807.9 12827.1 12840.3 12853.9 15950.0 15982.2 16021.0 16106.3 16144.0 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#3] mootools.html Cycles:180 Average:7935.76 Median:2349.55 stddev:5307.84 (225.9%) stddev-sans-first:5299.78 05:29:29 INFO - PID 27038 | Values: 1366.9 1433.4 1435.9 1437.3 1449.8 12505.2 13156.2 13199.3 13220.9 13223.9 12630.9 12884.5 12912.6 12966.9 13004.3 2333.8 2360.1 2371.9 2376.6 2380.5 2293.2 2354.3 2370.3 2383.4 2387.6 2254.1 2314.2 2333.5 2339.7 2408.7 2377.4 2410.8 2411.4 2413.8 2414.5 2291.0 2305.9 2309.2 2339.9 2344.8 12353.3 12502.2 12537.5 12585.6 12586.6 6937.9 7198.3 7211.4 7218.0 7233.3 3965.2 4074.3 4194.8 4213.9 4236.7 1473.7 1503.2 1505.4 1545.7 1558.9 19449.7 19525.3 19676.4 19725.8 19818.3 5745.6 5797.4 5804.7 5918.6 5945.5 14054.0 14089.0 14097.4 14101.9 14118.0 6798.0 6938.7 6938.7 6964.3 6999.6 6393.0 6456.6 6462.1 6548.7 6595.9 4313.8 4452.9 4479.1 4524.4 4528.3 1263.2 1266.2 1268.4 1275.4 1285.8 896.6 908.6 910.2 952.3 960.9 7038.6 7095.1 7273.1 7282.9 7471.7 986.3 1013.4 1017.5 1043.7 1050.1 4760.0 5167.6 5174.0 5290.8 5311.3 16628.3 17270.3 17318.0 17334.1 17383.8 17318.9 17353.5 17382.2 17416.3 17427.6 9284.0 9525.0 9734.8 9865.1 10053.1 7430.8 7620.5 7819.1 8049.4 8361.7 14572.9 15389.2 15511.8 15868.7 15981.6 15085.6 15629.2 15952.0 16111.0 16249.6 10310.2 10533.2 10694.7 10773.4 10803.1 12312.7 12316.9 12431.4 12445.4 12446.2 9405.6 9921.8 10065.6 10231.6 10246.3 9682.0 9863.4 9941.6 10009.6 10106.5 8940.3 9022.9 9041.5 9043.1 9077.1 6172.3 6463.9 6471.2 6495.7 6654.5 6185.2 6268.1 6406.5 6493.0 6663.0 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#4] prototype.html Cycles:180 Average:5629.51 Median:6252.90 stddev:1587.74 (25.4%) stddev-sans-first:1544.66 05:29:29 INFO - PID 27038 | Values: 492.2 492.4 517.2 518.7 523.5 6343.9 6368.6 6368.9 6433.7 6455.0 6099.8 6283.2 6290.3 6297.4 6306.2 5065.8 5089.6 5112.4 5123.0 5151.7 5099.4 5106.4 5116.8 5126.1 5179.3 5074.8 5084.2 5088.4 5096.3 5106.7 4880.7 5021.8 5034.6 5054.2 5108.8 4475.6 4485.7 4505.6 4523.4 4564.6 6155.8 6181.8 6189.8 6191.9 6222.6 5836.7 5839.7 5853.7 5858.5 5868.0 6615.1 6666.5 6695.0 6714.5 6726.5 4928.8 4929.4 4930.8 4955.6 4969.4 6977.3 7065.4 7088.3 7089.0 7117.3 5069.6 5097.3 5119.5 5120.8 5121.5 5191.9 5200.2 5204.5 5206.3 5211.8 5838.2 5842.2 5848.5 5861.8 5865.5 6729.6 6798.0 6834.6 6841.2 6861.1 1695.6 1781.2 1795.4 1810.8 1816.4 1220.0 1225.3 1242.6 1246.2 1262.4 5730.0 5731.7 5861.9 5882.6 5890.2 6852.8 6905.7 6911.8 6924.0 6956.8 5806.8 5835.3 5850.3 5854.3 5860.3 3631.0 3648.8 3654.3 3658.4 3684.6 6620.4 6653.6 6676.9 6710.7 6723.2 7053.8 7058.9 7060.5 7067.3 7073.5 6607.6 6620.9 6642.8 6673.8 6676.3 6777.5 6827.9 6834.3 6841.8 6862.8 6814.2 6817.9 6821.3 6822.8 6881.8 6369.9 6658.5 6658.9 6666.4 6691.5 5012.8 5042.3 5044.1 5049.4 5065.1 6761.4 6867.9 6928.5 6944.3 6967.7 6557.9 6615.0 6644.4 6665.5 6706.5 6564.5 6648.5 6653.7 6674.6 6695.4 6541.8 6551.4 6551.6 6597.9 6644.5 6713.4 6741.6 6743.5 6756.2 6760.3 6487.3 6490.1 6492.2 6506.2 6530.4 05:29:29 INFO - PID 27038 | 05:29:29 INFO - PID 27038 | [#5] yui.html Cycles:180 Average:21154.35 Median:19670.61 stddev:27453.06 (139.6%) stddev-sans-first:27487.80 05:29:29 INFO - PID 27038 | Values: 864.0 873.9 889.2 890.5 893.4 16878.4 17317.8 17373.7 17551.4 20569.6 19806.5 20733.4 20751.5 20802.4 21068.9 983.3 1037.9 1052.8 1071.3 1075.4 1090.8 1090.9 1096.1 1096.4 1097.1 1137.2 1143.1 1143.4 1143.4 1145.1 1057.8 1102.4 1120.9 1128.8 1129.2 811.2 811.8 813.8 814.5 815.5 17465.0 17490.2 17557.5 17563.5 17584.7 18658.0 19870.5 19924.3 19924.4 20142.6 15192.8 15910.1 15951.0 15963.8 16087.7 3532.8 3559.1 3566.6 3575.1 3577.3 100845.0 103779.5 107405.0 109732.5 110458.0 14554.0 15613.8 15835.4 15875.0 15900.0 27751.0 28468.1 28496.7 28712.4 28966.0 8780.8 8825.6 8852.5 8860.2 8930.3 3766.7 3859.2 3865.7 3906.0 4101.9 5502.4 5674.9 5698.1 5698.4 5709.9 1037.2 1037.2 1040.1 1041.7 1065.0 683.4 687.2 696.6 722.5 727.6 11815.0 12064.8 12068.3 12734.2 12843.5 658.8 693.5 713.6 720.0 725.7 5175.2 5534.3 5621.3 5691.7 5695.3 94852.0 95665.5 96175.0 101488.5 101518.0 87866.0 89052.6 90050.1 90063.1 91555.0 71417.3 74043.6 77311.0 77830.2 77830.6 10368.4 10420.6 10629.9 10748.7 10818.7 33738.5 34472.7 35437.6 35540.6 36184.6 43000.6 43052.1 43563.1 43905.0 44485.3 16064.4 16078.7 16091.1 16224.1 16405.6 16580.5 16769.7 17332.1 17663.2 17737.4 18795.0 19505.1 19636.0 19671.0 19713.1 18668.9 19670.2 19684.4 19878.4 19964.7 16821.7 17955.1 18076.8 18175.4 18590.3 12963.1 13267.1 13634.5 13834.0 13975.5 13945.5 14275.3 14695.1 15007.6 15056.9 05:29:29 INFO - PID 27038 | -------- Summary: end -------- 05:29:29 INFO - PID 27038 | 05:29:30 INFO - TEST-INFO | 27038: exit 0 05:29:30 INFO - TEST-OK | dromaeo_css | took 1117462ms 05:29:30 INFO - TEST-START | kraken 05:29:30 INFO - operating with platform_type : linux_ 05:29:30 INFO - Initialising browser for kraken test... 05:29:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42338/getInfo.html -profile /tmp/tmpOIsko2/profile 05:29:30 INFO - TEST-INFO | started process 27440 (/builds/slave/test/build/application/firefox/firefox http://localhost:42338/getInfo.html) 05:29:36 INFO - TEST-INFO | 27440: exit 0 05:29:36 INFO - Browser initialized. 05:29:36 INFO - Running cycle 1/1 for kraken test... 05:29:36 INFO - TEST-INFO | started process 27650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIsko2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:48 INFO - PID 27650 | RSS: Main: 175476736 05:29:48 INFO - PID 27650 | 05:29:51 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42338/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:51 INFO - PID 27650 | RSS: Main: 179027968 05:29:51 INFO - PID 27650 | 05:29:54 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42338/tests/kraken/driver.html?testName=audio-dft) 05:29:55 INFO - PID 27650 | RSS: Main: 179871744 05:29:55 INFO - PID 27650 | 05:29:58 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42338/tests/kraken/driver.html?testName=audio-fft) 05:29:58 INFO - PID 27650 | RSS: Main: 175595520 05:29:58 INFO - PID 27650 | 05:30:01 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42338/tests/kraken/driver.html?testName=audio-oscillator) 05:30:01 INFO - PID 27650 | RSS: Main: 176418816 05:30:01 INFO - PID 27650 | 05:30:03 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:04 INFO - PID 27650 | RSS: Main: 176525312 05:30:04 INFO - PID 27650 | 05:30:07 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42338/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:08 INFO - PID 27650 | RSS: Main: 180019200 05:30:08 INFO - PID 27650 | 05:30:11 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42338/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:12 INFO - PID 27650 | RSS: Main: 179601408 05:30:12 INFO - PID 27650 | 05:30:15 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42338/tests/kraken/driver.html?testName=json-parse-financial) 05:30:15 INFO - PID 27650 | RSS: Main: 180084736 05:30:15 INFO - PID 27650 | 05:30:17 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:17 INFO - PID 27650 | RSS: Main: 180658176 05:30:17 INFO - PID 27650 | 05:30:19 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:20 INFO - PID 27650 | RSS: Main: 180342784 05:30:20 INFO - PID 27650 | 05:30:22 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:22 INFO - PID 27650 | RSS: Main: 180297728 05:30:22 INFO - PID 27650 | 05:30:25 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:26 INFO - PID 27650 | RSS: Main: 180592640 05:30:26 INFO - PID 27650 | 05:30:29 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:30 INFO - PID 27650 | RSS: Main: 180379648 05:30:30 INFO - PID 27650 | 05:30:31 INFO - PID 27650 | Cycle 1(1): loaded http://localhost:42338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42338/tests/kraken/driver.html?testName=ai-astar) 05:30:32 INFO - PID 27650 | RSS: Main: 181645312 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | __start_tp_report 05:30:32 INFO - PID 27650 | _x_x_mozilla_page_load 05:30:32 INFO - PID 27650 | _x_x_mozilla_page_load_details 05:30:32 INFO - PID 27650 | |i|pagename|runs| 05:30:32 INFO - PID 27650 | |0;ai-astar;101;107;108;107;113;115;107;110;108;110 05:30:32 INFO - PID 27650 | |1;audio-beat-detection;154;126;158;181;122;155;172;121;175;128 05:30:32 INFO - PID 27650 | |2;audio-dft;166;164;164;162;165;169;168;170;168;165 05:30:32 INFO - PID 27650 | |3;audio-fft;75;77;76;171;76;76;74;74;95;75 05:30:32 INFO - PID 27650 | |4;audio-oscillator;82;82;139;88;83;83;150;85;83;138 05:30:32 INFO - PID 27650 | |5;imaging-gaussian-blur;115;118;115;114;115;113;115;114;113;114 05:30:32 INFO - PID 27650 | |6;imaging-darkroom;150;151;151;152;151;151;151;154;153;151 05:30:32 INFO - PID 27650 | |7;imaging-desaturate;95;95;94;95;95;96;96;95;95;95 05:30:32 INFO - PID 27650 | |8;json-parse-financial;53;54;55;53;54;52;54;57;54;53 05:30:32 INFO - PID 27650 | |9;json-stringify-tinderbox;54;54;53;55;55;53;54;55;56;54 05:30:32 INFO - PID 27650 | |10;stanford-crypto-aes;76;88;77;77;86;78;78;78;79;78 05:30:32 INFO - PID 27650 | |11;stanford-crypto-ccm;128;135;136;128;135;138;131;137;136;147 05:30:32 INFO - PID 27650 | |12;stanford-crypto-pbkdf2;199;189;181;183;188;195;185;197;188;179 05:30:32 INFO - PID 27650 | |13;stanford-crypto-sha256-iterative;72;74;71;70;71;69;69;69;70;71 05:30:32 INFO - PID 27650 | __end_tp_report 05:30:32 INFO - PID 27650 | __start_cc_report 05:30:32 INFO - PID 27650 | _x_x_mozilla_cycle_collect,969 05:30:32 INFO - PID 27650 | __end_cc_report 05:30:32 INFO - PID 27650 | __startTimestamp1497875432155__endTimestamp 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | ------- Summary: start ------- 05:30:32 INFO - PID 27650 | Number of tests: 14 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:3.81 (3.5%) stddev-sans-first:2.88 05:30:32 INFO - PID 27650 | Values: 101.0 107.0 108.0 107.0 113.0 115.0 107.0 110.0 108.0 110.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:156.50 stddev:23.22 (14.8%) stddev-sans-first:24.57 05:30:32 INFO - PID 27650 | Values: 154.0 126.0 158.0 181.0 122.0 155.0 172.0 121.0 175.0 128.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#2] audio-dft Cycles:10 Average:166.10 Median:167.00 stddev:2.56 (1.5%) stddev-sans-first:2.71 05:30:32 INFO - PID 27650 | Values: 166.0 164.0 164.0 162.0 165.0 169.0 168.0 170.0 168.0 165.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#3] audio-fft Cycles:10 Average:86.90 Median:76.00 stddev:30.20 (39.7%) stddev-sans-first:31.72 05:30:32 INFO - PID 27650 | Values: 75.0 77.0 76.0 171.0 76.0 76.0 74.0 74.0 95.0 75.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:83.00 stddev:28.54 (34.4%) stddev-sans-first:29.41 05:30:32 INFO - PID 27650 | Values: 82.0 82.0 139.0 88.0 83.0 83.0 150.0 85.0 83.0 138.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.43 (1.2%) stddev-sans-first:1.51 05:30:32 INFO - PID 27650 | Values: 115.0 118.0 115.0 114.0 115.0 113.0 115.0 114.0 113.0 114.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:1.18 (0.8%) stddev-sans-first:1.12 05:30:32 INFO - PID 27650 | Values: 150.0 151.0 151.0 152.0 151.0 151.0 151.0 154.0 153.0 151.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:30:32 INFO - PID 27650 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.37 (2.5%) stddev-sans-first:1.41 05:30:32 INFO - PID 27650 | Values: 53.0 54.0 55.0 53.0 54.0 52.0 54.0 57.0 54.0 53.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:1.00 05:30:32 INFO - PID 27650 | Values: 54.0 54.0 53.0 55.0 55.0 53.0 54.0 55.0 56.0 54.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.00 stddev:4.06 (5.2%) stddev-sans-first:4.11 05:30:32 INFO - PID 27650 | Values: 76.0 88.0 77.0 77.0 86.0 78.0 78.0 78.0 79.0 78.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:136.00 stddev:5.51 (4.0%) stddev-sans-first:5.21 05:30:32 INFO - PID 27650 | Values: 128.0 135.0 136.0 128.0 135.0 138.0 131.0 137.0 136.0 147.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.40 Median:188.50 stddev:6.79 (3.6%) stddev-sans-first:6.02 05:30:32 INFO - PID 27650 | Values: 199.0 189.0 181.0 183.0 188.0 195.0 185.0 197.0 188.0 179.0 05:30:32 INFO - PID 27650 | 05:30:32 INFO - PID 27650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.59 05:30:32 INFO - PID 27650 | Values: 72.0 74.0 71.0 70.0 71.0 69.0 69.0 69.0 70.0 71.0 05:30:32 INFO - PID 27650 | -------- Summary: end -------- 05:30:32 INFO - PID 27650 | 05:30:33 INFO - TEST-INFO | 27650: exit 0 05:30:33 INFO - TEST-OK | kraken | took 62876ms 05:30:33 INFO - SUITE-END | took 1180s 05:30:33 INFO - Completed test suite (00:19:40) 05:30:33 INFO - javascript benchmark 05:30:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8248.741697625015, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.9386212275767, 3098.163495856119, 3109.797863138896, 3116.0340294508705, 3122.765792565558, 6045.941960156972, 6092.573519853601, 6119.9595720210555, 6126.853582554522, 6131.693415329238, 6016.067509536029, 6124.683193113479, 6145.832291864543, 6165.290991535975, 6165.691715414223, 5710.371859095496, 5711.8000869969555, 5756.424357564252, 5765.596408251424, 5788.884222315552, 5739.741711622966, 5781.0, 5822.214001109859, 5850.444207800273, 5851.736671849756, 5516.696581688006, 5597.916031259534, 5684.687342196177, 5703.828885133411, 5707.086866101404, 5587.497125258747, 5600.52395546379, 5631.18347839561, 5686.5735069869925, 5699.857503562403, 5587.552995760329, 5619.578531610146, 5620.5503559715125, 5665.1502274658715, 5671.234383358235, 6095.786647467362, 6123.8162855114415, 6136.294326152461, 6140.324564297968, 6143.139960405547, 6587.374199451045, 6607.075009498674, 6607.900881486781, 6643.335666433366, 6689.8662026759675, 6536.607803531756, 6551.93448065518, 6614.404703576702, 6630.801075967729, 6653.002049692536, 6177.938220617736, 6222.315545290015, 6241.095041218998, 6259.0924315973925, 6263.843403914848, 6886.896696549556, 6888.758893438706, 6894.172699276119, 6895.931040689629, 6917.481188910851, 6273.435390814758, 6354.110424540568, 6372.74509019634, 6379.744810207632, 6380.106785050097, 6482.935170648328, 6548.410643042053, 6569.868602627921, 6619.304972977864, 6658.6337751424135, 6589.934100658932, 6655.800325990228, 6667.933320666828, 6688.632125233062, 6688.966555167291, 6601.405873471411, 6667.86664266712, 6675.766348177791, 6676.632785196861, 6682.398584127452, 5331.1470164773455, 5346.572274218053, 5364.463553644604, 5370.167624018283, 5384.138537833927, 4410.25025745624, 4411.955880441219, 4421.447319085114, 4470.307102399133, 4480.641548676098, 5751.079827227623, 5767.596268261182, 5801.274840644919, 5869.236999190078, 5887.322957859901, 6714.865702686016, 6715.798526044129, 6730.596164230162, 6734.966325168343, 6749.42629876466, 5807.128930660435, 5807.88384232313, 5808.970955145197, 5828.213191219216, 5833.241678581757, 5890.410958904075, 5898.705064746746, 5905.1142328650185, 5911.497522710618, 5917.970410147922, 6292.244930608356, 6358.395952384516, 6378.425941665272, 6378.649174295459, 6488.480921526267, 6663.400293973566, 6665.200175978914, 6688.966555167193, 6721.93278067213, 6731.091302674076, 6440.162778838721, 6467.223933128054, 6499.025146228104, 6514.120593719787, 6514.315996820265, 6521.543491955517, 6536.6731663415685, 6548.869022619616, 6560.475161986934, 6570.244421891352, 6522.5760325578685, 6709.993500974698, 6736.528443008942, 6740.730370785113, 6772.55978361405, 6327.050942358683, 6364.713587888648, 6364.872702546016, 6427.55007149495, 6433.067205255305, 6367.87264254703, 6441.3880681335195, 6459.095726598374, 6463.612183269019, 6480.060391243338, 6354.93645063562, 6355.523335749745, 6397.360263973565, 6405.775797847053, 6421.454176395058, 6382.936170638234, 6453.419192272718, 6551.80344589663, 6552.049952756919, 6560.967195163994, 6236.220472440945, 6277.74889004453, 6327.588706734047, 6335.746570137143, 6346.0], "value": 6047.4019057706855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.7620052084634, 816.9019717633885, 851.0595791650227, 864.6671031652812, 874.8687696845476, 39614.60385396145, 40279.19441611166, 40428.79785601075, 40611.59388406115, 40656.796716016455, 36068.0, 36329.818350908274, 36503.26993460129, 36573.0, 36611.4508282376, 6814.761483348071, 6958.304169583026, 6992.0, 6993.230744618088, 7003.509754317174, 6855.177378714537, 6856.965715171417, 6909.516333856632, 6944.861102777942, 6965.616891070989, 6870.656467176646, 6872.656367181621, 6910.965445172767, 6923.480738944574, 6924.099867017306, 6878.209005964303, 6881.896771548406, 6896.862017767063, 6916.0, 6926.411255043327, 6245.3442388549, 6264.091706702548, 6288.559800813945, 6293.2762732285455, 6320.93679063208, 32302.838485807657, 32431.189220269684, 32563.6743632563, 32812.8359358204, 32846.17884552881, 3286.720628746559, 3332.8833490827706, 3338.7329013678846, 3541.4687796830426, 3603.5135256740527, 29932.551011734842, 30033.0, 30202.69797302043, 30211.0, 30235.0, 3661.359262129117, 3728.720345974036, 3733.383991641376, 3750.587435382106, 3753.2118255166447, 178356.0, 180150.0, 185915.0, 186622.0, 187480.99999999863, 41539.1692166155, 47655.5234447658, 47756.7612161937, 47815.76092119587, 47829.0, 50249.49750502521, 50293.74853125711, 50490.0, 50508.49491505112, 50878.675312598105, 14915.850841491447, 15176.317065732068, 15186.392544298325, 15198.848011519744, 15203.467878624417, 12187.207831490925, 12295.815562766566, 12299.139060265696, 12299.323537205539, 12319.938400307941, 13943.302834858216, 14078.788818167735, 14126.50557230492, 14134.293285335692, 14214.28928553589, 5722.656640601577, 5772.480476757112, 5891.263592050994, 5912.836632401644, 5919.200907877467, 1008.8537162111453, 1022.897710228986, 1034.6430481484026, 1040.105509262034, 1060.5015642648098, 22282.777172228394, 22932.0, 22995.0, 23139.3058208254, 23241.186558470712, 1100.1034157161887, 1102.2009043443438, 1132.7394699219226, 1134.8241022641503, 1142.360278244186, 12197.39013049344, 16287.51137465878, 16655.41706040283, 16727.83272167263, 16908.40820571274, 220239.0, 221511.0, 221608.0, 222375.0, 224036.0, 53855.0, 54485.0, 54490.0, 54592.0, 54696.0, 1415.0872687116753, 1463.9341229644692, 1490.7763835424773, 1491.4258010665756, 1494.9327280272414, 26267.343316417242, 28422.43155136844, 28563.0, 28576.57135143016, 28686.856565717037, 37279.06802329855, 37322.0, 37440.81279593694, 37448.438273426465, 37636.0, 192706.0, 193602.0, 194412.0, 194571.0, 195854.0, 31383.0, 31979.84010079935, 32159.03522894317, 32265.0, 32730.34539309248, 39453.60546394614, 39652.0, 39750.0, 39751.60248397595, 41004.79497602493, 28297.0, 29221.269468263465, 30330.848345759012, 30435.39129217359, 30939.83421160497, 29114.27214319659, 29235.415291693622, 29305.0, 30041.849790750908, 30794.846025770625, 31520.52719209168, 33559.0, 33844.3231135371, 33955.830220849726, 33980.0, 27145.72854271432, 28652.0, 29490.52547372666, 29754.0, 33185.33629327352, 23660.88169559141, 25498.362540936625, 25704.0, 25756.356091097874, 25835.22494325173], "value": 16473.645824905932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2849723856226, 563.228377123341, 563.7857614106639, 568.4741614007044, 579.9942000579995, 21195.894020529897, 22250.109995600156, 22281.0, 22292.331230063122, 22370.664440033393, 23913.521729565397, 25107.37231569207, 26064.60903086455, 26241.73758262417, 26396.736032639667, 6387.840303992414, 6537.967310163443, 6544.607323560578, 6551.541392102555, 6552.868942621145, 6459.289478157399, 6490.4807615390655, 6500.187476565429, 6504.0, 6509.088727578142, 6084.421979911901, 6469.191351081115, 6487.253965793947, 6633.800985970404, 6682.532222744409, 6679.231888332831, 6729.899051514231, 6744.9325506745045, 6751.527393082486, 6762.3237676232475, 6635.303293154246, 6648.368405001517, 6654.168228971379, 6668.466522678174, 6674.733010679567, 29048.70951290481, 30517.237069073228, 30612.08163755091, 30694.0, 30920.072397828102, 2013.456366780961, 2060.6393881070903, 2061.494933741228, 2072.108993132952, 2073.844461665366, 19514.512137196543, 19550.80449195504, 19783.901080494506, 19827.40517784469, 19858.60282794336, 2452.889619967088, 2470.147799009339, 2547.337692200041, 2559.270607876746, 2571.0744132112422, 120074.3996280013, 122059.77940220574, 123832.0, 124207.0, 124222.37888810589, 18921.48628109748, 20630.896845515676, 21034.263800767207, 21559.676604850938, 22034.33896983093, 43138.35292470615, 43230.7838460812, 43252.1886077404, 43374.56625433768, 43448.0, 10735.624253151102, 10865.891341086646, 10934.671959841218, 11035.558577656964, 11113.110951124052, 8925.598348074353, 8932.687355942511, 8935.0, 8955.686550970684, 9064.818703626022, 11053.0, 11204.551817927355, 11280.774384512264, 11403.315801051964, 11539.596114135966, 2718.8130279369548, 2756.3109222694325, 2763.281845776578, 2803.5093858575074, 4217.873463796091, 980.3088822380205, 991.1426615977127, 991.6340167121468, 1015.1827778638267, 1022.1158697726413, 19426.70859937102, 19775.703364449546, 19916.50208744793, 20156.496087597927, 20400.489987750425, 992.0, 1012.6506355307407, 1041.796849614333, 1058.25921854702, 1068.6900798768424, 10779.568817247378, 10787.0, 10985.670429887115, 11025.558977640805, 11078.778424431466, 492236.0, 498136.0, 502431.0, 502957.0, 518162.0, 99672.5016374928, 99996.0, 102351.0, 102515.48742256241, 105794.0, 1163.365965548778, 1172.2556176827775, 1202.8676845546984, 1209.1354681402838, 1211.993940030312, 16343.264553094901, 20159.39521814348, 21692.783072169077, 21841.0, 21955.121795128016, 46065.0, 49346.259806103655, 49780.25329619986, 50299.49700502948, 50319.49680503295, 59707.70146149241, 60138.39861601503, 60307.396926030175, 61430.38569614247, 61936.69031654813, 12973.0, 13108.803367949678, 13114.60656180316, 13169.275689837152, 13175.2753598553, 13241.337933103114, 13547.187168769906, 17191.226394812013, 18924.43226703201, 19245.326413575458, 14306.427742890168, 14868.0, 15194.012389194668, 15478.226088695745, 15493.457728979432, 13609.094726738067, 13862.861371386158, 14138.717225655635, 14528.418863245775, 15046.473373432314, 15237.923810380877, 16342.264598092877, 16380.180990950166, 16397.91801040987, 16455.0, 12703.110782245523, 12807.935960320512, 12827.10210285271, 12840.293783841606, 12853.93573032129, 15950.0, 15982.200889955688, 16021.0, 16106.275217615, 16144.0], "value": 11938.175865238603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.8564800695926, 1433.4409580263698, 1435.9066660667063, 1437.2598111972336, 1449.833269174045, 12505.187162834409, 13156.210627362365, 13199.34003299836, 13220.933895330521, 13223.93388033061, 12630.873691263085, 12884.484620615187, 12912.612621621367, 12966.935165324183, 13004.34978251086, 2333.7666233376654, 2360.126753101355, 2371.8695471749047, 2376.5722170009476, 2380.5238952209543, 2293.151533932439, 2354.3290162303747, 2370.277065495023, 2383.356493746687, 2387.6060450025725, 2254.1434254983083, 2314.2478694424294, 2333.5216280662426, 2339.7075365579303, 2408.650745641881, 2377.3937645900273, 2410.8312418130736, 2411.397150712322, 2413.7706917842775, 2414.4567472318586, 2290.9656355154684, 2305.884705764705, 2309.157157637467, 2339.94150146246, 2344.765523447659, 12353.320567368792, 12502.187357821713, 12537.498500059986, 12585.559505417357, 12586.559470418582, 6937.930620693779, 7198.316159964795, 7211.387032102278, 7217.963910180468, 7233.348998590152, 3965.20695860829, 4074.348104303327, 4194.832206711728, 4213.894652633678, 4236.724612900182, 1473.749462591362, 1503.1582313904248, 1505.396752458639, 1545.6522282486462, 1558.8752899767992, 19449.708254376055, 19525.316613918443, 19676.40970770879, 19725.80274197254, 19818.3063592775, 5745.569082318842, 5797.36229014808, 5804.738786754606, 5918.644881307136, 5945.524358051432, 14054.0, 14089.013769036274, 14097.36561854719, 14101.929490352482, 14118.0, 6798.0, 6938.722451102, 6938.722451102, 6964.26875178099, 6999.615021173782, 6392.968035159794, 6456.644884531396, 6462.1276127723095, 6548.738050477928, 6595.934040659628, 4313.762743049162, 4452.933206001912, 4479.148961697267, 4524.366588677588, 4528.343390208402, 1263.2231177825572, 1266.1769849597652, 1268.3531398986584, 1275.3611609082284, 1285.8199852020725, 896.5651658945407, 908.6138391183721, 910.153557191818, 952.2572393533055, 960.9183219426427, 7038.577685338896, 7095.077639906883, 7273.127224733066, 7282.854342913112, 7471.70113195477, 986.3440811860177, 1013.3514550687565, 1017.4556612212431, 1043.6503771236569, 1050.1231471721198, 4759.9524004759505, 5167.586593072545, 5173.974130129325, 5290.809567847281, 5311.282976798083, 16628.3348666052, 17270.309187632607, 17318.0, 17334.133293335282, 17383.826161738474, 17318.913405433144, 17353.479395618153, 17382.217800198767, 17416.303347866196, 17427.56431089233, 9284.0, 9525.0, 9734.805303893883, 9865.112139907444, 10053.145482633912, 7430.777076687708, 7620.504667196615, 7819.139894611474, 8049.39629527776, 8361.665533378597, 14572.85427145715, 15389.153596552296, 15511.767323490383, 15868.68262634764, 15981.600459988593, 15085.622859428602, 15629.218539072774, 15952.0, 16111.0, 16249.59376015609, 10310.175185985254, 10533.157347412036, 10694.73263168427, 10773.353598784099, 10803.135749140207, 12312.692182695504, 12316.938415307866, 12431.378431078228, 12445.439955201857, 12446.190997585129, 9405.576749046446, 9921.751956201153, 10065.647702330383, 10231.590736370461, 10246.333988290737, 9682.0, 9863.358881672668, 9941.602335906482, 10009.649662261785, 10106.49467526606, 8940.284777217677, 9022.909770902206, 9041.547922603975, 9043.140901614335, 9077.092290771134, 6172.290186628596, 6463.935360646521, 6471.158749362553, 6495.74017039332, 6654.4676425884845, 6185.165002724574, 6268.091126786681, 6406.455451286693, 6493.026046093124, 6663.0], "value": 5837.411854256288, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.1610655677674, 492.3911989919549, 517.2448225590638, 518.7276679743136, 523.4948274914707, 6343.936560634393, 6368.586041907272, 6368.904466433008, 6433.710483028269, 6455.0, 6099.817005489843, 6283.183186185801, 6290.339514350996, 6297.401746834055, 6306.211723534559, 5065.772040258188, 5089.567386772129, 5112.437631860493, 5123.0, 5151.742412879341, 5099.388073431193, 5106.361704786902, 5116.820911268106, 5126.128558145106, 5179.2749015137915, 5074.797008119689, 5084.211947148198, 5088.389393272812, 5096.261042148886, 5106.668066575679, 4880.731559764212, 5021.824236151717, 5034.622403319729, 5054.21659642756, 5108.8211912583065, 4475.590189090426, 4485.680596358704, 4505.617022553087, 4523.434570678665, 4564.589186973189, 6155.846103847395, 6181.805459062013, 6189.81430557084, 6191.876162476725, 6222.62664240147, 5836.708164591796, 5839.708014599296, 5853.707314634294, 5858.531317494633, 5868.0, 6615.140031795836, 6666.533342666015, 6695.0, 6714.462842972599, 6726.495512836557, 4928.778204980748, 4929.359183306147, 4930.753462326905, 4955.578775804061, 4969.4036715594, 6977.302269773033, 7065.399441047517, 7088.291170882871, 7089.0075389445, 7117.252688467688, 5069.619778516626, 5097.337346144977, 5119.462456442095, 5120.769565369567, 5121.4622464641425, 5191.896162076738, 5200.2199670049795, 5204.4535323791215, 5206.349206349207, 5211.843644690665, 5838.211841401441, 5842.211301474332, 5848.5321174305955, 5861.794837180678, 5865.501432378211, 6729.5625784323865, 6798.0, 6834.624095674686, 6841.213260475109, 6861.142357205349, 1695.5761059735066, 1781.1806568978416, 1795.371619933039, 1810.7736532933384, 1816.400587806021, 1219.9878001220052, 1225.2587184753097, 1242.5713128970672, 1246.2273390497949, 1262.4129779652505, 5729.9713501432225, 5731.684757338303, 5861.9413805861395, 5882.647041177457, 5890.204822349014, 6852.760153394707, 6905.689243983932, 6911.7926462206215, 6923.965380173167, 6956.826079348057, 5806.767729290781, 5835.252276507636, 5850.338096166234, 5854.268216472941, 5860.296764388216, 3630.9818450908106, 3648.7810731356203, 3654.2775632154217, 3658.414653655402, 3684.613115622821, 6620.437262832713, 6653.567518111307, 6676.899846502306, 6710.664466776641, 6723.22682891464, 7053.788386348418, 7058.9294107059295, 7060.505764596532, 7067.293270672892, 7073.540219885691, 6607.603543787388, 6620.9006864897065, 6642.833929151713, 6673.799786006428, 6676.332366763382, 6777.491688123312, 6827.93172068273, 6834.316568343324, 6841.760538381132, 6862.794116176323, 6814.2163651180745, 6817.8636427270185, 6821.317868213139, 6822.761203357859, 6881.759138430131, 6369.9044514333245, 6658.533902626769, 6658.933410666025, 6666.400023997863, 6691.498137639599, 5012.77442515095, 5042.294078828893, 5044.0920634286185, 5049.38968637426, 5065.113605119016, 6761.411068398824, 6867.931320686929, 6928.549644273106, 6944.305569443015, 6967.651617419007, 6557.9344206557325, 6615.0, 6644.435223006099, 6665.500087493554, 6706.497012723968, 6564.5076619252795, 6648.468122550088, 6653.700583473658, 6674.632895190811, 6695.363940425652, 6541.803745887631, 6551.44312733423, 6551.6069035858, 6597.934020659732, 6644.534882558174, 6713.362230588086, 6741.59550426976, 6743.538608407994, 6756.155480564929, 6760.256371799196, 6487.286398496068, 6490.058941453557, 6492.220933488012, 6506.186726659168, 6530.412262896362], "value": 5157.968895810374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.038632304668, 873.8601823708206, 889.235257678396, 890.4612709310867, 893.3969570539888, 16878.409255676055, 17317.82682173178, 17373.7393939091, 17551.38570150045, 20569.588608227827, 19806.504837379074, 20733.377998660028, 20751.481212969684, 20802.375928722162, 21068.8946555267, 983.2969426859794, 1037.906588407045, 1052.794705032519, 1071.314358810362, 1075.4300220882944, 1090.7982023325671, 1090.8581884355024, 1096.1450068946235, 1096.3915027159924, 1097.1223021582741, 1137.2266858536193, 1143.1197977557276, 1143.4054291768275, 1143.4397145398736, 1145.123980155182, 1057.7567159553269, 1102.4102105373668, 1120.9439528023606, 1128.785530749159, 1129.1531351486385, 811.2455416462687, 811.772703642975, 813.780279324585, 814.5316443045273, 815.5147687126209, 17465.039422831866, 17490.212940417583, 17557.473275801618, 17563.473095807145, 17584.736228956448, 18658.0, 19870.503237419034, 19924.3026494072, 19924.402267931986, 20142.597148057102, 15192.848071519255, 15910.124943128123, 15951.042937423792, 15963.760543591856, 16087.678246435124, 3532.8056956867363, 3559.1458050068054, 3566.6076731559765, 3575.0704816747834, 3577.2845430913662, 100845.0, 103779.481102594, 107405.0, 109732.4513377436, 110458.0, 14554.0, 15613.765793513106, 15835.366585336687, 15875.0, 15900.0, 27751.0, 28468.145955621363, 28496.715032849406, 28712.425751485272, 28966.0, 8780.78048048804, 8825.602847871733, 8852.513111778786, 8860.202581767542, 8930.330225233134, 3766.717496187742, 3859.1702783901596, 3865.7100717446306, 3906.00396898789, 4101.938470922939, 5502.422245664227, 5674.914876276859, 5698.145278208219, 5698.373178950312, 5709.942900571024, 1037.2324479884983, 1037.2428127466992, 1040.1210976724656, 1041.6666666666595, 1064.989350106489, 683.3849535418065, 687.1925487552106, 696.5507247825226, 722.5195245162014, 727.6325455644971, 11815.0, 12064.75870482603, 12068.275903445821, 12734.235945843278, 12843.48626054966, 658.7957733102753, 693.4972145194795, 713.6253466929903, 720.0135813934838, 725.7024619905814, 5175.249588809676, 5534.252875861787, 5621.269234999424, 5691.7438715257085, 5695.316562012585, 94852.0, 95665.52167239119, 96175.0, 101488.49255753674, 101518.0, 87866.0, 89052.5547372259, 90050.09949900548, 90063.09936900547, 91555.0, 71417.28582714107, 74043.62978185074, 77311.0, 77830.2216977823, 77830.6108469454, 10368.429736364573, 10420.635277765241, 10629.94685026601, 10748.731281718019, 10818.673985093243, 33738.49392259069, 34472.655273446944, 35437.64562354344, 35540.644593553734, 36184.63815361918, 43000.56999429966, 43052.13895722131, 43563.12873742571, 43905.0, 44485.33272000858, 16064.43774467888, 16078.67842643164, 16091.114988675736, 16224.107674078039, 16405.589860253112, 16580.502584922473, 16769.66460670804, 17332.13339333003, 17663.205155767766, 17737.37919172823, 18795.0, 19505.122269497624, 19636.0, 19671.0, 19713.1129099188, 18668.90665546718, 19670.21319147218, 19684.409467715992, 19878.403647890587, 19964.70052949178, 16821.747673785147, 17955.102244887963, 18076.819231807513, 18175.363862264756, 18590.25638974426, 12963.092583519063, 13267.137636053625, 13634.549771544058, 13834.0, 13975.510857119953, 13945.511907083204, 14275.286235688382, 14695.11829290246, 15007.624809379853, 15056.924715376792], "value": 8796.380777844719, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 108.0, 107.0, 113.0, 115.0, 107.0, 110.0, 108.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 158.0, 181.0, 122.0, 155.0, 172.0, 121.0, 175.0, 128.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 162.0, 165.0, 169.0, 168.0, 170.0, 168.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 171.0, 76.0, 76.0, 74.0, 74.0, 95.0, 75.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 139.0, 88.0, 83.0, 83.0, 150.0, 85.0, 83.0, 138.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 115.0, 114.0, 115.0, 113.0, 115.0, 114.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 154.0, 153.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 53.0, 54.0, 52.0, 54.0, 57.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 55.0, 55.0, 53.0, 54.0, 55.0, 56.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 88.0, 77.0, 77.0, 86.0, 78.0, 78.0, 78.0, 79.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 136.0, 128.0, 135.0, 138.0, 131.0, 137.0, 136.0, 147.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 189.0, 181.0, 183.0, 188.0, 195.0, 185.0, 197.0, 188.0, 179.0], "value": 188.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 70.0, 71.0, 69.0, 69.0, 69.0, 70.0, 71.0], "value": 70.6, "unit": "score"}]}]} 05:30:33 INFO - Return code: 0 05:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:33 INFO - # TBPL SUCCESS # 05:30:33 INFO - Running post-action listener: _resource_record_post_action 05:30:33 INFO - [mozharness: 2017-06-19 12:30:33.515168Z] Finished run-tests step (success) 05:30:33 INFO - Running post-run listener: _resource_record_post_run 05:30:33 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 423763968; Read time: 4; Write time: 356456 05:30:33 INFO - TinderboxPrint: CPU usage
13.3% 05:30:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 05:30:33 INFO - TinderboxPrint: I/O write bytes / time
423,763,968 / 356,456 05:30:33 INFO - TinderboxPrint: CPU idle
8,284.4 (86.7%) 05:30:33 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 05:30:33 INFO - TinderboxPrint: Swap in / out
0 / 0 05:30:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 99131392; Read time: 0; Write time: 105820 05:30:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:30:33 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 320077824; Read time: 0; Write time: 250076 05:30:34 INFO - Running post-run listener: _upload_blobber_files 05:30:34 INFO - Blob upload gear active. 05:30:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:30:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:35 INFO - (blobuploader) - INFO - Done attempting. 05:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:36 INFO - (blobuploader) - INFO - Done attempting. 05:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:39 INFO - (blobuploader) - INFO - Done attempting. 05:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:30:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:40 INFO - (blobuploader) - INFO - Done attempting. 05:30:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:40 INFO - Return code: 0 05:30:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04ede90cec662c4c6c6d4cbc5727b49b7ad6b7438c6e93722df16bc1f92eff10c274c7afaedacd066cc00f56c4e5a31efd7ea819264d4811df036af130247f6e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76324d06b1a2e271439609dad20dd980e58f1e742cbd798c3a12486181d983c9b4db767140f0fa1ebe87f3e78b521b9ef85bc9c49ee8a88f66923bb2c1b761bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee18ab6e7bb86cd0b36298aeab7355e952c3ca6b0a7b61fc714581a44dfe8bb15b8030bb7f7b9eb0b72bf1d9d72d53b149f0615698c70c815238d8e1c12fb8f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46fd0364fb3bcd77755461750a8bed841617a6e25cf0b7c807bec9afb066632b111ef839e9b23b4ce4857445c1e01a0c003186a89c410a54c3c4f852e6ee836f"} 05:30:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:40 INFO - Contents: 05:30:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04ede90cec662c4c6c6d4cbc5727b49b7ad6b7438c6e93722df16bc1f92eff10c274c7afaedacd066cc00f56c4e5a31efd7ea819264d4811df036af130247f6e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76324d06b1a2e271439609dad20dd980e58f1e742cbd798c3a12486181d983c9b4db767140f0fa1ebe87f3e78b521b9ef85bc9c49ee8a88f66923bb2c1b761bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee18ab6e7bb86cd0b36298aeab7355e952c3ca6b0a7b61fc714581a44dfe8bb15b8030bb7f7b9eb0b72bf1d9d72d53b149f0615698c70c815238d8e1c12fb8f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46fd0364fb3bcd77755461750a8bed841617a6e25cf0b7c807bec9afb066632b111ef839e9b23b4ce4857445c1e01a0c003186a89c410a54c3c4f852e6ee836f"} 05:30:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:30:40 INFO - Copying logs to upload dir... 05:30:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:30:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.437097 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-19 05:30:39.713584) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 05:30:39.717493) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 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-Non-PGO/sha512/04ede90cec662c4c6c6d4cbc5727b49b7ad6b7438c6e93722df16bc1f92eff10c274c7afaedacd066cc00f56c4e5a31efd7ea819264d4811df036af130247f6e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76324d06b1a2e271439609dad20dd980e58f1e742cbd798c3a12486181d983c9b4db767140f0fa1ebe87f3e78b521b9ef85bc9c49ee8a88f66923bb2c1b761bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee18ab6e7bb86cd0b36298aeab7355e952c3ca6b0a7b61fc714581a44dfe8bb15b8030bb7f7b9eb0b72bf1d9d72d53b149f0615698c70c815238d8e1c12fb8f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46fd0364fb3bcd77755461750a8bed841617a6e25cf0b7c807bec9afb066632b111ef839e9b23b4ce4857445c1e01a0c003186a89c410a54c3c4f852e6ee836f"} build_url:https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/CSC6dMU4Q_6PNZ3mMFIC_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/04ede90cec662c4c6c6d4cbc5727b49b7ad6b7438c6e93722df16bc1f92eff10c274c7afaedacd066cc00f56c4e5a31efd7ea819264d4811df036af130247f6e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76324d06b1a2e271439609dad20dd980e58f1e742cbd798c3a12486181d983c9b4db767140f0fa1ebe87f3e78b521b9ef85bc9c49ee8a88f66923bb2c1b761bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee18ab6e7bb86cd0b36298aeab7355e952c3ca6b0a7b61fc714581a44dfe8bb15b8030bb7f7b9eb0b72bf1d9d72d53b149f0615698c70c815238d8e1c12fb8f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46fd0364fb3bcd77755461750a8bed841617a6e25cf0b7c807bec9afb066632b111ef839e9b23b4ce4857445c1e01a0c003186a89c410a54c3c4f852e6ee836f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-19 05:30:39.741982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:30:39.742279) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1497862581.867908-292356750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-19 05:30:39.826773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 05:30:39.827109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-19 05:30:39.827404) ========= ========= Total master_lag: 0.15 =========