builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1495880276.86 results: success (0) revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:56.861123) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:56.861504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:56.861802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:56.877107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:56.877368) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 03:17:57-- 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% 19.6M=0.001s 2017-05-27 03:17:58 (19.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.369767 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:57.263411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:57.263701) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017609 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:57.312947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 03:17:57.313240) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ebad93e117700d8e2d65573b824beb18a8cc2030 --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 ebad93e117700d8e2d65573b824beb18a8cc2030 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 03:17:58,270 truncating revision to first 12 chars 2017-05-27 03:17:58,270 Setting DEBUG logging. 2017-05-27 03:17:58,270 attempt 1/10 2017-05-27 03:17:58,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ebad93e11770?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 03:17:59,438 unpacking tar archive at: mozilla-central-ebad93e11770/testing/mozharness/ program finished with exit code 0 elapsedTime=1.491804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 03:17:58.820518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:58.823836) ========= script_repo_revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:58.831153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:58.831435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 03:17:58.841268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-27 03:17:58.841605) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:59 INFO - MultiFileLogger online at 20170527 03:17:59 in /builds/slave/test 03:17:59 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 03:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:59 INFO - {'append_to_log': False, 03:17:59 INFO - 'base_work_dir': '/builds/slave/test', 03:17:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:59 INFO - 'branch': 'Firefox-Non-PGO', 03:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:59 INFO - 'config_files': ('talos/linux_config.py',), 03:17:59 INFO - 'default_actions': ('clobber', 03:17:59 INFO - 'read-buildbot-config', 03:17:59 INFO - 'download-and-extract', 03:17:59 INFO - 'populate-webroot', 03:17:59 INFO - 'create-virtualenv', 03:17:59 INFO - 'install', 03:17:59 INFO - 'run-tests'), 03:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:59 INFO - 'download_minidump_stackwalk': True, 03:17:59 INFO - 'download_symbols': 'ondemand', 03:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:59 INFO - 'gecko_profile': False, 03:17:59 INFO - 'gecko_profile_interval': 0, 03:17:59 INFO - 'installer_path': 'installer.exe', 03:17:59 INFO - 'log_level': 'info', 03:17:59 INFO - 'log_name': 'talos', 03:17:59 INFO - 'log_to_console': True, 03:17:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:59 INFO - 'opt_config_files': (), 03:17:59 INFO - 'pip_index': False, 03:17:59 INFO - 'suite': 'dromaeojs-e10s', 03:17:59 INFO - 'system_bits': '32', 03:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:59 INFO - 'title': 'talos-linux64-ix-071', 03:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:59 INFO - 'use_talos_json': True, 03:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:59 INFO - 'work_dir': 'build'} 03:17:59 INFO - [mozharness: 2017-05-27 10:17:59.888660Z] Running clobber step. 03:17:59 INFO - Running pre-action listener: _resource_record_pre_action 03:17:59 INFO - Running main action method: clobber 03:17:59 INFO - rmtree: /builds/slave/test/build 03:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:01 INFO - Running post-action listener: _resource_record_post_action 03:18:01 INFO - [mozharness: 2017-05-27 10:18:01.425523Z] Finished clobber step (success) 03:18:01 INFO - [mozharness: 2017-05-27 10:18:01.425623Z] Running read-buildbot-config step. 03:18:01 INFO - Running pre-action listener: _resource_record_pre_action 03:18:01 INFO - Running main action method: read_buildbot_config 03:18:01 INFO - Using buildbot properties: 03:18:01 INFO - { 03:18:01 INFO - "project": "", 03:18:01 INFO - "product": "firefox", 03:18:01 INFO - "who": "archaeopteryx@coole-files.de", 03:18:01 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:18:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:18:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:18:01 INFO - "stage_platform": "linux64", 03:18:01 INFO - "basedir": "/builds/slave/test", 03:18:01 INFO - "buildnumber": 640, 03:18:01 INFO - "platform": "ubuntu64_hw", 03:18:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:01 INFO - "slavebuilddir": "test", 03:18:01 INFO - "taskId": "BL9W2YNdRcaxtoBl8mGxjw", 03:18:01 INFO - "branch": "mozilla-central", 03:18:01 INFO - "script_repo_revision": "production", 03:18:01 INFO - "revision": "ebad93e117700d8e2d65573b824beb18a8cc2030", 03:18:01 INFO - "slavename": "talos-linux64-ix-071", 03:18:01 INFO - "repo_path": "mozilla-central" 03:18:01 INFO - } 03:18:01 INFO - Finding installer, test and symbols from parent task. 03:18:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BL9W2YNdRcaxtoBl8mGxjw'}, attempt #1 03:18:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BL9W2YNdRcaxtoBl8mGxjw'}, attempt #1 03:18:02 INFO - Task dependencies: IggRYx8DSWac_R94qt0K1g 03:18:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g'}, attempt #1 03:18:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 03:18:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/test_packages.json 03:18:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.crashreporter-symbols.zip 03:18:02 INFO - Running post-action listener: _resource_record_post_action 03:18:02 INFO - [mozharness: 2017-05-27 10:18:02.793884Z] Finished read-buildbot-config step (success) 03:18:02 INFO - [mozharness: 2017-05-27 10:18:02.794200Z] Running download-and-extract step. 03:18:02 INFO - Running pre-action listener: _resource_record_pre_action 03:18:02 INFO - Running main action method: download_and_extract 03:18:02 INFO - mkdir: /builds/slave/test/build/tests 03:18:02 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')]} 03:18:02 INFO - trying https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.test_packages.json 03:18:02 INFO - Downloading https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:03 INFO - Downloaded 986 bytes. 03:18:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:03 INFO - Using the following test package requirements: 03:18:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:03 INFO - u'common': [u'target.common.tests.zip'], 03:18:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:03 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:03 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:03 INFO - u'target.web-platform.tests.zip'], 03:18:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:18:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip 03:18:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:03 INFO - Fetch https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip into memory 03:18:04 INFO - Content-Length response header: 63534015 03:18:04 INFO - Bytes received: 63534015 03:18:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:18:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip 03:18:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:15 INFO - Fetch https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.common.tests.zip into memory 03:18:16 INFO - Content-Length response header: 63534015 03:18:16 INFO - Bytes received: 63534015 03:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.talos.tests.zip 03:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.talos.tests.zip into memory 03:18:29 INFO - Content-Length response header: 14441221 03:18:29 INFO - Bytes received: 14441221 03:18: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')]} 03:18:29 INFO - trying https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 03:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:18:30 INFO - Downloaded 54092932 bytes. 03:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 03:18:30 INFO - mkdir: /builds/slave/test/properties 03:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:30 INFO - Contents: 03:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 03:18:30 INFO - Running post-action listener: _resource_record_post_action 03:18:30 INFO - Running post-action listener: set_extra_try_arguments 03:18:30 INFO - [mozharness: 2017-05-27 10:18:30.849970Z] Finished download-and-extract step (success) 03:18:30 INFO - [mozharness: 2017-05-27 10:18:30.850068Z] Running populate-webroot step. 03:18:30 INFO - Running pre-action listener: _resource_record_pre_action 03:18:30 INFO - Running main action method: populate_webroot 03:18:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:30 INFO - '--tppagecycles', 03:18:30 INFO - '7'], 03:18:30 INFO - 'tests': ['tsvgm']}}, 03:18:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['damp', 'tps']}, 03:18:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'tests': ['damp', 'tps']}, 03:18:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['dromaeo_dom']}, 03:18:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:18:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:18:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:18:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['a11yr', 03:18:30 INFO - 'ts_paint', 03:18:30 INFO - 'tpaint', 03:18:30 INFO - 'sessionrestore', 03:18:30 INFO - 'sessionrestore_no_auto_restore', 03:18:30 INFO - 'tabpaint']}, 03:18:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:18:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:18:30 INFO - 'bloom_basic_ref']}, 03:18:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['tsvgx', 03:18:30 INFO - 'tsvgr_opacity', 03:18:30 INFO - 'tart', 03:18:30 INFO - 'tscrollx', 03:18:30 INFO - 'cart', 03:18:30 INFO - 'tsvg_static']}, 03:18:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:30 INFO - 'tsvgr_opacity', 03:18:30 INFO - 'tart', 03:18:30 INFO - 'tscrollx', 03:18:30 INFO - 'cart', 03:18:30 INFO - 'tsvg_static']}, 03:18:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'talos_options': ['--disable-e10s'], 03:18:30 INFO - 'tests': ['tp5o']}, 03:18:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:18:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'talos_options': ['--disable-e10s', 03:18:30 INFO - '--xperf_path', 03:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:30 INFO - 'tests': ['tp5n']}, 03:18:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:18:30 INFO - 'talos_options': ['--xperf_path', 03:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:30 INFO - 'tests': ['tp5n']}}, 03:18:30 INFO - 'talos.zip': {'path': '', 03:18:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:30 INFO - Running post-action listener: _resource_record_post_action 03:18:30 INFO - [mozharness: 2017-05-27 10:18:30.864120Z] Finished populate-webroot step (success) 03:18:30 INFO - [mozharness: 2017-05-27 10:18:30.864209Z] Running create-virtualenv step. 03:18:30 INFO - Running pre-action listener: _resource_record_pre_action 03:18:30 INFO - Running main action method: create_virtualenv 03:18:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:30 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 03:18:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:30 INFO - Using real prefix '/usr' 03:18:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:33 INFO - Installing pip.................done. 03:18:33 INFO - Return code: 0 03:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:33 INFO - Reading from file tmpfile_stdout 03:18:33 INFO - Output received: 03:18:33 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) 03:18:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:33 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:33 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 03:18:33 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 03:18:33 INFO - Using env: {'DISPLAY': ':0', 03:18:33 INFO - 'HOME': '/home/cltbld', 03:18:33 INFO - 'LANG': 'en_US.UTF-8', 03:18:33 INFO - 'LANGUAGE': 'en_US:en', 03:18:33 INFO - 'LOGNAME': 'cltbld', 03:18:33 INFO - 'MAIL': '/var/mail/cltbld', 03:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:33 INFO - 'MOZ_NO_REMOTE': '1', 03:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:33 INFO - 'NO_EM_RESTART': '1', 03:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:33 INFO - 'PWD': '/builds/slave/test', 03:18:33 INFO - 'SHELL': '/bin/bash', 03:18:33 INFO - 'SHLVL': '1', 03:18:33 INFO - 'TERM': 'linux', 03:18:33 INFO - 'TMOUT': '86400', 03:18:33 INFO - 'USER': 'cltbld', 03:18:33 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:33 INFO - '_': '/tools/buildbot/bin/python'} 03:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:33 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 03:18:33 INFO - Cleaning up... 03:18:33 INFO - Return code: 0 03:18:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:33 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:33 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 03:18:33 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 03:18:33 INFO - Using env: {'DISPLAY': ':0', 03:18:33 INFO - 'HOME': '/home/cltbld', 03:18:33 INFO - 'LANG': 'en_US.UTF-8', 03:18:33 INFO - 'LANGUAGE': 'en_US:en', 03:18:33 INFO - 'LOGNAME': 'cltbld', 03:18:33 INFO - 'MAIL': '/var/mail/cltbld', 03:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:33 INFO - 'MOZ_NO_REMOTE': '1', 03:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:33 INFO - 'NO_EM_RESTART': '1', 03:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:33 INFO - 'PWD': '/builds/slave/test', 03:18:33 INFO - 'SHELL': '/bin/bash', 03:18:33 INFO - 'SHLVL': '1', 03:18:33 INFO - 'TERM': 'linux', 03:18:33 INFO - 'TMOUT': '86400', 03:18:33 INFO - 'USER': 'cltbld', 03:18:33 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:33 INFO - '_': '/tools/buildbot/bin/python'} 03:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:34 INFO - Downloading/unpacking psutil>=3.1.1 03:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:35 INFO - Installing collected packages: psutil 03:18:35 INFO - Running setup.py install for psutil 03:18:35 INFO - building 'psutil._psutil_linux' extension 03:18:35 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 03:18:35 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 03:18:35 INFO - building 'psutil._psutil_posix' extension 03:18:35 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 03:18:35 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 03:18:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:35 INFO - Successfully installed psutil 03:18:35 INFO - Cleaning up... 03:18:35 INFO - Return code: 0 03:18:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:35 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:35 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 03:18:35 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 03:18:35 INFO - Using env: {'DISPLAY': ':0', 03:18:35 INFO - 'HOME': '/home/cltbld', 03:18:35 INFO - 'LANG': 'en_US.UTF-8', 03:18:35 INFO - 'LANGUAGE': 'en_US:en', 03:18:35 INFO - 'LOGNAME': 'cltbld', 03:18:35 INFO - 'MAIL': '/var/mail/cltbld', 03:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:35 INFO - 'MOZ_NO_REMOTE': '1', 03:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:35 INFO - 'NO_EM_RESTART': '1', 03:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:35 INFO - 'PWD': '/builds/slave/test', 03:18:35 INFO - 'SHELL': '/bin/bash', 03:18:35 INFO - 'SHLVL': '1', 03:18:35 INFO - 'TERM': 'linux', 03:18:35 INFO - 'TMOUT': '86400', 03:18:35 INFO - 'USER': 'cltbld', 03:18:35 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:35 INFO - '_': '/tools/buildbot/bin/python'} 03:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:37 INFO - Installing collected packages: mozsystemmonitor 03:18:37 INFO - Running setup.py install for mozsystemmonitor 03:18:37 INFO - Successfully installed mozsystemmonitor 03:18:37 INFO - Cleaning up... 03:18:37 INFO - Return code: 0 03:18:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:37 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')]} 03:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:37 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')]} 03:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:37 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:37 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 03:18:37 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 03:18:37 INFO - Using env: {'DISPLAY': ':0', 03:18:37 INFO - 'HOME': '/home/cltbld', 03:18:37 INFO - 'LANG': 'en_US.UTF-8', 03:18:37 INFO - 'LANGUAGE': 'en_US:en', 03:18:37 INFO - 'LOGNAME': 'cltbld', 03:18:37 INFO - 'MAIL': '/var/mail/cltbld', 03:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:37 INFO - 'MOZ_NO_REMOTE': '1', 03:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:37 INFO - 'NO_EM_RESTART': '1', 03:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:37 INFO - 'PWD': '/builds/slave/test', 03:18:37 INFO - 'SHELL': '/bin/bash', 03:18:37 INFO - 'SHLVL': '1', 03:18:37 INFO - 'TERM': 'linux', 03:18:37 INFO - 'TMOUT': '86400', 03:18:37 INFO - 'USER': 'cltbld', 03:18:37 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:37 INFO - '_': '/tools/buildbot/bin/python'} 03:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:37 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 03:18:37 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 03:18:37 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 03:18:37 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 03:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:38 INFO - warning: no files found matching '*.txt' 03:18:38 INFO - no previously-included directories found matching 'build' 03:18:38 INFO - no previously-included directories found matching 'dist' 03:18:38 INFO - no previously-included directories found matching '.git*' 03:18:38 INFO - Installing collected packages: jsonschema, functools32 03:18:38 INFO - Running setup.py install for functools32 03:18:38 INFO - warning: no files found matching '*.txt' 03:18:38 INFO - no previously-included directories found matching 'build' 03:18:38 INFO - no previously-included directories found matching 'dist' 03:18:38 INFO - no previously-included directories found matching '.git*' 03:18:38 INFO - Successfully installed jsonschema functools32 03:18:38 INFO - Cleaning up... 03:18:39 INFO - Return code: 0 03:18:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:39 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')]} 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:39 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')]} 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:39 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:39 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 03:18:39 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 03:18:39 INFO - Using env: {'DISPLAY': ':0', 03:18:39 INFO - 'HOME': '/home/cltbld', 03:18:39 INFO - 'LANG': 'en_US.UTF-8', 03:18:39 INFO - 'LANGUAGE': 'en_US:en', 03:18:39 INFO - 'LOGNAME': 'cltbld', 03:18:39 INFO - 'MAIL': '/var/mail/cltbld', 03:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:39 INFO - 'MOZ_NO_REMOTE': '1', 03:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:39 INFO - 'NO_EM_RESTART': '1', 03:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:39 INFO - 'PWD': '/builds/slave/test', 03:18:39 INFO - 'SHELL': '/bin/bash', 03:18:39 INFO - 'SHLVL': '1', 03:18:39 INFO - 'TERM': 'linux', 03:18:39 INFO - 'TMOUT': '86400', 03:18:39 INFO - 'USER': 'cltbld', 03:18:39 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:39 INFO - '_': '/tools/buildbot/bin/python'} 03:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:39 INFO - Cleaning up... 03:18:39 INFO - Return code: 0 03:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:39 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')]} 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:39 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')]} 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:39 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:39 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 03:18:39 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 03:18:39 INFO - Using env: {'DISPLAY': ':0', 03:18:39 INFO - 'HOME': '/home/cltbld', 03:18:39 INFO - 'LANG': 'en_US.UTF-8', 03:18:39 INFO - 'LANGUAGE': 'en_US:en', 03:18:39 INFO - 'LOGNAME': 'cltbld', 03:18:39 INFO - 'MAIL': '/var/mail/cltbld', 03:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:39 INFO - 'MOZ_NO_REMOTE': '1', 03:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:39 INFO - 'NO_EM_RESTART': '1', 03:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:39 INFO - 'PWD': '/builds/slave/test', 03:18:39 INFO - 'SHELL': '/bin/bash', 03:18:39 INFO - 'SHLVL': '1', 03:18:39 INFO - 'TERM': 'linux', 03:18:39 INFO - 'TMOUT': '86400', 03:18:39 INFO - 'USER': 'cltbld', 03:18:39 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:39 INFO - '_': '/tools/buildbot/bin/python'} 03:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:40 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 03:18:40 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 03:18:40 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 03:18:40 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 03:18:41 INFO - Downloading docopt-0.6.1.tar.gz 03:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:41 INFO - Running setup.py install for blobuploader 03:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:41 INFO - Running setup.py install for requests 03:18:41 INFO - Running setup.py install for docopt 03:18:41 INFO - Successfully installed blobuploader requests docopt 03:18:41 INFO - Cleaning up... 03:18:41 INFO - Return code: 0 03:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:41 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:41 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 03:18:41 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 03:18:41 INFO - Using env: {'DISPLAY': ':0', 03:18:41 INFO - 'HOME': '/home/cltbld', 03:18:41 INFO - 'LANG': 'en_US.UTF-8', 03:18:41 INFO - 'LANGUAGE': 'en_US:en', 03:18:41 INFO - 'LOGNAME': 'cltbld', 03:18:41 INFO - 'MAIL': '/var/mail/cltbld', 03:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:41 INFO - 'MOZ_NO_REMOTE': '1', 03:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:41 INFO - 'NO_EM_RESTART': '1', 03:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:41 INFO - 'PWD': '/builds/slave/test', 03:18:41 INFO - 'SHELL': '/bin/bash', 03:18:41 INFO - 'SHLVL': '1', 03:18:41 INFO - 'TERM': 'linux', 03:18:41 INFO - 'TMOUT': '86400', 03:18:41 INFO - 'USER': 'cltbld', 03:18:41 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:41 INFO - '_': '/tools/buildbot/bin/python'} 03:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:41 INFO - Running setup.py (path:/tmp/pip-EuH4oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:42 INFO - Running setup.py (path:/tmp/pip-RPMDG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:42 INFO - Running setup.py (path:/tmp/pip-7bVz0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:42 INFO - Running setup.py (path:/tmp/pip-3LuXyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:42 INFO - Running setup.py (path:/tmp/pip-S4u4q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:42 INFO - Running setup.py (path:/tmp/pip-1eXUkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:42 INFO - Running setup.py (path:/tmp/pip-6k4MXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:42 INFO - Running setup.py (path:/tmp/pip-xrQ5Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:42 INFO - Running setup.py (path:/tmp/pip-yykf3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:42 INFO - Running setup.py (path:/tmp/pip-r2htGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:42 INFO - Running setup.py (path:/tmp/pip-sh4zkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:42 INFO - Running setup.py (path:/tmp/pip-LQNhgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:42 INFO - Running setup.py (path:/tmp/pip-V1nmrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:42 INFO - Running setup.py (path:/tmp/pip-vKyc7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:42 INFO - Running setup.py (path:/tmp/pip-ILKufb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:43 INFO - Running setup.py (path:/tmp/pip-gKN6xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:43 INFO - Running setup.py (path:/tmp/pip-fKPACk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:43 INFO - Running setup.py install for manifestparser 03:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozcrash 03:18:43 INFO - Running setup.py install for mozdebug 03:18:43 INFO - Running setup.py install for mozdevice 03:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozfile 03:18:43 INFO - Running setup.py install for mozhttpd 03:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozinfo 03:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozInstall 03:18:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:43 INFO - Running setup.py install for mozleak 03:18:44 INFO - Running setup.py install for mozlog 03:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for moznetwork 03:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozprocess 03:18:44 INFO - Running setup.py install for mozprofile 03:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozrunner 03:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Running setup.py install for mozscreenshot 03:18:44 INFO - Running setup.py install for moztest 03:18:44 INFO - Running setup.py install for mozversion 03:18:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:44 INFO - Cleaning up... 03:18:44 INFO - Return code: 0 03:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:44 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:44 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 03:18:44 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 03:18:44 INFO - Using env: {'DISPLAY': ':0', 03:18:44 INFO - 'HOME': '/home/cltbld', 03:18:44 INFO - 'LANG': 'en_US.UTF-8', 03:18:44 INFO - 'LANGUAGE': 'en_US:en', 03:18:44 INFO - 'LOGNAME': 'cltbld', 03:18:44 INFO - 'MAIL': '/var/mail/cltbld', 03:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:44 INFO - 'MOZ_NO_REMOTE': '1', 03:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:44 INFO - 'NO_EM_RESTART': '1', 03:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:44 INFO - 'PWD': '/builds/slave/test', 03:18:44 INFO - 'SHELL': '/bin/bash', 03:18:44 INFO - 'SHLVL': '1', 03:18:44 INFO - 'TERM': 'linux', 03:18:44 INFO - 'TMOUT': '86400', 03:18:44 INFO - 'USER': 'cltbld', 03:18:44 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:44 INFO - '_': '/tools/buildbot/bin/python'} 03:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:45 INFO - Running setup.py (path:/tmp/pip-qTY4cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:45 INFO - Running setup.py (path:/tmp/pip-_lw_EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:45 INFO - Running setup.py (path:/tmp/pip-A577Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:45 INFO - Running setup.py (path:/tmp/pip-Puxkz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:45 INFO - Running setup.py (path:/tmp/pip-YD_7dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:45 INFO - Running setup.py (path:/tmp/pip-Z3FLg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:45 INFO - Running setup.py (path:/tmp/pip-x4FZTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:45 INFO - Running setup.py (path:/tmp/pip-zvAN8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:45 INFO - Running setup.py (path:/tmp/pip-AIuB93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:45 INFO - Running setup.py (path:/tmp/pip-u5X6oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:45 INFO - Running setup.py (path:/tmp/pip-njK5zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:45 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)) 03:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:45 INFO - Running setup.py (path:/tmp/pip-mGw8WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:46 INFO - Running setup.py (path:/tmp/pip-IwpT3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:46 INFO - Running setup.py (path:/tmp/pip-z02s9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:46 INFO - Running setup.py (path:/tmp/pip-6xypKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:46 INFO - Running setup.py (path:/tmp/pip-v50hHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:46 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)) 03:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:46 INFO - Running setup.py (path:/tmp/pip-l1EJup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 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)) 03:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:46 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 03:18:46 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 03:18:46 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 03:18:46 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 03:18:47 INFO - Downloading blessings-1.6.tar.gz 03:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:47 INFO - Installing collected packages: blessings 03:18:47 INFO - Running setup.py install for blessings 03:18:47 INFO - Successfully installed blessings 03:18:47 INFO - Cleaning up... 03:18:47 INFO - Return code: 0 03:18:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:47 INFO - Reading from file tmpfile_stdout 03:18:47 INFO - Current package versions: 03:18:47 INFO - argparse == 1.2.1 03:18:47 INFO - blessings == 1.6 03:18:47 INFO - blobuploader == 1.2.4 03:18:47 INFO - docopt == 0.6.1 03:18:47 INFO - functools32 == 3.2.3-2 03:18:47 INFO - jsonschema == 2.5.1 03:18:47 INFO - manifestparser == 1.1 03:18:47 INFO - mozInstall == 1.12 03:18:47 INFO - mozcrash == 1.0 03:18:47 INFO - mozdebug == 0.1 03:18:47 INFO - mozdevice == 0.51 03:18:47 INFO - mozfile == 1.2 03:18:47 INFO - mozhttpd == 0.7 03:18:47 INFO - mozinfo == 0.9 03:18:47 INFO - mozleak == 0.1 03:18:47 INFO - mozlog == 3.4 03:18:47 INFO - moznetwork == 0.27 03:18:47 INFO - mozprocess == 0.25 03:18:47 INFO - mozprofile == 0.28 03:18:47 INFO - mozrunner == 6.13 03:18:47 INFO - mozscreenshot == 0.1 03:18:47 INFO - mozsystemmonitor == 0.3 03:18:47 INFO - moztest == 0.8 03:18:47 INFO - mozversion == 1.4 03:18:47 INFO - psutil == 3.1.1 03:18:47 INFO - requests == 1.2.3 03:18:47 INFO - wsgiref == 0.1.2 03:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:47 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')]} 03:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:47 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')]} 03:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:47 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:47 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 03:18:47 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 03:18:47 INFO - Using env: {'DISPLAY': ':0', 03:18:47 INFO - 'HOME': '/home/cltbld', 03:18:47 INFO - 'LANG': 'en_US.UTF-8', 03:18:47 INFO - 'LANGUAGE': 'en_US:en', 03:18:47 INFO - 'LOGNAME': 'cltbld', 03:18:47 INFO - 'MAIL': '/var/mail/cltbld', 03:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:47 INFO - 'MOZ_NO_REMOTE': '1', 03:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:47 INFO - 'NO_EM_RESTART': '1', 03:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:47 INFO - 'PWD': '/builds/slave/test', 03:18:47 INFO - 'SHELL': '/bin/bash', 03:18:47 INFO - 'SHLVL': '1', 03:18:47 INFO - 'TERM': 'linux', 03:18:47 INFO - 'TMOUT': '86400', 03:18:47 INFO - 'USER': 'cltbld', 03:18:47 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:47 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 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)) 03:18:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:18:48 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 03:18:48 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 03:18:48 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 03:18:48 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 03:18:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:18:49 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)) 03:18:49 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)) 03:18:49 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)) 03:18:49 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)) 03:18:49 INFO - Installing collected packages: marionette-driver 03:18:49 INFO - Running setup.py install for marionette-driver 03:18:49 INFO - Successfully installed marionette-driver 03:18:49 INFO - Cleaning up... 03:18:49 INFO - Return code: 0 03:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18:49 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')]} 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:49 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')]} 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:49 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 0x20d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244b5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', '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 03:18:49 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 03:18:49 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 03:18:49 INFO - Using env: {'DISPLAY': ':0', 03:18:49 INFO - 'HOME': '/home/cltbld', 03:18:49 INFO - 'LANG': 'en_US.UTF-8', 03:18:49 INFO - 'LANGUAGE': 'en_US:en', 03:18:49 INFO - 'LOGNAME': 'cltbld', 03:18:49 INFO - 'MAIL': '/var/mail/cltbld', 03:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:49 INFO - 'MOZ_NO_REMOTE': '1', 03:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:49 INFO - 'NO_EM_RESTART': '1', 03:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:49 INFO - 'PWD': '/builds/slave/test', 03:18:49 INFO - 'SHELL': '/bin/bash', 03:18:49 INFO - 'SHLVL': '1', 03:18:49 INFO - 'TERM': 'linux', 03:18:49 INFO - 'TMOUT': '86400', 03:18:49 INFO - 'USER': 'cltbld', 03:18:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:49 INFO - '_': '/tools/buildbot/bin/python'} 03:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:49 INFO - Cleaning up... 03:18:49 INFO - Return code: 0 03:18:49 INFO - Running post-action listener: _resource_record_post_action 03:18:49 INFO - Running post-action listener: _start_resource_monitoring 03:18:49 INFO - Starting resource monitoring. 03:18:49 INFO - [mozharness: 2017-05-27 10:18:49.771864Z] Finished create-virtualenv step (success) 03:18:49 INFO - [mozharness: 2017-05-27 10:18:49.772333Z] Running install step. 03:18:49 INFO - Running pre-action listener: _resource_record_pre_action 03:18:49 INFO - Running main action method: install 03:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:49 INFO - Reading from file tmpfile_stdout 03:18:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:50 INFO - Reading from file tmpfile_stdout 03:18:50 INFO - Output received: 03:18:50 INFO - Usage: mozinstall [options] installer 03:18:50 INFO - Options: 03:18:50 INFO - -h, --help show this help message and exit 03:18:50 INFO - -d DEST, --destination=DEST 03:18:50 INFO - Directory to install application into. [default: 03:18:50 INFO - "/builds/slave/test"] 03:18:50 INFO - --app=APP Application being installed. [default: firefox] 03:18:50 INFO - mkdir: /builds/slave/test/build/application 03:18:50 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'] 03:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:05 INFO - Reading from file tmpfile_stdout 03:19:05 INFO - Output received: 03:19:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:05 INFO - Running post-action listener: _resource_record_post_action 03:19:05 INFO - [mozharness: 2017-05-27 10:19:05.681676Z] Finished install step (success) 03:19:05 INFO - [mozharness: 2017-05-27 10:19:05.681958Z] Running run-tests step. 03:19:05 INFO - Running pre-action listener: _resource_record_pre_action 03:19:05 INFO - Running main action method: run_tests 03:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:05 INFO - Python 2.7.3 03:19:05 INFO - Return code: 0 03:19:05 INFO - grabbing minidump binary from tooltool 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:05 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 0x24487a0>, '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 0x24496a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2449b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:05 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 03:19:05 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 03:19:05 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 03:19:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:05 INFO - Return code: 0 03:19:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:05 INFO - ENV: RUST_BACKTRACE is now 1 03:19:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:05 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/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 03:19:05 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/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 03:19:05 INFO - Using env: {'DISPLAY': ':0', 03:19:05 INFO - 'HOME': '/home/cltbld', 03:19:05 INFO - 'LANG': 'en_US.UTF-8', 03:19:05 INFO - 'LANGUAGE': 'en_US:en', 03:19:05 INFO - 'LOGNAME': 'cltbld', 03:19:05 INFO - 'MAIL': '/var/mail/cltbld', 03:19:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:05 INFO - 'MOZ_NO_REMOTE': '1', 03:19:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:05 INFO - 'NO_EM_RESTART': '1', 03:19:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:05 INFO - 'PWD': '/builds/slave/test', 03:19:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:05 INFO - 'RUST_BACKTRACE': '1', 03:19:05 INFO - 'SHELL': '/bin/bash', 03:19:05 INFO - 'SHLVL': '1', 03:19:05 INFO - 'TERM': 'linux', 03:19:05 INFO - 'TMOUT': '86400', 03:19:05 INFO - 'USER': 'cltbld', 03:19:05 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754', 03:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:05 INFO - '_': '/tools/buildbot/bin/python'} 03:19:05 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/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 03:19:06 INFO - mozversion application_buildid: 20170527080129 03:19:06 INFO - mozversion application_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 03:19:06 INFO - mozversion application_display_name: Nightly 03:19:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:06 INFO - mozversion application_name: Firefox 03:19:06 INFO - mozversion application_remotingname: firefox 03:19:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:06 INFO - mozversion application_vendor: Mozilla 03:19:06 INFO - mozversion application_version: 55.0a1 03:19:06 INFO - mozversion platform_buildid: 20170527080129 03:19:06 INFO - mozversion platform_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 03:19:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:06 INFO - mozversion platform_version: 55.0a1 03:19:06 INFO - using testdate: 1495880346 03:19:06 INFO - actual date: 1495880346 03:19:06 INFO - starting webserver on 'localhost:52911' 03:19:06 INFO - SUITE-START | Running 2 tests 03:19:06 INFO - TEST-START | dromaeo_css 03:19:06 INFO - operating with platform_type : linux_ 03:19:06 INFO - Initialising browser for dromaeo_css test... 03:19:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52911/getInfo.html -profile /tmp/tmpLye9U_/profile 03:19:06 INFO - TEST-INFO | started process 26328 (/builds/slave/test/build/application/firefox/firefox http://localhost:52911/getInfo.html) 03:19:41 INFO - TEST-INFO | 26328: killed by SIGTERM 03:19:41 INFO - Browser initialized. 03:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:41 INFO - TEST-INFO | started process 26531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLye9U_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:53 INFO - PID 26531 | RSS: Main: 183144448 03:19:53 INFO - PID 26531 | 03:22:57 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52911/tests/dromaeo/cssquery-ext.html) 03:22:58 INFO - PID 26531 | RSS: Main: 178835456 03:22:58 INFO - PID 26531 | 03:26:00 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-ext.html (next: http://localhost:52911/tests/dromaeo/cssquery-jquery.html) 03:26:01 INFO - PID 26531 | RSS: Main: 184061952 03:26:01 INFO - PID 26531 | 03:29:03 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52911/tests/dromaeo/cssquery-mootools.html) 03:29:03 INFO - PID 26531 | RSS: Main: 180920320 03:29:03 INFO - PID 26531 | 03:32:05 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52911/tests/dromaeo/cssquery-prototype.html) 03:32:06 INFO - PID 26531 | RSS: Main: 185331712 03:32:06 INFO - PID 26531 | 03:35:09 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52911/tests/dromaeo/cssquery-yui.html) 03:35:09 INFO - PID 26531 | RSS: Main: 184061952 03:35:09 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | Cycle 1(1): loaded http://localhost:52911/tests/dromaeo/cssquery-yui.html (next: http://localhost:52911/tests/dromaeo/cssquery-dojo.html) 03:38:11 INFO - PID 26531 | RSS: Main: 181620736 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | __start_tp_report 03:38:11 INFO - PID 26531 | _x_x_mozilla_page_load 03:38:11 INFO - PID 26531 | _x_x_mozilla_page_load_details 03:38:11 INFO - PID 26531 | |i|pagename|runs| 03:38:11 INFO - PID 26531 | |0;dojo.html;2709.458108378324;2715.4840580289733;2731.5902614607808;2749.1615057407494;2752.2844060544253;5206.843794686156;5225.712585807779;5254.605904557155;5257.132573125435;5290.4180540140605;5171.17261238202;5271.736413179336;5282.630215884889;5290.206469029647;5372.7045012524295;4471.8231771924175;4665.9766701166445;4681.438227412716;4707.270373092159;4721.2918062290755;4693.436787585478;4727.409073865767;4727.763611819412;4748.3827102476625;4768.070226305872;4595.149897269016;4612.976935115303;4664.580187783082;4714.457837348715;4715.929261061086;4705.3647757552635;4727.149113159629;4749.786259618326;4762.2380419133115;4790.784414701347;4640.257558790611;4665.86002419928;4695.131400690849;4705.905881882343;4707;5171.612129090333;5261.000409922102;5288.1538953767595;5293.100172970604;5334.013207556614;5620.353659329188;5731.168980497804;5767.048437007888;5767.0772676372;5770.7691692332255;5759.049756790125;5761.683107429089;5762.855928601818;5763.538916886639;5765.1352297155345;5271.815486457956;5354.625176237704;5357.464253574689;5361.383440904346;5363.785448582091;5796.449337312949;5871.178035075093;5888.352281249059;5903;5912.201852749909;5518.558515318765;5525.778968841281;5537.501624853702;5571.331440227118;5583.35791383996;5452.6183167177915;5603.411641777636;5620.887582248332;5622.297212848394;5625.634333768292;5545;5608.551315894719;5619.606627536034;5629.493345598916;5650.124230744241;5662.801801936913;5699.059655156935;5700.800471983461;5725.5133313667975;5736.77052917887;4732.455767586772;4735.171345014609;4737.95262047382;4754.95245047552;4789.784459699322;4029.395590661424;4063.0858056937545;4071.9389209161886;4073.042834933788;4091.5090189176894;4688.249880019181;4729;4831.879203019953;4857.052874689472;4866.148424025781;5704.144378343199;5715.571332150105;5729.799457018984;5734.16854556087;5737.598368114275;4774.3077253798;4777;4778.904421911542;4790.520947905182;4820.927686084711;4960;4978.701277923264;4986.002799440126;5027.396712394536;5057.696538207646;5264.947350526446;5269.525742683177;5270.8155214567305;5295.443978382368;5308.575313974796;5668.801591944262;5714.542836572981;5734.05388110957;5735.627184233012;5744.281964754406;5168.147255702767;5214.634975551827;5320.095583750849;5321.574274057989;5327.9733601331745;5560.165975103605;5688.943110568841;5696.401877802937;5698.0598201296325;5703.800366987136;5613.410591887793;5654.943450565442;5670.659760414388;5749.8562535936935;5780.421957804186;5468.781248750005;5476.534494568006;5477.643953143033;5494.36814766307;5515.696636685021;5469.480399362054;5470.972645136908;5473.096939005179;5474.0146773579545;5474.178873169057;5353.759080841293;5376.166694162254;5426.538744206787;5457.099578569491;5466.480684335141;5555.194496797861;5575.581831362583;5593.300837395325;5595.272614560081;5608.158776183442;5390.110631745875;5431.022415965006;5436.103042997861;5440.102383106743;5440.129579267298 03:38:11 INFO - PID 26531 | |1;ext.html;673.5117040145894;717.5300178383159;734.3170851108467;1185.123008973359;1260.2312589320518;33543.49684754731;34542.82728586357;34625.65374346256;34654.65345346546;34773.826130869376;33154.83422582884;33447;33510.32979340412;33566.66433335666;33619.66380336202;6397.936020639792;6510.6744662766905;6543.312952140028;6698.698558564876;6710.899336509956;6740.93259067408;6831.248562658104;6832.385085342318;6835.043093966849;6837.726490940381;6794.218664853531;6831.419329357011;6839.760608378708;6850.280720524348;6860.5197636165485;6769.289224631392;6804.217514985766;6810.795676129724;6833.145856767904;6839.281875403086;6745.0556922030955;6783.084283621746;6816;6818.249992500821;6822.976553516963;30887.845560772053;31054.223644408845;31286.21784455384;31319.37361252785;31489.37021259562;3025.8789648414036;3054.0379780369335;3063.1729433053174;3067.7239048485744;3072.815631062121;24115.397115072086;24189.516209675883;24366.39084022896;24376.268711938672;24431.389215269584;3059.4645936961165;3086.861091250899;3102.612173478315;3152.133163380066;3172.0959526535057;119074;120392;137909;138059;139626.30186849102;37408.25183496315;37675.434868476994;37855;37937.62062379341;37944.810275948446;38784;39324.803375982934;39349.60650393459;39389.40915886264;39443.40834887479;11359.375234362189;11389.544418223344;11397.772044559228;11447.771044579062;11505.079593632488;9042.593083311267;9070.773230669287;9085.091490850995;9133.315001374924;9143.405678630868;11926.224795388272;12023.21849079807;12087.274763514217;12104.394780260951;12191.939040304742;5028.195488721787;5113.897722045613;5143.5627971622835;5207.4011488678525;5253.632245742838;868.2359523619175;905.117510427328;922.8154369126067;925.2644147902433;953.8616900549381;19982.70025949612;20371.4907127323;21117.366479005654;21339.46651333729;21563.353099407042;985.669800616787;990.4453506036642;999.695092996643;1010.6715317521835;1016.1261315268863;10933.18001149917;11350.829737553944;11355.954044864768;11390.943045284721;11505.539778408938;175326;175473.12263438856;176576;176778;177124;40044.59955400409;40408.79795601062;40433.797831011245;40434.191316173514;40582.1883562333;1192.6555973830282;1225.8835410635975;1234.7098431868503;1244.7074937389707;1245.3897590180745;19717.309894153637;19951;20427.08078136517;21275.68086478735;21389.14443422308;29423;29501.557476638296;29515.262118447212;29521.409571808013;29534;146838;148461;148533;148552.25723871312;148657;27799.166025019284;27815.582766258118;28737.425251494435;29426.264343391587;29480.2311861289;35857.282854342244;35900.461493077106;35918.28163436664;35919.82040089783;35938.64061359353;25284.747152528238;26562.86718566395;27181.456370872867;27623;27923.860380698778;26353.736462635894;26820.8658956704;27329.180124596292;27632.171034868985;28056.859715701292;30345;30509.694903050684;30672.386552268385;30692.232694182825;30784.53823192699;26277.60583591286;26297.21108366752;26967.730322696523;27299.590506142027;27729.584056238768;21382.465438364165;21839;22056.228032018804;22353.888230558743;22413.43966400853 03:38:11 INFO - PID 26531 | |2;jquery.html;391.1609597413549;392.7388286789285;407.4194273160747;409.6170080974291;428.5650065183839;12226.755464890697;12365.938170309159;16859.409920652764;17671.116444177787;17675.558111047216;12356.752864942695;17891.552711182194;18058.909705451453;18113.366032188875;18207.726884096748;5147.433782283946;5419;5420.051490989081;5421.457854214586;5430.131179011359;5075.9746201268945;5134.435212126663;5181.378234611851;5272.103742363788;5354.946450535484;5148.5881129509735;5151.922721159167;5152.072626927152;5158.896822063556;5159.432462429129;4967.925481117786;5058.822941197077;5142.562882155022;5148.021875843597;5158.742062896859;4528.411306530163;4533.320001999694;4548.385967894358;4568.771561421949;4570.360149579062;20623.484412889648;20764.169433222654;20788;21054.578908421747;21107.26124585632;1527.335609010073;1547.0331043098063;1552.2161308539116;1566.2951671747646;1597.4488801363627;13846.723065538734;14015.43938242469;14095.2952352383;14119.78820317696;14245.572632821031;1999;2016.314453085958;2045.3454894433787;2055.3011975928257;2057.5781964697203;86631.56684216602;88447.55776221142;90830.545847271;95150;98617.50691246497;10156.542955567018;10185.847212291821;10481.213908956859;10494.895051049545;10748.946255268673;14219;14282.714345713028;14310.427582896777;14317.284135793168;14376.137431754129;6449.645269510222;6628.767993120217;6680.96659516709;6942.7222911084;6981.511294209458;6280.899042221877;6285.277193122758;6436.903446448307;6441.613503189824;6449.451796597248;6430.099786029959;6544.672766361663;6606.900896486556;6632.834179145463;6756.932430675729;1867.6918308478948;1882.6422979633826;1894.5547796267865;1900.477368723612;2000.0999550202175;823.222055157882;861.4028703459076;874.6588830356167;888.9066248983679;893.5532233883058;16295.83704162967;16371.427000055179;16894.324227030782;17088.57278568046;17381.82618173802;877.903430622631;879.6613303878053;881.5768431152954;896.1307531694246;896.8430524658158;8802.295816334678;9376.249900007982;9385.108414700593;9508.049195080437;10916.945415273032;400758;401807;402253;411570;418737;77944;78157.21842781613;78397.216027839;79683;82406.17593824105;1066.099146221426;1093.5461783359976;1119.3955264157428;1126.8422420861086;1128.1651577832345;16985.40551080706;17234.310627575258;17796.021218833088;17830.286788528832;17953.192106354985;37474.43788343122;37585.2482950334;38210.80894595509;39258.607413926635;39761.20477590374;44546.55453445424;44979.32531011972;45200.547994519635;45205.547944520134;46454.53545464502;7833.295003449717;7870.173631768582;8002.679892804223;8012.198780121941;8099.514029158269;11612.709682258012;12132.636020919386;12197.634070977885;12437.564685235973;12746.617601471971;9632.614695412385;9724.173445257233;9795.314327997257;9808.85286720714;10013.349132306377;9619.615215391586;9675.951620241854;10317.27779055459;10351.120154786928;10541.525631346762;9526.285528585246;9878.209743220668;9921.206303495848;10138.391696498235;10184.949075254577;7598.658060387185;7604.961975190088;7676.270754278335;7706.884396733942;7719.073711154698;8838;8950.552472376485;8956;8998.59506322204;9137.817243655223 03:38:11 INFO - PID 26531 | |3;mootools.html;1236.8082947143191;1275.158395458997;1278.4758249117858;1284.8650891656375;1289.439093994112;9801.509924503773;10063.949680251606;10334.1732661387;10367.844482332772;10409.5315710793;10269.486525673723;10409.5315710793;10459.529321180546;10473.581056757721;10476.52855621497;2211.1266049910278;2243.596152692515;2253.7182852143483;2262.739784924738;2265.161890100657;2176.379731776444;2214.1143542582936;2215.9224427145055;2216.966745498819;2219.9778002220014;2084.9478763030893;2107.957840843182;2115.6614941609346;2124.9043793029273;2132.093860109455;2072.7409073865765;2098.8320934325216;2102.3272552783114;2103.316422162803;2106.2101711858054;1864.1424944525534;1920.3470819921295;2006.388051644248;2038.4088614301984;2156.4608847788054;10101.090901818798;10179.949100254451;10180.338278011906;10186.643467478603;10201.693949181536;5508.3114610673665;5704.058830292996;5718.456746609066;5739.540836733093;5748.022836117828;3218.5494030835703;3269.395161895033;3323.9169020774434;3329.200991761984;3349.363620912043;1055.482813421418;1064.542246833861;1077.1921059205595;1109.6171820721838;1121.0975164992178;14765.630859228499;14842.55472335821;14894.851051489455;14945.40218391263;14970.401183952628;4696.2955556666775;4772.3557319761385;4866.805327786919;4872.8781780455065;4914.410270767531;11001.449927503752;11010.449477526092;11023.228374013743;11026.944865275622;11030.28303160292;5451.700156491352;5550.91673624896;5556;5556.86107847299;5559.416261292587;5106.565941894906;5121.231815227671;5155.200943853709;5162.483751624807;5166.870828229325;3866.7873266970587;3912.628300311466;3915.7063220258024;3981.203759248162;4001.47980762499;1060.607575197182;1061.5806756331206;1070.6841481762742;1077.6982444915436;1078.741102135482;702.0978043214445;726.4370113162341;727.9490435669452;731.3527528137637;740.9036825212688;5461.344638643309;5556.888862222733;5614.85962850932;5653.23681303027;5679.716014199274;495.07174048658766;839.546644811807;841.6507149532875;849.7960489482604;854.1885209051426;3727.5340582427198;3809.8095095245126;3848.3265428549894;3855.857476156923;3860.749051311656;12834.486620535261;13062.673433164247;13359.599212023655;13396.531121410704;13522.053456258163;12875.871241287467;13255.867441325656;13265.734685306239;13440.126391784503;13547.66130846717;7304.160021597478;7453.515521491194;7462.403007759366;7481.251874812475;7484.326410622961;5543.029969755357;5591.412901645269;5653.180288858175;5663.716814159358;5727.284089488814;11976.221545599508;12005;12060.51757929673;12256.448459819152;12330.50677972871;11947.641570752543;12407.875921240671;12430.37848107573;12548.874511254771;12550.811737824122;8431.494110353398;8551.230389264996;8590;8595.699150529701;8613.526256055977;9271.443713377219;9498.287628427757;9598.66404675861;9619.663311784054;9622.566984485575;7631.275028872248;7750.689972401041;8066;8133.308668763221;8157.265846073882;7784.455088144002;7814.101378341336;7826.921730782619;7943.205679432011;8005.519668819889;6921.965390173017;7010.649467526705;7056.470764692771;7056.6471676417;7074.964625176841;4764.4282686077895;4992.375953005874;4997.650164488451;5094.1849304111165;5244.9737751310995;5291.777453469475;5328.413874473882;5378.273933019149;5440.945590544202;5617.269754931996 03:38:11 INFO - PID 26531 | |4;prototype.html;339.0320634588249;340.24126198577187;380.0403979950626;380.4882433127444;382.6919329939399;5456.672599644019;5509.449055094488;5523.861903452415;5535.944640553594;5536.916946245805;5280.8910128872885;5365.195220716894;5374.91937620935;5379.946200537994;5394.406615272317;4057.214825476781;4105.815238314275;4112.506499220098;4119.382092686106;4128.360104183841;4081.3061779497557;4086.6730661547003;4103.958960410388;4108.993296642327;4140.958590414088;4057.3913912913004;4057.797110144481;4073.065293985348;4075.4498142750645;4082.265192265391;3993.9001524961964;4054.3513037914086;4073.327900896378;4075.9592404076025;4105.096878686684;3558.768680035789;3561.6438356164435;3565.447355659877;3566.35805555;3585.784852908808;5269.552088072518;5293.788248470057;5307.495787900143;5312.707801070939;5333.973330133364;4656.604188643969;4707.741074240916;4768.904621907577;4779.545943135397;4795.472498025214;5713.771449142029;5744.913826292609;5747.281589801275;5748.42515748426;5748.568857335675;3978.6419222270133;3992.301347264246;4007.8377270591495;4008.158286759784;4013.177298653769;5820.82537523875;5854.7072646367515;6044.304904935944;6066;6148.7233074511305;4044.3529035354204;4085.6935729820384;4095.6313931746286;4095.7337773044655;4104.281750693616;4136.689748268832;4136.91726165475;4148.253314403436;4152.43942067823;4152.480939882515;4684.578387945101;4725.243960966229;4773.260144677511;4786.44955830077;4791.5687588117235;5759.827205183768;5791.189233507313;5796.536277097822;5827.825165245049;5836.4747172753805;1381.6891199480237;1393.5958572014206;1394.0868730981224;1402.2287741742;1404.599689088605;866.6793286483916;908.9909100909039;909.8391320613542;912.2473958983865;921.7142086788892;4958.7024778513405;4986.426560945538;4986.925196122061;4989.476105008995;5010.699358038456;5924.170616113662;5938.524918006549;5988.970055149696;6014.51883849291;6027.457528822427;4795.568398844121;4893;4898.53463920927;4915.8033678652455;4948.604111671058;3139.8587063582195;3185.5380969759717;3200.1679563313705;3203.47142721453;3204.6955539223736;5458;5509.283793106871;5510.586705997066;5513.558915286848;5520.199571062173;5902.557308201816;6158.753649854045;6195.597286176384;6226;6231.781887634002;5537.473939975695;5552.444755524496;5562.193481945176;5569.10894256917;5571.860703482445;5715.542756579381;5949.19685842423;5987.670678112746;6040;6078.422549857756;5905.438983296752;5931.406859314034;5955.493783028491;5962.850928726816;5990.730417131327;5314.813981510629;5452.318460192476;5465.863353416196;5472;5510.283663123929;3935.2129574084724;3966.147278335172;3980.084580546433;3982.8406863725127;3989.3617021276455;5949.791757288474;6015.405917431796;6061.181740465157;6077.453029227391;6083.969580152071;5809.2738407699035;5836.445537673914;5854.941450585439;5866.882662346815;5889.734961926638;5731.885362292647;5749.7125143741805;5788.53691704671;5819.941800582109;5838.386969368155;5643.802466913638;5726.284214473191;5733.9713301434895;5765.769369225184;5768.336641286306;5864.912026319524;5869.4717475425705;5869.882602347844;5883.235179426647;5894.705264736832;5626.493615574454;5667.846218436967;5715.942260786197;5731.283589551306;5741.16753070794 03:38:11 INFO - PID 26531 | |5;yui.html;741.9480636355457;750.8610906982209;767.834915493169;768.4428789127883;789.1004255149129;13751.793723094162;14510.782338264922;14561.635959101028;15767.448139315125;15897.52307430776;16446.61524079011;16452.67094658106;16626.66746665066;16632.66734665306;16638.168091595402;878.7759121424044;898.6854600889702;904.3307952115421;905.1988989744091;908.8773015642903;839.890814194157;855.9358048146382;864.7449002544233;865.3250464637562;895.1853813030144;933.0529512544772;935.111643938258;936.6955739384694;937.2455173585261;938.3431597881477;926.9907300926972;928.3176865004217;930.8045310484806;931.3759780946748;931.5435436636;687.1719577908608;689.5552368722147;691.2051141187624;691.3294104718466;692.6432887063116;14594.270286485633;14934.25328733559;15083.095014299068;15167.62080947974;15169.24153792317;13917;14275.857241427557;14321.069130506483;14346.856531434762;14477.78283325751;12289.078319126102;12312.692182695415;12345.5061797528;12559.309237991907;12620;2865.298001989505;2888.292368369742;2892.5082735934943;2894.52240380337;2903.332233586266;80830;82998.58500707518;83582.58208708979;83979;84494.99999999939;12817.423215955305;13059.869401305865;13086.2802545859;13170.275634839983;13195.406206720529;22738.43153921165;23647.408814779767;23902.88048559781;23985.04059837587;24015.51968960611;6179.752809887644;6253.843653908689;6257.530685198628;6324.3991820776955;6342.460890824239;2668.3595936974984;2711.552593821997;2715.83704977698;2746.0800631788575;2767.3220061085162;3833.7124715646437;3881.708871834567;3916.3538016227003;3922.646961773454;3941.625545573166;704.4962851561158;708.3801673535656;712.9500934934505;714;717;600.099850224663;612.7548980407784;614.1954040207343;631.6115588912877;640.452413186728;9561.378510396802;10112.747181320527;10536.525856336484;10826.729331766612;11199.384033878052;622.9750809967641;629.9527535434769;630.3664816859119;634.5241069198102;648.9740410383627;4527.615152712056;4585.95414045862;4627.722336659811;4742.075295317449;4754.952450475451;84559;86052.56973715092;86271;86672;88017;75172.62413687896;75179;75528.24471755321;77049.45901082059;79143.20856791474;53943.730281347554;57172.71413642988;58958.41041589615;59354.70322648445;64834.67582662151;9447.763805904633;10045;10266.230032747424;10275.588976441157;10320.174386048948;27320;27588.586171207848;27662.170134895987;27907.72092279051;28878.278043049093;51024;52042.47957520376;52317;53199.468005321;53416.732916336725;13803.378847952066;13809.51666691661;13881.583552493441;14308.141511509342;14348.641283967985;15668.294926728096;16044.358225670843;16283.674326513641;17439.82560174382;17504.387346442814;13831.100978436369;13860.861391386361;13904.51334203298;14039.649008774863;14284.285785710465;14188.36152373125;14567.125972441687;14653.853461465249;14664.046836955564;14950.327235274657;13043.413046413123;13083.542076027294;13200.273984930922;13276.402561884932;13349.199048057148;9874.308798384043;10010.64962726301;10091.646792362231;10095.091441770275;10240.180785537288;10070.144037756872;10116.747081323027;10500.317479363817;10670.73323166927;10697.679069627924 03:38:11 INFO - PID 26531 | __end_tp_report 03:38:11 INFO - PID 26531 | __start_cc_report 03:38:11 INFO - PID 26531 | _x_x_mozilla_cycle_collect,385 03:38:11 INFO - PID 26531 | __end_cc_report 03:38:11 INFO - PID 26531 | __startTimestamp1495881491599__endTimestamp 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | ------- Summary: start ------- 03:38:11 INFO - PID 26531 | Number of tests: 6 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#0] dojo.html Cycles:165 Average:5191.04 Median:5357.46 stddev:617.26 (11.5%) stddev-sans-first:587.65 03:38:11 INFO - PID 26531 | Values: 2709.5 2715.5 2731.6 2749.2 2752.3 5206.8 5225.7 5254.6 5257.1 5290.4 5171.2 5271.7 5282.6 5290.2 5372.7 4471.8 4666.0 4681.4 4707.3 4721.3 4693.4 4727.4 4727.8 4748.4 4768.1 4595.1 4613.0 4664.6 4714.5 4715.9 4705.4 4727.1 4749.8 4762.2 4790.8 4640.3 4665.9 4695.1 4705.9 4707.0 5171.6 5261.0 5288.2 5293.1 5334.0 5620.4 5731.2 5767.0 5767.1 5770.8 5759.0 5761.7 5762.9 5763.5 5765.1 5271.8 5354.6 5357.5 5361.4 5363.8 5796.4 5871.2 5888.4 5903.0 5912.2 5518.6 5525.8 5537.5 5571.3 5583.4 5452.6 5603.4 5620.9 5622.3 5625.6 5545.0 5608.6 5619.6 5629.5 5650.1 5662.8 5699.1 5700.8 5725.5 5736.8 4732.5 4735.2 4738.0 4755.0 4789.8 4029.4 4063.1 4071.9 4073.0 4091.5 4688.2 4729.0 4831.9 4857.1 4866.1 5704.1 5715.6 5729.8 5734.2 5737.6 4774.3 4777.0 4778.9 4790.5 4820.9 4960.0 4978.7 4986.0 5027.4 5057.7 5264.9 5269.5 5270.8 5295.4 5308.6 5668.8 5714.5 5734.1 5735.6 5744.3 5168.1 5214.6 5320.1 5321.6 5328.0 5560.2 5688.9 5696.4 5698.1 5703.8 5613.4 5654.9 5670.7 5749.9 5780.4 5468.8 5476.5 5477.6 5494.4 5515.7 5469.5 5471.0 5473.1 5474.0 5474.2 5353.8 5376.2 5426.5 5457.1 5466.5 5555.2 5575.6 5593.3 5595.3 5608.2 5390.1 5431.0 5436.1 5440.1 5440.1 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#1] ext.html Cycles:180 Average:29403.66 Median:16870.06 stddev:39495.24 (234.1%) stddev-sans-first:39547.12 03:38:11 INFO - PID 26531 | Values: 673.5 717.5 734.3 1185.1 1260.2 33543.5 34542.8 34625.7 34654.7 34773.8 33154.8 33447.0 33510.3 33566.7 33619.7 6397.9 6510.7 6543.3 6698.7 6710.9 6740.9 6831.2 6832.4 6835.0 6837.7 6794.2 6831.4 6839.8 6850.3 6860.5 6769.3 6804.2 6810.8 6833.1 6839.3 6745.1 6783.1 6816.0 6818.2 6823.0 30887.8 31054.2 31286.2 31319.4 31489.4 3025.9 3054.0 3063.2 3067.7 3072.8 24115.4 24189.5 24366.4 24376.3 24431.4 3059.5 3086.9 3102.6 3152.1 3172.1 119074.0 120392.0 137909.0 138059.0 139626.3 37408.3 37675.4 37855.0 37937.6 37944.8 38784.0 39324.8 39349.6 39389.4 39443.4 11359.4 11389.5 11397.8 11447.8 11505.1 9042.6 9070.8 9085.1 9133.3 9143.4 11926.2 12023.2 12087.3 12104.4 12191.9 5028.2 5113.9 5143.6 5207.4 5253.6 868.2 905.1 922.8 925.3 953.9 19982.7 20371.5 21117.4 21339.5 21563.4 985.7 990.4 999.7 1010.7 1016.1 10933.2 11350.8 11356.0 11390.9 11505.5 175326.0 175473.1 176576.0 176778.0 177124.0 40044.6 40408.8 40433.8 40434.2 40582.2 1192.7 1225.9 1234.7 1244.7 1245.4 19717.3 19951.0 20427.1 21275.7 21389.1 29423.0 29501.6 29515.3 29521.4 29534.0 146838.0 148461.0 148533.0 148552.3 148657.0 27799.2 27815.6 28737.4 29426.3 29480.2 35857.3 35900.5 35918.3 35919.8 35938.6 25284.7 26562.9 27181.5 27623.0 27923.9 26353.7 26820.9 27329.2 27632.2 28056.9 30345.0 30509.7 30672.4 30692.2 30784.5 26277.6 26297.2 26967.7 27299.6 27729.6 21382.5 21839.0 22056.2 22353.9 22413.4 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#2] jquery.html Cycles:180 Average:25511.43 Median:24866.98 stddev:67614.90 (271.9%) stddev-sans-first:67778.28 03:38:11 INFO - PID 26531 | Values: 391.2 392.7 407.4 409.6 428.6 12226.8 12365.9 16859.4 17671.1 17675.6 12356.8 17891.6 18058.9 18113.4 18207.7 5147.4 5419.0 5420.1 5421.5 5430.1 5076.0 5134.4 5181.4 5272.1 5354.9 5148.6 5151.9 5152.1 5158.9 5159.4 4967.9 5058.8 5142.6 5148.0 5158.7 4528.4 4533.3 4548.4 4568.8 4570.4 20623.5 20764.2 20788.0 21054.6 21107.3 1527.3 1547.0 1552.2 1566.3 1597.4 13846.7 14015.4 14095.3 14119.8 14245.6 1999.0 2016.3 2045.3 2055.3 2057.6 86631.6 88447.6 90830.5 95150.0 98617.5 10156.5 10185.8 10481.2 10494.9 10748.9 14219.0 14282.7 14310.4 14317.3 14376.1 6449.6 6628.8 6681.0 6942.7 6981.5 6280.9 6285.3 6436.9 6441.6 6449.5 6430.1 6544.7 6606.9 6632.8 6756.9 1867.7 1882.6 1894.6 1900.5 2000.1 823.2 861.4 874.7 888.9 893.6 16295.8 16371.4 16894.3 17088.6 17381.8 877.9 879.7 881.6 896.1 896.8 8802.3 9376.2 9385.1 9508.0 10916.9 400758.0 401807.0 402253.0 411570.0 418737.0 77944.0 78157.2 78397.2 79683.0 82406.2 1066.1 1093.5 1119.4 1126.8 1128.2 16985.4 17234.3 17796.0 17830.3 17953.2 37474.4 37585.2 38210.8 39258.6 39761.2 44546.6 44979.3 45200.5 45205.5 46454.5 7833.3 7870.2 8002.7 8012.2 8099.5 11612.7 12132.6 12197.6 12437.6 12746.6 9632.6 9724.2 9795.3 9808.9 10013.3 9619.6 9676.0 10317.3 10351.1 10541.5 9526.3 9878.2 9921.2 10138.4 10184.9 7598.7 7605.0 7676.3 7706.9 7719.1 8838.0 8950.6 8956.0 8998.6 9137.8 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#3] mootools.html Cycles:180 Average:6265.40 Median:3829.07 stddev:4061.19 (106.1%) stddev-sans-first:4055.01 03:38:11 INFO - PID 26531 | Values: 1236.8 1275.2 1278.5 1284.9 1289.4 9801.5 10063.9 10334.2 10367.8 10409.5 10269.5 10409.5 10459.5 10473.6 10476.5 2211.1 2243.6 2253.7 2262.7 2265.2 2176.4 2214.1 2215.9 2217.0 2220.0 2084.9 2108.0 2115.7 2124.9 2132.1 2072.7 2098.8 2102.3 2103.3 2106.2 1864.1 1920.3 2006.4 2038.4 2156.5 10101.1 10179.9 10180.3 10186.6 10201.7 5508.3 5704.1 5718.5 5739.5 5748.0 3218.5 3269.4 3323.9 3329.2 3349.4 1055.5 1064.5 1077.2 1109.6 1121.1 14765.6 14842.6 14894.9 14945.4 14970.4 4696.3 4772.4 4866.8 4872.9 4914.4 11001.4 11010.4 11023.2 11026.9 11030.3 5451.7 5550.9 5556.0 5556.9 5559.4 5106.6 5121.2 5155.2 5162.5 5166.9 3866.8 3912.6 3915.7 3981.2 4001.5 1060.6 1061.6 1070.7 1077.7 1078.7 702.1 726.4 727.9 731.4 740.9 5461.3 5556.9 5614.9 5653.2 5679.7 495.1 839.5 841.7 849.8 854.2 3727.5 3809.8 3848.3 3855.9 3860.7 12834.5 13062.7 13359.6 13396.5 13522.1 12875.9 13255.9 13265.7 13440.1 13547.7 7304.2 7453.5 7462.4 7481.3 7484.3 5543.0 5591.4 5653.2 5663.7 5727.3 11976.2 12005.0 12060.5 12256.4 12330.5 11947.6 12407.9 12430.4 12548.9 12550.8 8431.5 8551.2 8590.0 8595.7 8613.5 9271.4 9498.3 9598.7 9619.7 9622.6 7631.3 7750.7 8066.0 8133.3 8157.3 7784.5 7814.1 7826.9 7943.2 8005.5 6922.0 7010.6 7056.5 7056.6 7075.0 4764.4 4992.4 4997.7 5094.2 5245.0 5291.8 5328.4 5378.3 5440.9 5617.3 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#4] prototype.html Cycles:180 Average:4737.17 Median:5423.36 stddev:1427.98 (26.3%) stddev-sans-first:1393.31 03:38:11 INFO - PID 26531 | Values: 339.0 340.2 380.0 380.5 382.7 5456.7 5509.4 5523.9 5535.9 5536.9 5280.9 5365.2 5374.9 5379.9 5394.4 4057.2 4105.8 4112.5 4119.4 4128.4 4081.3 4086.7 4104.0 4109.0 4141.0 4057.4 4057.8 4073.1 4075.4 4082.3 3993.9 4054.4 4073.3 4076.0 4105.1 3558.8 3561.6 3565.4 3566.4 3585.8 5269.6 5293.8 5307.5 5312.7 5334.0 4656.6 4707.7 4768.9 4779.5 4795.5 5713.8 5744.9 5747.3 5748.4 5748.6 3978.6 3992.3 4007.8 4008.2 4013.2 5820.8 5854.7 6044.3 6066.0 6148.7 4044.4 4085.7 4095.6 4095.7 4104.3 4136.7 4136.9 4148.3 4152.4 4152.5 4684.6 4725.2 4773.3 4786.4 4791.6 5759.8 5791.2 5796.5 5827.8 5836.5 1381.7 1393.6 1394.1 1402.2 1404.6 866.7 909.0 909.8 912.2 921.7 4958.7 4986.4 4986.9 4989.5 5010.7 5924.2 5938.5 5989.0 6014.5 6027.5 4795.6 4893.0 4898.5 4915.8 4948.6 3139.9 3185.5 3200.2 3203.5 3204.7 5458.0 5509.3 5510.6 5513.6 5520.2 5902.6 6158.8 6195.6 6226.0 6231.8 5537.5 5552.4 5562.2 5569.1 5571.9 5715.5 5949.2 5987.7 6040.0 6078.4 5905.4 5931.4 5955.5 5962.9 5990.7 5314.8 5452.3 5465.9 5472.0 5510.3 3935.2 3966.1 3980.1 3982.8 3989.4 5949.8 6015.4 6061.2 6077.5 6084.0 5809.3 5836.4 5854.9 5866.9 5889.7 5731.9 5749.7 5788.5 5819.9 5838.4 5643.8 5726.3 5734.0 5765.8 5768.3 5864.9 5869.5 5869.9 5883.2 5894.7 5626.5 5667.8 5715.9 5731.3 5741.2 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | [#5] yui.html Cycles:180 Average:17660.00 Median:2898.93 stddev:23260.35 (802.4%) stddev-sans-first:23290.91 03:38:11 INFO - PID 26531 | Values: 741.9 750.9 767.8 768.4 789.1 13751.8 14510.8 14561.6 15767.4 15897.5 16446.6 16452.7 16626.7 16632.7 16638.2 878.8 898.7 904.3 905.2 908.9 839.9 855.9 864.7 865.3 895.2 933.1 935.1 936.7 937.2 938.3 927.0 928.3 930.8 931.4 931.5 687.2 689.6 691.2 691.3 692.6 14594.3 14934.3 15083.1 15167.6 15169.2 13917.0 14275.9 14321.1 14346.9 14477.8 12289.1 12312.7 12345.5 12559.3 12620.0 2865.3 2888.3 2892.5 2894.5 2903.3 80830.0 82998.6 83582.6 83979.0 84495.0 12817.4 13059.9 13086.3 13170.3 13195.4 22738.4 23647.4 23902.9 23985.0 24015.5 6179.8 6253.8 6257.5 6324.4 6342.5 2668.4 2711.6 2715.8 2746.1 2767.3 3833.7 3881.7 3916.4 3922.6 3941.6 704.5 708.4 713.0 714.0 717.0 600.1 612.8 614.2 631.6 640.5 9561.4 10112.7 10536.5 10826.7 11199.4 623.0 630.0 630.4 634.5 649.0 4527.6 4586.0 4627.7 4742.1 4755.0 84559.0 86052.6 86271.0 86672.0 88017.0 75172.6 75179.0 75528.2 77049.5 79143.2 53943.7 57172.7 58958.4 59354.7 64834.7 9447.8 10045.0 10266.2 10275.6 10320.2 27320.0 27588.6 27662.2 27907.7 28878.3 51024.0 52042.5 52317.0 53199.5 53416.7 13803.4 13809.5 13881.6 14308.1 14348.6 15668.3 16044.4 16283.7 17439.8 17504.4 13831.1 13860.9 13904.5 14039.6 14284.3 14188.4 14567.1 14653.9 14664.0 14950.3 13043.4 13083.5 13200.3 13276.4 13349.2 9874.3 10010.6 10091.6 10095.1 10240.2 10070.1 10116.7 10500.3 10670.7 10697.7 03:38:11 INFO - PID 26531 | -------- Summary: end -------- 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | 03:38:11 INFO - PID 26531 | ###!!! [Child][MessageChannel] Error: (msgtype=0x4400B1,name=PContent::Msg_ConsoleMessage) Channel closing: too late to send/recv, messages will be lost 03:38:11 INFO - PID 26531 | 03:38:12 INFO - TEST-INFO | 26531: exit 0 03:38:12 INFO - TEST-OK | dromaeo_css | took 1146475ms 03:38:12 INFO - TEST-START | kraken 03:38:12 INFO - operating with platform_type : linux_ 03:38:12 INFO - Initialising browser for kraken test... 03:38:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52911/getInfo.html -profile /tmp/tmpmtjG8n/profile 03:38:12 INFO - TEST-INFO | started process 26934 (/builds/slave/test/build/application/firefox/firefox http://localhost:52911/getInfo.html) 03:38:47 INFO - TEST-INFO | 26934: killed by SIGTERM 03:38:47 INFO - Browser initialized. 03:38:47 INFO - Running cycle 1/1 for kraken test... 03:38:47 INFO - TEST-INFO | started process 27135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtjG8n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:59 INFO - PID 27135 | RSS: Main: 183443456 03:38:59 INFO - PID 27135 | 03:39:02 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52911/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:03 INFO - PID 27135 | RSS: Main: 186085376 03:39:03 INFO - PID 27135 | 03:39:06 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52911/tests/kraken/driver.html?testName=audio-dft) 03:39:06 INFO - PID 27135 | RSS: Main: 185724928 03:39:06 INFO - PID 27135 | 03:39:09 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52911/tests/kraken/driver.html?testName=audio-fft) 03:39:10 INFO - PID 27135 | RSS: Main: 182071296 03:39:10 INFO - PID 27135 | 03:39:12 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52911/tests/kraken/driver.html?testName=audio-oscillator) 03:39:13 INFO - PID 27135 | RSS: Main: 182628352 03:39:13 INFO - PID 27135 | 03:39:15 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:15 INFO - PID 27135 | RSS: Main: 182927360 03:39:15 INFO - PID 27135 | 03:39:18 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52911/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:19 INFO - PID 27135 | RSS: Main: 183824384 03:39:19 INFO - PID 27135 | 03:39:23 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52911/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:23 INFO - PID 27135 | RSS: Main: 182870016 03:39:23 INFO - PID 27135 | 03:39:26 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52911/tests/kraken/driver.html?testName=json-parse-financial) 03:39:27 INFO - PID 27135 | RSS: Main: 183779328 03:39:27 INFO - PID 27135 | 03:39:28 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:29 INFO - PID 27135 | RSS: Main: 183943168 03:39:29 INFO - PID 27135 | 03:39:31 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:32 INFO - PID 27135 | RSS: Main: 183431168 03:39:32 INFO - PID 27135 | 03:39:34 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:34 INFO - PID 27135 | RSS: Main: 183320576 03:39:34 INFO - PID 27135 | 03:39:37 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:38 INFO - PID 27135 | RSS: Main: 183357440 03:39:38 INFO - PID 27135 | 03:39:41 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:42 INFO - PID 27135 | RSS: Main: 183463936 03:39:42 INFO - PID 27135 | 03:39:43 INFO - PID 27135 | Cycle 1(1): loaded http://localhost:52911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52911/tests/kraken/driver.html?testName=ai-astar) 03:39:44 INFO - PID 27135 | RSS: Main: 184713216 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | __start_tp_report 03:39:44 INFO - PID 27135 | _x_x_mozilla_page_load 03:39:44 INFO - PID 27135 | _x_x_mozilla_page_load_details 03:39:44 INFO - PID 27135 | |i|pagename|runs| 03:39:44 INFO - PID 27135 | |0;ai-astar;105;110;111;110;109;111;111;111;110;112 03:39:44 INFO - PID 27135 | |1;audio-beat-detection;152;133;125;177;128;129;122;123;147;123 03:39:44 INFO - PID 27135 | |2;audio-dft;164;165;164;167;168;172;168;165;164;163 03:39:44 INFO - PID 27135 | |3;audio-fft;73;75;74;101;74;76;74;75;94;74 03:39:44 INFO - PID 27135 | |4;audio-oscillator;86;83;98;83;83;82;102;85;83;105 03:39:44 INFO - PID 27135 | |5;imaging-gaussian-blur;114;114;116;114;114;114;114;114;113;114 03:39:44 INFO - PID 27135 | |6;imaging-darkroom;150;151;151;151;150;150;151;151;151;151 03:39:44 INFO - PID 27135 | |7;imaging-desaturate;95;96;94;95;94;94;94;95;95;95 03:39:44 INFO - PID 27135 | |8;json-parse-financial;55;55;54;56;56;55;58;56;56;55 03:39:44 INFO - PID 27135 | |9;json-stringify-tinderbox;56;56;55;57;57;57;56;56;57;56 03:39:44 INFO - PID 27135 | |10;stanford-crypto-aes;87;88;89;87;87;87;87;88;114;88 03:39:44 INFO - PID 27135 | |11;stanford-crypto-ccm;138;140;134;138;144;134;130;135;139;132 03:39:44 INFO - PID 27135 | |12;stanford-crypto-pbkdf2;186;194;196;192;186;187;192;192;201;188 03:39:44 INFO - PID 27135 | |13;stanford-crypto-sha256-iterative;74;75;72;77;73;70;74;72;71;71 03:39:44 INFO - PID 27135 | __end_tp_report 03:39:44 INFO - PID 27135 | __start_cc_report 03:39:44 INFO - PID 27135 | _x_x_mozilla_cycle_collect,1004 03:39:44 INFO - PID 27135 | __end_cc_report 03:39:44 INFO - PID 27135 | __startTimestamp1495881584180__endTimestamp 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | ------- Summary: start ------- 03:39:44 INFO - PID 27135 | Number of tests: 14 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:0.88 03:39:44 INFO - PID 27135 | Values: 105.0 110.0 111.0 110.0 109.0 111.0 111.0 111.0 110.0 112.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:131.00 stddev:17.75 (13.5%) stddev-sans-first:17.84 03:39:44 INFO - PID 27135 | Values: 152.0 133.0 125.0 177.0 128.0 129.0 122.0 123.0 147.0 123.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:2.75 (1.7%) stddev-sans-first:2.82 03:39:44 INFO - PID 27135 | Values: 164.0 165.0 164.0 167.0 168.0 172.0 168.0 165.0 164.0 163.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#3] audio-fft Cycles:10 Average:79.00 Median:74.50 stddev:9.92 (13.3%) stddev-sans-first:10.28 03:39:44 INFO - PID 27135 | Values: 73.0 75.0 74.0 101.0 74.0 76.0 74.0 75.0 94.0 74.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:8.97 (10.8%) stddev-sans-first:9.45 03:39:44 INFO - PID 27135 | Values: 86.0 83.0 98.0 83.0 83.0 82.0 102.0 85.0 83.0 105.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:39:44 INFO - PID 27135 | Values: 114.0 114.0 116.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 03:39:44 INFO - PID 27135 | Values: 150.0 151.0 151.0 151.0 150.0 150.0 151.0 151.0 151.0 151.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:39:44 INFO - PID 27135 | Values: 95.0 96.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 03:39:44 INFO - PID 27135 | Values: 55.0 55.0 54.0 56.0 56.0 55.0 58.0 56.0 56.0 55.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 03:39:44 INFO - PID 27135 | Values: 56.0 56.0 55.0 57.0 57.0 57.0 56.0 56.0 57.0 56.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:87.50 stddev:8.39 (9.6%) stddev-sans-first:8.82 03:39:44 INFO - PID 27135 | Values: 87.0 88.0 89.0 87.0 87.0 87.0 87.0 88.0 114.0 88.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:138.00 stddev:4.17 (3.0%) stddev-sans-first:4.38 03:39:44 INFO - PID 27135 | Values: 138.0 140.0 134.0 138.0 144.0 134.0 130.0 135.0 139.0 132.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:192.00 stddev:4.84 (2.5%) stddev-sans-first:4.72 03:39:44 INFO - PID 27135 | Values: 186.0 194.0 196.0 192.0 186.0 187.0 192.0 192.0 201.0 188.0 03:39:44 INFO - PID 27135 | 03:39:44 INFO - PID 27135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.50 stddev:2.13 (2.9%) stddev-sans-first:2.22 03:39:44 INFO - PID 27135 | Values: 74.0 75.0 72.0 77.0 73.0 70.0 74.0 72.0 71.0 71.0 03:39:44 INFO - PID 27135 | -------- Summary: end -------- 03:39:44 INFO - PID 27135 | 03:39:45 INFO - TEST-INFO | 27135: exit 0 03:39:45 INFO - TEST-OK | kraken | took 92854ms 03:39:45 INFO - SUITE-END | took 1239s 03:39:45 INFO - Completed test suite (00:20:39) 03:39:45 INFO - javascript benchmark 03:39:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6680.585875407507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2709.458108378324, 2715.4840580289733, 2731.5902614607808, 2749.1615057407494, 2752.2844060544253, 5206.843794686156, 5225.712585807779, 5254.605904557155, 5257.132573125435, 5290.4180540140605, 5171.17261238202, 5271.736413179336, 5282.630215884889, 5290.206469029647, 5372.7045012524295, 4471.8231771924175, 4665.9766701166445, 4681.438227412716, 4707.270373092159, 4721.2918062290755, 4693.436787585478, 4727.409073865767, 4727.763611819412, 4748.3827102476625, 4768.070226305872, 4595.149897269016, 4612.976935115303, 4664.580187783082, 4714.457837348715, 4715.929261061086, 4705.3647757552635, 4727.149113159629, 4749.786259618326, 4762.2380419133115, 4790.784414701347, 4640.257558790611, 4665.86002419928, 4695.131400690849, 4705.905881882343, 4707.0, 5171.612129090333, 5261.000409922102, 5288.1538953767595, 5293.100172970604, 5334.013207556614, 5620.353659329188, 5731.168980497804, 5767.048437007888, 5767.0772676372, 5770.7691692332255, 5759.049756790125, 5761.683107429089, 5762.855928601818, 5763.538916886639, 5765.1352297155345, 5271.815486457956, 5354.625176237704, 5357.464253574689, 5361.383440904346, 5363.785448582091, 5796.449337312949, 5871.178035075093, 5888.352281249059, 5903.0, 5912.201852749909, 5518.558515318765, 5525.778968841281, 5537.501624853702, 5571.331440227118, 5583.35791383996, 5452.6183167177915, 5603.411641777636, 5620.887582248332, 5622.297212848394, 5625.634333768292, 5545.0, 5608.551315894719, 5619.606627536034, 5629.493345598916, 5650.124230744241, 5662.801801936913, 5699.059655156935, 5700.800471983461, 5725.5133313667975, 5736.77052917887, 4732.455767586772, 4735.171345014609, 4737.95262047382, 4754.95245047552, 4789.784459699322, 4029.395590661424, 4063.0858056937545, 4071.9389209161886, 4073.042834933788, 4091.5090189176894, 4688.249880019181, 4729.0, 4831.879203019953, 4857.052874689472, 4866.148424025781, 5704.144378343199, 5715.571332150105, 5729.799457018984, 5734.16854556087, 5737.598368114275, 4774.3077253798, 4777.0, 4778.904421911542, 4790.520947905182, 4820.927686084711, 4960.0, 4978.701277923264, 4986.002799440126, 5027.396712394536, 5057.696538207646, 5264.947350526446, 5269.525742683177, 5270.8155214567305, 5295.443978382368, 5308.575313974796, 5668.801591944262, 5714.542836572981, 5734.05388110957, 5735.627184233012, 5744.281964754406, 5168.147255702767, 5214.634975551827, 5320.095583750849, 5321.574274057989, 5327.9733601331745, 5560.165975103605, 5688.943110568841, 5696.401877802937, 5698.0598201296325, 5703.800366987136, 5613.410591887793, 5654.943450565442, 5670.659760414388, 5749.8562535936935, 5780.421957804186, 5468.781248750005, 5476.534494568006, 5477.643953143033, 5494.36814766307, 5515.696636685021, 5469.480399362054, 5470.972645136908, 5473.096939005179, 5474.0146773579545, 5474.178873169057, 5353.759080841293, 5376.166694162254, 5426.538744206787, 5457.099578569491, 5466.480684335141, 5555.194496797861, 5575.581831362583, 5593.300837395325, 5595.272614560081, 5608.158776183442, 5390.110631745875, 5431.022415965006, 5436.103042997861, 5440.102383106743, 5440.129579267298], "value": 5145.730826168827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.5117040145894, 717.5300178383159, 734.3170851108467, 1185.123008973359, 1260.2312589320518, 33543.49684754731, 34542.82728586357, 34625.65374346256, 34654.65345346546, 34773.826130869376, 33154.83422582884, 33447.0, 33510.32979340412, 33566.66433335666, 33619.66380336202, 6397.936020639792, 6510.6744662766905, 6543.312952140028, 6698.698558564876, 6710.899336509956, 6740.93259067408, 6831.248562658104, 6832.385085342318, 6835.043093966849, 6837.726490940381, 6794.218664853531, 6831.419329357011, 6839.760608378708, 6850.280720524348, 6860.5197636165485, 6769.289224631392, 6804.217514985766, 6810.795676129724, 6833.145856767904, 6839.281875403086, 6745.0556922030955, 6783.084283621746, 6816.0, 6818.249992500821, 6822.976553516963, 30887.845560772053, 31054.223644408845, 31286.21784455384, 31319.37361252785, 31489.37021259562, 3025.8789648414036, 3054.0379780369335, 3063.1729433053174, 3067.7239048485744, 3072.815631062121, 24115.397115072086, 24189.516209675883, 24366.39084022896, 24376.268711938672, 24431.389215269584, 3059.4645936961165, 3086.861091250899, 3102.612173478315, 3152.133163380066, 3172.0959526535057, 119074.0, 120392.0, 137909.0, 138059.0, 139626.30186849102, 37408.25183496315, 37675.434868476994, 37855.0, 37937.62062379341, 37944.810275948446, 38784.0, 39324.803375982934, 39349.60650393459, 39389.40915886264, 39443.40834887479, 11359.375234362189, 11389.544418223344, 11397.772044559228, 11447.771044579062, 11505.079593632488, 9042.593083311267, 9070.773230669287, 9085.091490850995, 9133.315001374924, 9143.405678630868, 11926.224795388272, 12023.21849079807, 12087.274763514217, 12104.394780260951, 12191.939040304742, 5028.195488721787, 5113.897722045613, 5143.5627971622835, 5207.4011488678525, 5253.632245742838, 868.2359523619175, 905.117510427328, 922.8154369126067, 925.2644147902433, 953.8616900549381, 19982.70025949612, 20371.4907127323, 21117.366479005654, 21339.46651333729, 21563.353099407042, 985.669800616787, 990.4453506036642, 999.695092996643, 1010.6715317521835, 1016.1261315268863, 10933.18001149917, 11350.829737553944, 11355.954044864768, 11390.943045284721, 11505.539778408938, 175326.0, 175473.12263438856, 176576.0, 176778.0, 177124.0, 40044.59955400409, 40408.79795601062, 40433.797831011245, 40434.191316173514, 40582.1883562333, 1192.6555973830282, 1225.8835410635975, 1234.7098431868503, 1244.7074937389707, 1245.3897590180745, 19717.309894153637, 19951.0, 20427.08078136517, 21275.68086478735, 21389.14443422308, 29423.0, 29501.557476638296, 29515.262118447212, 29521.409571808013, 29534.0, 146838.0, 148461.0, 148533.0, 148552.25723871312, 148657.0, 27799.166025019284, 27815.582766258118, 28737.425251494435, 29426.264343391587, 29480.2311861289, 35857.282854342244, 35900.461493077106, 35918.28163436664, 35919.82040089783, 35938.64061359353, 25284.747152528238, 26562.86718566395, 27181.456370872867, 27623.0, 27923.860380698778, 26353.736462635894, 26820.8658956704, 27329.180124596292, 27632.171034868985, 28056.859715701292, 30345.0, 30509.694903050684, 30672.386552268385, 30692.232694182825, 30784.53823192699, 26277.60583591286, 26297.21108366752, 26967.730322696523, 27299.590506142027, 27729.584056238768, 21382.465438364165, 21839.0, 22056.228032018804, 22353.888230558743, 22413.43966400853], "value": 14214.257165519259, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1609597413549, 392.7388286789285, 407.4194273160747, 409.6170080974291, 428.5650065183839, 12226.755464890697, 12365.938170309159, 16859.409920652764, 17671.116444177787, 17675.558111047216, 12356.752864942695, 17891.552711182194, 18058.909705451453, 18113.366032188875, 18207.726884096748, 5147.433782283946, 5419.0, 5420.051490989081, 5421.457854214586, 5430.131179011359, 5075.9746201268945, 5134.435212126663, 5181.378234611851, 5272.103742363788, 5354.946450535484, 5148.5881129509735, 5151.922721159167, 5152.072626927152, 5158.896822063556, 5159.432462429129, 4967.925481117786, 5058.822941197077, 5142.562882155022, 5148.021875843597, 5158.742062896859, 4528.411306530163, 4533.320001999694, 4548.385967894358, 4568.771561421949, 4570.360149579062, 20623.484412889648, 20764.169433222654, 20788.0, 21054.578908421747, 21107.26124585632, 1527.335609010073, 1547.0331043098063, 1552.2161308539116, 1566.2951671747646, 1597.4488801363627, 13846.723065538734, 14015.43938242469, 14095.2952352383, 14119.78820317696, 14245.572632821031, 1999.0, 2016.314453085958, 2045.3454894433787, 2055.3011975928257, 2057.5781964697203, 86631.56684216602, 88447.55776221142, 90830.545847271, 95150.0, 98617.50691246497, 10156.542955567018, 10185.847212291821, 10481.213908956859, 10494.895051049545, 10748.946255268673, 14219.0, 14282.714345713028, 14310.427582896777, 14317.284135793168, 14376.137431754129, 6449.645269510222, 6628.767993120217, 6680.96659516709, 6942.7222911084, 6981.511294209458, 6280.899042221877, 6285.277193122758, 6436.903446448307, 6441.613503189824, 6449.451796597248, 6430.099786029959, 6544.672766361663, 6606.900896486556, 6632.834179145463, 6756.932430675729, 1867.6918308478948, 1882.6422979633826, 1894.5547796267865, 1900.477368723612, 2000.0999550202175, 823.222055157882, 861.4028703459076, 874.6588830356167, 888.9066248983679, 893.5532233883058, 16295.83704162967, 16371.427000055179, 16894.324227030782, 17088.57278568046, 17381.82618173802, 877.903430622631, 879.6613303878053, 881.5768431152954, 896.1307531694246, 896.8430524658158, 8802.295816334678, 9376.249900007982, 9385.108414700593, 9508.049195080437, 10916.945415273032, 400758.0, 401807.0, 402253.0, 411570.0, 418737.0, 77944.0, 78157.21842781613, 78397.216027839, 79683.0, 82406.17593824105, 1066.099146221426, 1093.5461783359976, 1119.3955264157428, 1126.8422420861086, 1128.1651577832345, 16985.40551080706, 17234.310627575258, 17796.021218833088, 17830.286788528832, 17953.192106354985, 37474.43788343122, 37585.2482950334, 38210.80894595509, 39258.607413926635, 39761.20477590374, 44546.55453445424, 44979.32531011972, 45200.547994519635, 45205.547944520134, 46454.53545464502, 7833.295003449717, 7870.173631768582, 8002.679892804223, 8012.198780121941, 8099.514029158269, 11612.709682258012, 12132.636020919386, 12197.634070977885, 12437.564685235973, 12746.617601471971, 9632.614695412385, 9724.173445257233, 9795.314327997257, 9808.85286720714, 10013.349132306377, 9619.615215391586, 9675.951620241854, 10317.27779055459, 10351.120154786928, 10541.525631346762, 9526.285528585246, 9878.209743220668, 9921.206303495848, 10138.391696498235, 10184.949075254577, 7598.658060387185, 7604.961975190088, 7676.270754278335, 7706.884396733942, 7719.073711154698, 8838.0, 8950.552472376485, 8956.0, 8998.59506322204, 9137.817243655223], "value": 8434.512327977885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.8082947143191, 1275.158395458997, 1278.4758249117858, 1284.8650891656375, 1289.439093994112, 9801.509924503773, 10063.949680251606, 10334.1732661387, 10367.844482332772, 10409.5315710793, 10269.486525673723, 10409.5315710793, 10459.529321180546, 10473.581056757721, 10476.52855621497, 2211.1266049910278, 2243.596152692515, 2253.7182852143483, 2262.739784924738, 2265.161890100657, 2176.379731776444, 2214.1143542582936, 2215.9224427145055, 2216.966745498819, 2219.9778002220014, 2084.9478763030893, 2107.957840843182, 2115.6614941609346, 2124.9043793029273, 2132.093860109455, 2072.7409073865765, 2098.8320934325216, 2102.3272552783114, 2103.316422162803, 2106.2101711858054, 1864.1424944525534, 1920.3470819921295, 2006.388051644248, 2038.4088614301984, 2156.4608847788054, 10101.090901818798, 10179.949100254451, 10180.338278011906, 10186.643467478603, 10201.693949181536, 5508.3114610673665, 5704.058830292996, 5718.456746609066, 5739.540836733093, 5748.022836117828, 3218.5494030835703, 3269.395161895033, 3323.9169020774434, 3329.200991761984, 3349.363620912043, 1055.482813421418, 1064.542246833861, 1077.1921059205595, 1109.6171820721838, 1121.0975164992178, 14765.630859228499, 14842.55472335821, 14894.851051489455, 14945.40218391263, 14970.401183952628, 4696.2955556666775, 4772.3557319761385, 4866.805327786919, 4872.8781780455065, 4914.410270767531, 11001.449927503752, 11010.449477526092, 11023.228374013743, 11026.944865275622, 11030.28303160292, 5451.700156491352, 5550.91673624896, 5556.0, 5556.86107847299, 5559.416261292587, 5106.565941894906, 5121.231815227671, 5155.200943853709, 5162.483751624807, 5166.870828229325, 3866.7873266970587, 3912.628300311466, 3915.7063220258024, 3981.203759248162, 4001.47980762499, 1060.607575197182, 1061.5806756331206, 1070.6841481762742, 1077.6982444915436, 1078.741102135482, 702.0978043214445, 726.4370113162341, 727.9490435669452, 731.3527528137637, 740.9036825212688, 5461.344638643309, 5556.888862222733, 5614.85962850932, 5653.23681303027, 5679.716014199274, 495.07174048658766, 839.546644811807, 841.6507149532875, 849.7960489482604, 854.1885209051426, 3727.5340582427198, 3809.8095095245126, 3848.3265428549894, 3855.857476156923, 3860.749051311656, 12834.486620535261, 13062.673433164247, 13359.599212023655, 13396.531121410704, 13522.053456258163, 12875.871241287467, 13255.867441325656, 13265.734685306239, 13440.126391784503, 13547.66130846717, 7304.160021597478, 7453.515521491194, 7462.403007759366, 7481.251874812475, 7484.326410622961, 5543.029969755357, 5591.412901645269, 5653.180288858175, 5663.716814159358, 5727.284089488814, 11976.221545599508, 12005.0, 12060.51757929673, 12256.448459819152, 12330.50677972871, 11947.641570752543, 12407.875921240671, 12430.37848107573, 12548.874511254771, 12550.811737824122, 8431.494110353398, 8551.230389264996, 8590.0, 8595.699150529701, 8613.526256055977, 9271.443713377219, 9498.287628427757, 9598.66404675861, 9619.663311784054, 9622.566984485575, 7631.275028872248, 7750.689972401041, 8066.0, 8133.308668763221, 8157.265846073882, 7784.455088144002, 7814.101378341336, 7826.921730782619, 7943.205679432011, 8005.519668819889, 6921.965390173017, 7010.649467526705, 7056.470764692771, 7056.6471676417, 7074.964625176841, 4764.4282686077895, 4992.375953005874, 4997.650164488451, 5094.1849304111165, 5244.9737751310995, 5291.777453469475, 5328.413874473882, 5378.273933019149, 5440.945590544202, 5617.269754931996], "value": 4695.350901890369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.0320634588249, 340.24126198577187, 380.0403979950626, 380.4882433127444, 382.6919329939399, 5456.672599644019, 5509.449055094488, 5523.861903452415, 5535.944640553594, 5536.916946245805, 5280.8910128872885, 5365.195220716894, 5374.91937620935, 5379.946200537994, 5394.406615272317, 4057.214825476781, 4105.815238314275, 4112.506499220098, 4119.382092686106, 4128.360104183841, 4081.3061779497557, 4086.6730661547003, 4103.958960410388, 4108.993296642327, 4140.958590414088, 4057.3913912913004, 4057.797110144481, 4073.065293985348, 4075.4498142750645, 4082.265192265391, 3993.9001524961964, 4054.3513037914086, 4073.327900896378, 4075.9592404076025, 4105.096878686684, 3558.768680035789, 3561.6438356164435, 3565.447355659877, 3566.35805555, 3585.784852908808, 5269.552088072518, 5293.788248470057, 5307.495787900143, 5312.707801070939, 5333.973330133364, 4656.604188643969, 4707.741074240916, 4768.904621907577, 4779.545943135397, 4795.472498025214, 5713.771449142029, 5744.913826292609, 5747.281589801275, 5748.42515748426, 5748.568857335675, 3978.6419222270133, 3992.301347264246, 4007.8377270591495, 4008.158286759784, 4013.177298653769, 5820.82537523875, 5854.7072646367515, 6044.304904935944, 6066.0, 6148.7233074511305, 4044.3529035354204, 4085.6935729820384, 4095.6313931746286, 4095.7337773044655, 4104.281750693616, 4136.689748268832, 4136.91726165475, 4148.253314403436, 4152.43942067823, 4152.480939882515, 4684.578387945101, 4725.243960966229, 4773.260144677511, 4786.44955830077, 4791.5687588117235, 5759.827205183768, 5791.189233507313, 5796.536277097822, 5827.825165245049, 5836.4747172753805, 1381.6891199480237, 1393.5958572014206, 1394.0868730981224, 1402.2287741742, 1404.599689088605, 866.6793286483916, 908.9909100909039, 909.8391320613542, 912.2473958983865, 921.7142086788892, 4958.7024778513405, 4986.426560945538, 4986.925196122061, 4989.476105008995, 5010.699358038456, 5924.170616113662, 5938.524918006549, 5988.970055149696, 6014.51883849291, 6027.457528822427, 4795.568398844121, 4893.0, 4898.53463920927, 4915.8033678652455, 4948.604111671058, 3139.8587063582195, 3185.5380969759717, 3200.1679563313705, 3203.47142721453, 3204.6955539223736, 5458.0, 5509.283793106871, 5510.586705997066, 5513.558915286848, 5520.199571062173, 5902.557308201816, 6158.753649854045, 6195.597286176384, 6226.0, 6231.781887634002, 5537.473939975695, 5552.444755524496, 5562.193481945176, 5569.10894256917, 5571.860703482445, 5715.542756579381, 5949.19685842423, 5987.670678112746, 6040.0, 6078.422549857756, 5905.438983296752, 5931.406859314034, 5955.493783028491, 5962.850928726816, 5990.730417131327, 5314.813981510629, 5452.318460192476, 5465.863353416196, 5472.0, 5510.283663123929, 3935.2129574084724, 3966.147278335172, 3980.084580546433, 3982.8406863725127, 3989.3617021276455, 5949.791757288474, 6015.405917431796, 6061.181740465157, 6077.453029227391, 6083.969580152071, 5809.2738407699035, 5836.445537673914, 5854.941450585439, 5866.882662346815, 5889.734961926638, 5731.885362292647, 5749.7125143741805, 5788.53691704671, 5819.941800582109, 5838.386969368155, 5643.802466913638, 5726.284214473191, 5733.9713301434895, 5765.769369225184, 5768.336641286306, 5864.912026319524, 5869.4717475425705, 5869.882602347844, 5883.235179426647, 5894.705264736832, 5626.493615574454, 5667.846218436967, 5715.942260786197, 5731.283589551306, 5741.16753070794], "value": 4286.93054459689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.9480636355457, 750.8610906982209, 767.834915493169, 768.4428789127883, 789.1004255149129, 13751.793723094162, 14510.782338264922, 14561.635959101028, 15767.448139315125, 15897.52307430776, 16446.61524079011, 16452.67094658106, 16626.66746665066, 16632.66734665306, 16638.168091595402, 878.7759121424044, 898.6854600889702, 904.3307952115421, 905.1988989744091, 908.8773015642903, 839.890814194157, 855.9358048146382, 864.7449002544233, 865.3250464637562, 895.1853813030144, 933.0529512544772, 935.111643938258, 936.6955739384694, 937.2455173585261, 938.3431597881477, 926.9907300926972, 928.3176865004217, 930.8045310484806, 931.3759780946748, 931.5435436636, 687.1719577908608, 689.5552368722147, 691.2051141187624, 691.3294104718466, 692.6432887063116, 14594.270286485633, 14934.25328733559, 15083.095014299068, 15167.62080947974, 15169.24153792317, 13917.0, 14275.857241427557, 14321.069130506483, 14346.856531434762, 14477.78283325751, 12289.078319126102, 12312.692182695415, 12345.5061797528, 12559.309237991907, 12620.0, 2865.298001989505, 2888.292368369742, 2892.5082735934943, 2894.52240380337, 2903.332233586266, 80830.0, 82998.58500707518, 83582.58208708979, 83979.0, 84494.99999999939, 12817.423215955305, 13059.869401305865, 13086.2802545859, 13170.275634839983, 13195.406206720529, 22738.43153921165, 23647.408814779767, 23902.88048559781, 23985.04059837587, 24015.51968960611, 6179.752809887644, 6253.843653908689, 6257.530685198628, 6324.3991820776955, 6342.460890824239, 2668.3595936974984, 2711.552593821997, 2715.83704977698, 2746.0800631788575, 2767.3220061085162, 3833.7124715646437, 3881.708871834567, 3916.3538016227003, 3922.646961773454, 3941.625545573166, 704.4962851561158, 708.3801673535656, 712.9500934934505, 714.0, 717.0, 600.099850224663, 612.7548980407784, 614.1954040207343, 631.6115588912877, 640.452413186728, 9561.378510396802, 10112.747181320527, 10536.525856336484, 10826.729331766612, 11199.384033878052, 622.9750809967641, 629.9527535434769, 630.3664816859119, 634.5241069198102, 648.9740410383627, 4527.615152712056, 4585.95414045862, 4627.722336659811, 4742.075295317449, 4754.952450475451, 84559.0, 86052.56973715092, 86271.0, 86672.0, 88017.0, 75172.62413687896, 75179.0, 75528.24471755321, 77049.45901082059, 79143.20856791474, 53943.730281347554, 57172.71413642988, 58958.41041589615, 59354.70322648445, 64834.67582662151, 9447.763805904633, 10045.0, 10266.230032747424, 10275.588976441157, 10320.174386048948, 27320.0, 27588.586171207848, 27662.170134895987, 27907.72092279051, 28878.278043049093, 51024.0, 52042.47957520376, 52317.0, 53199.468005321, 53416.732916336725, 13803.378847952066, 13809.51666691661, 13881.583552493441, 14308.141511509342, 14348.641283967985, 15668.294926728096, 16044.358225670843, 16283.674326513641, 17439.82560174382, 17504.387346442814, 13831.100978436369, 13860.861391386361, 13904.51334203298, 14039.649008774863, 14284.285785710465, 14188.36152373125, 14567.125972441687, 14653.853461465249, 14664.046836955564, 14950.327235274657, 13043.413046413123, 13083.542076027294, 13200.273984930922, 13276.402561884932, 13349.199048057148, 9874.308798384043, 10010.64962726301, 10091.646792362231, 10095.091441770275, 10240.180785537288, 10070.144037756872, 10116.747081323027, 10500.317479363817, 10670.73323166927, 10697.679069627924], "value": 7158.313920667738, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.2000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 125.0, 177.0, 128.0, 129.0, 122.0, 123.0, 147.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 167.0, 168.0, 172.0, 168.0, 165.0, 164.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 101.0, 74.0, 76.0, 74.0, 75.0, 94.0, 74.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 98.0, 83.0, 83.0, 82.0, 102.0, 85.0, 83.0, 105.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 56.0, 56.0, 55.0, 58.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 87.0, 87.0, 87.0, 87.0, 88.0, 114.0, 88.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 134.0, 138.0, 144.0, 134.0, 130.0, 135.0, 139.0, 132.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 194.0, 196.0, 192.0, 186.0, 187.0, 192.0, 192.0, 201.0, 188.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 77.0, 73.0, 70.0, 74.0, 72.0, 71.0, 71.0], "value": 72.9, "unit": "score"}]}]} 03:39:45 INFO - Return code: 0 03:39:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:45 INFO - # TBPL SUCCESS # 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - [mozharness: 2017-05-27 10:39:45.991597Z] Finished run-tests step (success) 03:39:45 INFO - Running post-run listener: _resource_record_post_run 03:39:46 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403644416; Read time: 208; Write time: 237852 03:39:46 INFO - TinderboxPrint: CPU usage
12.7% 03:39:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 03:39:46 INFO - TinderboxPrint: I/O write bytes / time
403,644,416 / 237,852 03:39:46 INFO - TinderboxPrint: CPU idle
8,755.6 (87.3%) 03:39:46 INFO - TinderboxPrint: CPU user
1,216.1 (12.1%) 03:39:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 97431552; Read time: 64; Write time: 102216 03:39:46 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306212864; Read time: 144; Write time: 135636 03:39:46 INFO - Running post-run listener: _upload_blobber_files 03:39:46 INFO - Blob upload gear active. 03:39:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:46 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 03:39:46 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'] 03:39:46 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 03:39:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:49 INFO - (blobuploader) - INFO - Done attempting. 03:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:50 INFO - (blobuploader) - INFO - Done attempting. 03:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:53 INFO - (blobuploader) - INFO - Done attempting. 03:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:54 INFO - (blobuploader) - INFO - Done attempting. 03:39:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:54 INFO - Return code: 0 03:39:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79eff15bf157a65bba4b7430dc1e2e10c151432fb3b1e7f850a57542967f47a64e1811ed925db2351fd5b098461aff7c7cdf4a9cb684199234a197c9e3bfe07", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35441a09adee7751da7b8c5fbf36277960dae16ed52c9aaef015fc6726a112763ac08e2e218a671f357f4777c049d83d3c82668e1a71e8ea2033d7a81bb8b715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650177bdb71e9bd09dbd8af6e91d0f797785aa22ba1ee0f13a713a6776b6c9531b8449435026f602abe335b045c1ad6bdc6c67728ebe2f2efd2dc170c07895af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530d54846566722bc0e0b5764b21f58e5ac78ea569dc79c946e26d45d745cb2c1cf31204994234cae306c95ac9b3004d2773e5da45f08f7606edfe0c22d30bc3"} 03:39:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:54 INFO - Contents: 03:39:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79eff15bf157a65bba4b7430dc1e2e10c151432fb3b1e7f850a57542967f47a64e1811ed925db2351fd5b098461aff7c7cdf4a9cb684199234a197c9e3bfe07", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35441a09adee7751da7b8c5fbf36277960dae16ed52c9aaef015fc6726a112763ac08e2e218a671f357f4777c049d83d3c82668e1a71e8ea2033d7a81bb8b715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650177bdb71e9bd09dbd8af6e91d0f797785aa22ba1ee0f13a713a6776b6c9531b8449435026f602abe335b045c1ad6bdc6c67728ebe2f2efd2dc170c07895af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530d54846566722bc0e0b5764b21f58e5ac78ea569dc79c946e26d45d745cb2c1cf31204994234cae306c95ac9b3004d2773e5da45f08f7606edfe0c22d30bc3"} 03:39:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:54 INFO - Copying logs to upload dir... 03:39:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.627717 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-27 03:39:53.491268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 03:39:53.496045) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 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/c79eff15bf157a65bba4b7430dc1e2e10c151432fb3b1e7f850a57542967f47a64e1811ed925db2351fd5b098461aff7c7cdf4a9cb684199234a197c9e3bfe07", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35441a09adee7751da7b8c5fbf36277960dae16ed52c9aaef015fc6726a112763ac08e2e218a671f357f4777c049d83d3c82668e1a71e8ea2033d7a81bb8b715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650177bdb71e9bd09dbd8af6e91d0f797785aa22ba1ee0f13a713a6776b6c9531b8449435026f602abe335b045c1ad6bdc6c67728ebe2f2efd2dc170c07895af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530d54846566722bc0e0b5764b21f58e5ac78ea569dc79c946e26d45d745cb2c1cf31204994234cae306c95ac9b3004d2773e5da45f08f7606edfe0c22d30bc3"} build_url:https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/IggRYx8DSWac_R94qt0K1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c79eff15bf157a65bba4b7430dc1e2e10c151432fb3b1e7f850a57542967f47a64e1811ed925db2351fd5b098461aff7c7cdf4a9cb684199234a197c9e3bfe07", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35441a09adee7751da7b8c5fbf36277960dae16ed52c9aaef015fc6726a112763ac08e2e218a671f357f4777c049d83d3c82668e1a71e8ea2033d7a81bb8b715", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/650177bdb71e9bd09dbd8af6e91d0f797785aa22ba1ee0f13a713a6776b6c9531b8449435026f602abe335b045c1ad6bdc6c67728ebe2f2efd2dc170c07895af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/530d54846566722bc0e0b5764b21f58e5ac78ea569dc79c946e26d45d745cb2c1cf31204994234cae306c95ac9b3004d2773e5da45f08f7606edfe0c22d30bc3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 03:39:53.520279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:39:53.523629) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495877595.196786-902341754 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:39:53.602438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 03:39:53.602756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 03:39:53.603049) ========= ========= Total master_lag: 0.17 =========