builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-036 starttime: 1505557345.16 results: success (0) revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.159350) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.159731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.160247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.264755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.268031) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:22:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-09-16 03:22:25 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.419207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.419513) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014816 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:25.468551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:22:25.468863) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 --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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:22:25,439 truncating revision to first 12 chars 2017-09-16 03:22:25,439 Setting DEBUG logging. 2017-09-16 03:22:25,439 attempt 1/10 2017-09-16 03:22:25,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6c1b45e7e94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:22:25,912 attempt 1/10 2017-09-16 03:22:26,567 current task status: no status available at this point. state: STARTED 2017-09-16 03:22:26,567 sleeping for 10.00s (attempt 1/10) 2017-09-16 03:22:36,577 attempt 2/10 2017-09-16 03:22:37,004 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-16 03:22:37,164 unpacking tar archive at: mozilla-central-6c1b45e7e94d/testing/mozharness/ program finished with exit code 0 elapsedTime=12.040679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:22:37.530400) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.530719) ========= script_repo_revision: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.531092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.531351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:22:37.546380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 03:22:37.546732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:37 INFO - MultiFileLogger online at 20170916 03:22:37 in /builds/slave/test 03:22:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:37 INFO - {'append_to_log': False, 03:22:37 INFO - 'base_work_dir': '/builds/slave/test', 03:22:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:37 INFO - 'branch': 'Firefox-Non-PGO', 03:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:37 INFO - 'code_coverage': False, 03:22:37 INFO - 'config_files': ('talos/linux_config.py',), 03:22:37 INFO - 'default_actions': ('clobber', 03:22:37 INFO - 'read-buildbot-config', 03:22:37 INFO - 'download-and-extract', 03:22:37 INFO - 'populate-webroot', 03:22:37 INFO - 'create-virtualenv', 03:22:37 INFO - 'install', 03:22:37 INFO - 'setup-mitmproxy', 03:22:37 INFO - 'run-tests'), 03:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:37 INFO - 'disable_ccov_upload': False, 03:22:37 INFO - 'disable_stylo': False, 03:22:37 INFO - 'download_minidump_stackwalk': True, 03:22:37 INFO - 'download_symbols': 'ondemand', 03:22:37 INFO - 'enable_stylo': False, 03:22:37 INFO - 'enable_webrender': False, 03:22:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:37 INFO - 'gecko_profile': False, 03:22:37 INFO - 'gecko_profile_interval': 0, 03:22:37 INFO - 'installer_path': 'installer.exe', 03:22:37 INFO - 'log_level': 'info', 03:22:37 INFO - 'log_name': 'talos', 03:22:37 INFO - 'log_to_console': True, 03:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:37 INFO - 'opt_config_files': (), 03:22:37 INFO - 'pip_index': False, 03:22:37 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:22:37 INFO - 'system_bits': '32', 03:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:37 INFO - 'title': 'talos-linux64-ix-036', 03:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:37 INFO - 'use_talos_json': True, 03:22:37 INFO - 'verify': 'False', 03:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:37 INFO - 'work_dir': 'build'} 03:22:37 INFO - [mozharness: 2017-09-16 10:22:37.658659Z] Running clobber step. 03:22:37 INFO - Running pre-action listener: _resource_record_pre_action 03:22:37 INFO - Running main action method: clobber 03:22:37 INFO - rmtree: /builds/slave/test/build 03:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:39 INFO - Running post-action listener: _resource_record_post_action 03:22:39 INFO - [mozharness: 2017-09-16 10:22:39.171284Z] Finished clobber step (success) 03:22:39 INFO - [mozharness: 2017-09-16 10:22:39.171379Z] Running read-buildbot-config step. 03:22:39 INFO - Running pre-action listener: _resource_record_pre_action 03:22:39 INFO - Running main action method: read_buildbot_config 03:22:39 INFO - Using buildbot properties: 03:22:39 INFO - { 03:22:39 INFO - "project": "", 03:22:39 INFO - "product": "firefox", 03:22:39 INFO - "who": "archaeopteryx@coole-files.de", 03:22:39 INFO - "installer_path": "public/build/target.tar.bz2", 03:22:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:22:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:22:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:22:39 INFO - "stage_platform": "linux64", 03:22:39 INFO - "basedir": "/builds/slave/test", 03:22:39 INFO - "buildnumber": 29, 03:22:39 INFO - "platform": "ubuntu64_hw", 03:22:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:22:39 INFO - "slavebuilddir": "test", 03:22:39 INFO - "taskId": "NFqpejZdQ3CL6h6KMXT14g", 03:22:39 INFO - "branch": "mozilla-central", 03:22:39 INFO - "script_repo_revision": "production", 03:22:39 INFO - "revision": "6c1b45e7e94dbf343813eda03f1fd0b3259b59b1", 03:22:39 INFO - "slavename": "talos-linux64-ix-036", 03:22:39 INFO - "repo_path": "mozilla-central" 03:22:39 INFO - } 03:22:39 INFO - Finding installer, test and symbols from parent task. 03:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NFqpejZdQ3CL6h6KMXT14g'}, attempt #1 03:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NFqpejZdQ3CL6h6KMXT14g'}, attempt #1 03:22:40 INFO - Task dependencies: HjCsUs2wRpaX7mNuomNYtQ 03:22:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ'}, attempt #1 03:22:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip 03:22:40 INFO - Running post-action listener: _resource_record_post_action 03:22:40 INFO - [mozharness: 2017-09-16 10:22:40.560983Z] Finished read-buildbot-config step (success) 03:22:40 INFO - [mozharness: 2017-09-16 10:22:40.561202Z] Running download-and-extract step. 03:22:40 INFO - Running pre-action listener: _resource_record_pre_action 03:22:40 INFO - Running main action method: download_and_extract 03:22:40 INFO - mkdir: /builds/slave/test/build/tests 03:22:40 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:22:40 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json 03:22:40 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:22:41 INFO - Downloaded 989 bytes. 03:22:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:22:41 INFO - Using the following test package requirements: 03:22:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:22:41 INFO - u'common': [u'target.common.tests.zip'], 03:22:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:22:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:22:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:22:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:22:41 INFO - u'mozbase': [u'target.common.tests.zip'], 03:22:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:22:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:22:41 INFO - u'web-platform': [u'target.common.tests.zip', 03:22:41 INFO - u'target.web-platform.tests.tar.gz'], 03:22:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:22:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:22:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip 03:22:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:41 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.common.tests.zip into memory 03:22:42 INFO - Content-Length response header: 54731145 03:22:42 INFO - Bytes received: 54731145 03:22:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip 03:22:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:22:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.talos.tests.zip into memory 03:22:53 INFO - Content-Length response header: 14508749 03:22:53 INFO - Bytes received: 14508749 03:22:53 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:22:53 INFO - trying https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:22:54 INFO - Downloaded 61438347 bytes. 03:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:55 INFO - mkdir: /builds/slave/test/properties 03:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:55 INFO - Contents: 03:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 03:22:55 INFO - Running post-action listener: _resource_record_post_action 03:22:55 INFO - Running post-action listener: find_tests_for_verification 03:22:55 INFO - Running post-action listener: set_extra_try_arguments 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.245791Z] Finished download-and-extract step (success) 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.246103Z] Running populate-webroot step. 03:22:55 INFO - Running pre-action listener: _resource_record_pre_action 03:22:55 INFO - Running main action method: populate_webroot 03:22:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tresize', 03:22:55 INFO - 'tcanvasmark']}, 03:22:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['dromaeo_css', 03:22:55 INFO - 'kraken']}, 03:22:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['damp', 'tps']}, 03:22:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['damp', 'tps']}, 03:22:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['dromaeo_dom']}, 03:22:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:22:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['basic_compositor_video', 03:22:55 INFO - 'glvideo']}, 03:22:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:22:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['ts_paint_webext', 03:22:55 INFO - 'tp5o_webext']}, 03:22:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:55 INFO - 'ts_paint', 03:22:55 INFO - 'tpaint', 03:22:55 INFO - 'sessionrestore', 03:22:55 INFO - 'sessionrestore_many_windows', 03:22:55 INFO - 'sessionrestore_no_auto_restore', 03:22:55 INFO - 'tabpaint']}, 03:22:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['a11yr', 03:22:55 INFO - 'ts_paint', 03:22:55 INFO - 'tpaint', 03:22:55 INFO - 'sessionrestore', 03:22:55 INFO - 'sessionrestore_many_windows', 03:22:55 INFO - 'sessionrestore_no_auto_restore', 03:22:55 INFO - 'tabpaint']}, 03:22:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:22:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:22:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['perf_reftest_singletons']}, 03:22:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['bloom_basic']}, 03:22:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:55 INFO - 'tsvgr_opacity', 03:22:55 INFO - 'tart', 03:22:55 INFO - 'tscrollx', 03:22:55 INFO - 'tsvg_static']}, 03:22:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tsvgx', 03:22:55 INFO - 'tsvgr_opacity', 03:22:55 INFO - 'tart', 03:22:55 INFO - 'tscrollx', 03:22:55 INFO - 'tsvg_static']}, 03:22:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:22:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo'], 03:22:55 INFO - 'tests': ['tp5o']}, 03:22:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo', 03:22:55 INFO - '--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:22:55 INFO - 'talos_options': ['--stylo-threads=1', 03:22:55 INFO - '--mitmproxy', 03:22:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:22:55 INFO - '--firstNonBlankPaint'], 03:22:55 INFO - 'tests': ['tp6_google', 03:22:55 INFO - 'tp6_youtube', 03:22:55 INFO - 'tp6_amazon', 03:22:55 INFO - 'tp6_facebook']}, 03:22:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--xperf_path', 03:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:55 INFO - 'tests': ['tp5n']}, 03:22:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:22:55 INFO - 'talos_options': ['--disable-stylo', 03:22:55 INFO - '--xperf_path', 03:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:55 INFO - 'tests': ['tp5n']}}} 03:22:55 INFO - Running post-action listener: _resource_record_post_action 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.271347Z] Finished populate-webroot step (success) 03:22:55 INFO - [mozharness: 2017-09-16 10:22:55.271437Z] Running create-virtualenv step. 03:22:55 INFO - Running pre-action listener: _resource_record_pre_action 03:22:55 INFO - Running main action method: create_virtualenv 03:22:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:22:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:22:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:22:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:56 INFO - Installing pip...............done. 03:22:56 INFO - Return code: 0 03:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:22:56 INFO - Reading from file tmpfile_stdout 03:22:56 INFO - Output received: 03:22:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:22:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:56 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:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:56 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:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:56 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:22:56 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:22:56 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:22:56 INFO - Using env: {'DISPLAY': ':0', 03:22:56 INFO - 'HOME': '/home/cltbld', 03:22:56 INFO - 'LANG': 'en_US.UTF-8', 03:22:56 INFO - 'LANGUAGE': 'en_US:en', 03:22:56 INFO - 'LOGNAME': 'cltbld', 03:22:56 INFO - 'MAIL': '/var/mail/cltbld', 03:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:56 INFO - 'MOZ_NO_REMOTE': '1', 03:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:56 INFO - 'NO_EM_RESTART': '1', 03:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:56 INFO - 'PWD': '/builds/slave/test', 03:22:56 INFO - 'SHELL': '/bin/bash', 03:22:56 INFO - 'SHLVL': '1', 03:22:56 INFO - 'TERM': 'linux', 03:22:56 INFO - 'TMOUT': '86400', 03:22:56 INFO - 'USER': 'cltbld', 03:22:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:56 INFO - '_': '/tools/buildbot/bin/python'} 03:22:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:22:57 INFO - Downloading/unpacking pip>=1.5 03:22:57 INFO - Running setup.py egg_info for package pip 03:22:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:57 INFO - Installing collected packages: pip 03:22:57 INFO - Found existing installation: pip 1.1 03:22:57 INFO - Uninstalling pip: 03:22:57 INFO - Successfully uninstalled pip 03:22:57 INFO - Running setup.py install for pip 03:22:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:22:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:22:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:22:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:22:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:22:57 INFO - Successfully installed pip 03:22:57 INFO - Cleaning up... 03:22:57 INFO - Return code: 0 03:22:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:57 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:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:57 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:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:57 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:22:57 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:22:57 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:22:57 INFO - Using env: {'DISPLAY': ':0', 03:22:57 INFO - 'HOME': '/home/cltbld', 03:22:57 INFO - 'LANG': 'en_US.UTF-8', 03:22:57 INFO - 'LANGUAGE': 'en_US:en', 03:22:57 INFO - 'LOGNAME': 'cltbld', 03:22:57 INFO - 'MAIL': '/var/mail/cltbld', 03:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:57 INFO - 'MOZ_NO_REMOTE': '1', 03:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:57 INFO - 'NO_EM_RESTART': '1', 03:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:57 INFO - 'PWD': '/builds/slave/test', 03:22:57 INFO - 'SHELL': '/bin/bash', 03:22:57 INFO - 'SHLVL': '1', 03:22:57 INFO - 'TERM': 'linux', 03:22:57 INFO - 'TMOUT': '86400', 03:22:57 INFO - 'USER': 'cltbld', 03:22:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:57 INFO - '_': '/tools/buildbot/bin/python'} 03:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:57 INFO - Downloading/unpacking psutil>=3.1.1 03:22:57 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:22:57 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:22:57 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:22:57 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:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:59 INFO - Installing collected packages: psutil 03:22:59 INFO - Running setup.py install for psutil 03:22:59 INFO - building 'psutil._psutil_linux' extension 03:22:59 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:22:59 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:22:59 INFO - building 'psutil._psutil_posix' extension 03:22:59 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:22:59 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:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:59 INFO - Successfully installed psutil 03:22:59 INFO - Cleaning up... 03:22:59 INFO - Return code: 0 03:22:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:59 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:22:59 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:22:59 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:22:59 INFO - Using env: {'DISPLAY': ':0', 03:22:59 INFO - 'HOME': '/home/cltbld', 03:22:59 INFO - 'LANG': 'en_US.UTF-8', 03:22:59 INFO - 'LANGUAGE': 'en_US:en', 03:22:59 INFO - 'LOGNAME': 'cltbld', 03:22:59 INFO - 'MAIL': '/var/mail/cltbld', 03:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:59 INFO - 'MOZ_NO_REMOTE': '1', 03:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:59 INFO - 'NO_EM_RESTART': '1', 03:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:59 INFO - 'PWD': '/builds/slave/test', 03:22:59 INFO - 'SHELL': '/bin/bash', 03:22:59 INFO - 'SHLVL': '1', 03:22:59 INFO - 'TERM': 'linux', 03:22:59 INFO - 'TMOUT': '86400', 03:22:59 INFO - 'USER': 'cltbld', 03:22:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:59 INFO - '_': '/tools/buildbot/bin/python'} 03:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:59 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:22:59 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:22:59 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:22:59 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:23:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:00 INFO - Installing collected packages: mozsystemmonitor 03:23:00 INFO - Running setup.py install for mozsystemmonitor 03:23:01 INFO - Successfully installed mozsystemmonitor 03:23:01 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23: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:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:02 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:02 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:23:02 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:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:02 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:23:02 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:23:02 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:23:02 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:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:03 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:23:03 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:23:03 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:23:03 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:23:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:03 INFO - warning: no files found matching '*.txt' 03:23:03 INFO - no previously-included directories found matching 'build' 03:23:03 INFO - no previously-included directories found matching 'dist' 03:23:03 INFO - no previously-included directories found matching '.git*' 03:23:03 INFO - Installing collected packages: jsonschema, functools32 03:23:04 INFO - Running setup.py install for functools32 03:23:04 INFO - warning: no files found matching '*.txt' 03:23:04 INFO - no previously-included directories found matching 'build' 03:23:04 INFO - no previously-included directories found matching 'dist' 03:23:04 INFO - no previously-included directories found matching '.git*' 03:23:05 INFO - Successfully installed jsonschema functools32 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23: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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:05 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:23:05 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:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23: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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:05 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:23:05 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:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:05 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:23:05 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:23:05 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:23:05 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:23:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:06 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:23:06 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:23:06 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:23:06 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:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:06 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:23:06 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:23:06 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:23:06 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:23:07 INFO - Downloading docopt-0.6.1.tar.gz 03:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:07 INFO - Running setup.py install for blobuploader 03:23:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:07 INFO - Running setup.py install for requests 03:23:07 INFO - Running setup.py install for docopt 03:23:07 INFO - Successfully installed blobuploader requests docopt 03:23:07 INFO - Cleaning up... 03:23:07 INFO - Return code: 0 03:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:07 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:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:07 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:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:07 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:07 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:23:07 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:23:07 INFO - Using env: {'DISPLAY': ':0', 03:23:07 INFO - 'HOME': '/home/cltbld', 03:23:07 INFO - 'LANG': 'en_US.UTF-8', 03:23:07 INFO - 'LANGUAGE': 'en_US:en', 03:23:07 INFO - 'LOGNAME': 'cltbld', 03:23:07 INFO - 'MAIL': '/var/mail/cltbld', 03:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:07 INFO - 'MOZ_NO_REMOTE': '1', 03:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:07 INFO - 'NO_EM_RESTART': '1', 03:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:07 INFO - 'PWD': '/builds/slave/test', 03:23:07 INFO - 'SHELL': '/bin/bash', 03:23:07 INFO - 'SHLVL': '1', 03:23:07 INFO - 'TERM': 'linux', 03:23:07 INFO - 'TMOUT': '86400', 03:23:07 INFO - 'USER': 'cltbld', 03:23:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:07 INFO - '_': '/tools/buildbot/bin/python'} 03:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:07 INFO - Running setup.py (path:/tmp/pip-Khij2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Running setup.py (path:/tmp/pip-xQlAyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Running setup.py (path:/tmp/pip-8MvlYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Running setup.py (path:/tmp/pip-ZmPWa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Running setup.py (path:/tmp/pip-mNpCDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Running setup.py (path:/tmp/pip-fFApjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:08 INFO - Running setup.py (path:/tmp/pip-sJorLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:08 INFO - Running setup.py (path:/tmp/pip-dXKN8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:08 INFO - Running setup.py (path:/tmp/pip-WT_DXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:08 INFO - Running setup.py (path:/tmp/pip-dfkYYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:08 INFO - Running setup.py (path:/tmp/pip-S9yZIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:08 INFO - Running setup.py (path:/tmp/pip-MQxEFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:08 INFO - Running setup.py (path:/tmp/pip-NZ2CRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:08 INFO - Running setup.py (path:/tmp/pip-VGaD8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:08 INFO - Running setup.py (path:/tmp/pip-5NUdDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Running setup.py (path:/tmp/pip-GguFXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Running setup.py (path:/tmp/pip-0WSraK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:09 INFO - Running setup.py install for manifestparser 03:23:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozcrash 03:23:09 INFO - Running setup.py install for mozdebug 03:23:09 INFO - Running setup.py install for mozdevice 03:23:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozfile 03:23:09 INFO - Running setup.py install for mozhttpd 03:23:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozinfo 03:23:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozInstall 03:23:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:09 INFO - Running setup.py install for mozleak 03:23:10 INFO - Running setup.py install for mozlog 03:23:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for moznetwork 03:23:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozprocess 03:23:10 INFO - Running setup.py install for mozprofile 03:23:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozrunner 03:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Running setup.py install for mozscreenshot 03:23:10 INFO - Running setup.py install for moztest 03:23:10 INFO - Running setup.py install for mozversion 03:23:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:10 INFO - Cleaning up... 03:23:10 INFO - Return code: 0 03:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:10 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:10 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:23:10 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:23:10 INFO - Using env: {'DISPLAY': ':0', 03:23:10 INFO - 'HOME': '/home/cltbld', 03:23:10 INFO - 'LANG': 'en_US.UTF-8', 03:23:10 INFO - 'LANGUAGE': 'en_US:en', 03:23:10 INFO - 'LOGNAME': 'cltbld', 03:23:10 INFO - 'MAIL': '/var/mail/cltbld', 03:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:10 INFO - 'MOZ_NO_REMOTE': '1', 03:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:10 INFO - 'NO_EM_RESTART': '1', 03:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:10 INFO - 'PWD': '/builds/slave/test', 03:23:10 INFO - 'SHELL': '/bin/bash', 03:23:10 INFO - 'SHLVL': '1', 03:23:10 INFO - 'TERM': 'linux', 03:23:10 INFO - 'TMOUT': '86400', 03:23:10 INFO - 'USER': 'cltbld', 03:23:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:10 INFO - '_': '/tools/buildbot/bin/python'} 03:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 INFO - Running setup.py (path:/tmp/pip-7d1tjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 INFO - Running setup.py (path:/tmp/pip-0IRaR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 INFO - Running setup.py (path:/tmp/pip-TAoYXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 INFO - Running setup.py (path:/tmp/pip-SG3PaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:11 INFO - Running setup.py (path:/tmp/pip-K35N_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 INFO - Running setup.py (path:/tmp/pip-_5gzfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:11 INFO - Running setup.py (path:/tmp/pip-v8pFwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:11 INFO - Running setup.py (path:/tmp/pip-o6MyFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:11 INFO - Running setup.py (path:/tmp/pip-GILNgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:11 INFO - Running setup.py (path:/tmp/pip-NErF37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:11 INFO - Running setup.py (path:/tmp/pip-F17M70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:11 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:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:11 INFO - Running setup.py (path:/tmp/pip-jUjzKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:12 INFO - Running setup.py (path:/tmp/pip-LdSokv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:12 INFO - Running setup.py (path:/tmp/pip-weuujW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 INFO - Running setup.py (path:/tmp/pip-SHvHdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:12 INFO - Running setup.py (path:/tmp/pip-YdyouM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:12 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:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:12 INFO - Running setup.py (path:/tmp/pip-czs0s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:12 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:23:12 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:23:12 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:23:12 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:23:13 INFO - Downloading blessings-1.6.tar.gz 03:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:13 INFO - Installing collected packages: blessings 03:23:13 INFO - Running setup.py install for blessings 03:23:13 INFO - Successfully installed blessings 03:23:13 INFO - Cleaning up... 03:23:13 INFO - Return code: 0 03:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:13 INFO - Reading from file tmpfile_stdout 03:23:13 INFO - Current package versions: 03:23:13 INFO - argparse == 1.2.1 03:23:13 INFO - blessings == 1.6 03:23:13 INFO - blobuploader == 1.2.4 03:23:13 INFO - docopt == 0.6.1 03:23:13 INFO - functools32 == 3.2.3-2 03:23:13 INFO - jsonschema == 2.5.1 03:23:13 INFO - manifestparser == 1.1 03:23:13 INFO - mozInstall == 1.13 03:23:13 INFO - mozcrash == 1.0 03:23:13 INFO - mozdebug == 0.1 03:23:13 INFO - mozdevice == 0.51 03:23:13 INFO - mozfile == 1.2 03:23:13 INFO - mozhttpd == 0.7 03:23:13 INFO - mozinfo == 0.10 03:23:13 INFO - mozleak == 0.1 03:23:13 INFO - mozlog == 3.5 03:23:13 INFO - moznetwork == 0.27 03:23:13 INFO - mozprocess == 0.25 03:23:13 INFO - mozprofile == 0.28 03:23:13 INFO - mozrunner == 6.13 03:23:13 INFO - mozscreenshot == 0.1 03:23:13 INFO - mozsystemmonitor == 0.3 03:23:13 INFO - moztest == 0.8 03:23:13 INFO - mozversion == 1.4 03:23:13 INFO - psutil == 3.1.1 03:23:13 INFO - requests == 1.2.3 03:23:13 INFO - wsgiref == 0.1.2 03:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:13 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 03:23:13 INFO - 'HOME': '/home/cltbld', 03:23:13 INFO - 'LANG': 'en_US.UTF-8', 03:23:13 INFO - 'LANGUAGE': 'en_US:en', 03:23:13 INFO - 'LOGNAME': 'cltbld', 03:23:13 INFO - 'MAIL': '/var/mail/cltbld', 03:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:13 INFO - 'MOZ_NO_REMOTE': '1', 03:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:13 INFO - 'NO_EM_RESTART': '1', 03:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:13 INFO - 'PWD': '/builds/slave/test', 03:23:13 INFO - 'SHELL': '/bin/bash', 03:23:13 INFO - 'SHLVL': '1', 03:23:13 INFO - 'TERM': 'linux', 03:23:13 INFO - 'TMOUT': '86400', 03:23:13 INFO - 'USER': 'cltbld', 03:23:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:13 INFO - '_': '/tools/buildbot/bin/python'} 03:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:23:15 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:23:15 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:23:15 INFO - Installing collected packages: simplejson 03:23:15 INFO - Running setup.py install for simplejson 03:23:15 INFO - building 'simplejson._speedups' extension 03:23:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:23:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:23:16 INFO - Successfully installed simplejson 03:23:16 INFO - Cleaning up... 03:23:16 INFO - Return code: 0 03:23:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:16 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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:16 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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:16 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 0x1ea61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2212a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', '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:23:16 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:23:16 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:23:16 INFO - Using env: {'DISPLAY': ':0', 03:23:16 INFO - 'HOME': '/home/cltbld', 03:23:16 INFO - 'LANG': 'en_US.UTF-8', 03:23:16 INFO - 'LANGUAGE': 'en_US:en', 03:23:16 INFO - 'LOGNAME': 'cltbld', 03:23:16 INFO - 'MAIL': '/var/mail/cltbld', 03:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:16 INFO - 'MOZ_NO_REMOTE': '1', 03:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:16 INFO - 'NO_EM_RESTART': '1', 03:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:16 INFO - 'PWD': '/builds/slave/test', 03:23:16 INFO - 'SHELL': '/bin/bash', 03:23:16 INFO - 'SHLVL': '1', 03:23:16 INFO - 'TERM': 'linux', 03:23:16 INFO - 'TMOUT': '86400', 03:23:16 INFO - 'USER': 'cltbld', 03:23:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:16 INFO - '_': '/tools/buildbot/bin/python'} 03:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:16 INFO - Cleaning up... 03:23:16 INFO - Return code: 0 03:23:16 INFO - Running post-action listener: _resource_record_post_action 03:23:16 INFO - Running post-action listener: _start_resource_monitoring 03:23:16 INFO - Starting resource monitoring. 03:23:16 INFO - [mozharness: 2017-09-16 10:23:16.636862Z] Finished create-virtualenv step (success) 03:23:16 INFO - [mozharness: 2017-09-16 10:23:16.637331Z] Running install step. 03:23:16 INFO - Running pre-action listener: _resource_record_pre_action 03:23:16 INFO - Running main action method: install 03:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:16 INFO - Reading from file tmpfile_stdout 03:23:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:16 INFO - Reading from file tmpfile_stdout 03:23:16 INFO - Output received: 03:23:16 INFO - Usage: mozinstall [options] installer 03:23:16 INFO - Options: 03:23:16 INFO - -h, --help show this help message and exit 03:23:16 INFO - -d DEST, --destination=DEST 03:23:16 INFO - Directory to install application into. [default: 03:23:16 INFO - "/builds/slave/test"] 03:23:16 INFO - --app=APP Application being installed. [default: firefox] 03:23:16 INFO - mkdir: /builds/slave/test/build/application 03:23:16 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:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:23:34 INFO - Reading from file tmpfile_stdout 03:23:34 INFO - Output received: 03:23:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:34 INFO - Running post-action listener: _resource_record_post_action 03:23:34 INFO - [mozharness: 2017-09-16 10:23:34.733663Z] Finished install step (success) 03:23:34 INFO - [mozharness: 2017-09-16 10:23:34.733916Z] Running setup-mitmproxy step. 03:23:34 INFO - Running pre-action listener: _resource_record_pre_action 03:23:34 INFO - Running main action method: setup_mitmproxy 03:23:34 INFO - Skipping: mitmproxy is not required 03:23:34 INFO - Running post-action listener: _resource_record_post_action 03:23:34 INFO - [mozharness: 2017-09-16 10:23:34.735056Z] Finished setup-mitmproxy step (success) 03:23:34 INFO - [mozharness: 2017-09-16 10:23:34.735276Z] Running run-tests step. 03:23:34 INFO - Running pre-action listener: _resource_record_pre_action 03:23:34 INFO - Running pre-action listener: _set_gcov_prefix 03:23:34 INFO - Running main action method: run_tests 03:23:34 WARNING - Try message not found. 03:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:34 INFO - Python 2.7.3 03:23:34 INFO - Return code: 0 03:23:34 INFO - grabbing minidump binary from tooltool 03:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2216090>, '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 0x2216d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2210f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:23:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:23:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:23:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:34 INFO - Return code: 0 03:23:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:34 INFO - ENV: RUST_BACKTRACE is now full 03:23:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:34 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:23:34 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:23:34 INFO - Using env: {'DISPLAY': ':0', 03:23:34 INFO - 'HOME': '/home/cltbld', 03:23:34 INFO - 'LANG': 'en_US.UTF-8', 03:23:34 INFO - 'LANGUAGE': 'en_US:en', 03:23:34 INFO - 'LOGNAME': 'cltbld', 03:23:34 INFO - 'MAIL': '/var/mail/cltbld', 03:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:34 INFO - 'MOZ_NO_REMOTE': '1', 03:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:34 INFO - 'NO_EM_RESTART': '1', 03:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:34 INFO - 'PWD': '/builds/slave/test', 03:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:34 INFO - 'RUST_BACKTRACE': 'full', 03:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:34 INFO - 'SHELL': '/bin/bash', 03:23:34 INFO - 'SHLVL': '1', 03:23:34 INFO - 'TERM': 'linux', 03:23:34 INFO - 'TMOUT': '86400', 03:23:34 INFO - 'USER': 'cltbld', 03:23:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:34 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:23:35 INFO - mozversion application_buildid: 20170916093032 03:23:35 INFO - mozversion application_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:35 INFO - mozversion application_display_name: Nightly 03:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:35 INFO - mozversion application_name: Firefox 03:23:35 INFO - mozversion application_remotingname: firefox 03:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:23:35 INFO - mozversion application_vendor: Mozilla 03:23:35 INFO - mozversion application_version: 57.0a1 03:23:35 INFO - mozversion platform_buildid: 20170916093032 03:23:35 INFO - mozversion platform_changeset: 6c1b45e7e94dbf343813eda03f1fd0b3259b59b1 03:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:23:35 INFO - mozversion platform_version: 57.0a1 03:23:35 INFO - using testdate: 1505557415 03:23:35 INFO - actual date: 1505557415 03:23:35 INFO - starting webserver on 'localhost:50547' 03:23:35 INFO - SUITE-START | Running 2 tests 03:23:35 INFO - TEST-START | dromaeo_css 03:23:35 INFO - Initialising browser for dromaeo_css test... 03:23:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50547/getInfo.html -profile /tmp/tmp42J402/profile 03:23:35 INFO - TEST-INFO | started process 25126 (/builds/slave/test/build/application/firefox/firefox http://localhost:50547/getInfo.html) 03:23:41 INFO - TEST-INFO | 25126: exit 0 03:23:41 INFO - Browser initialized. 03:23:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:41 INFO - Using env: {'DISPLAY': ':0', 03:23:41 INFO - 'HOME': '/home/cltbld', 03:23:41 INFO - 'JSGC_DISABLE_POISONING': '1', 03:23:41 INFO - 'LANG': 'en_US.UTF-8', 03:23:41 INFO - 'LANGUAGE': 'en_US:en', 03:23:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:23:41 INFO - 'LOGNAME': 'cltbld', 03:23:41 INFO - 'MAIL': '/var/mail/cltbld', 03:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:41 INFO - 'MOZ_CRASHREPORTER': '1', 03:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:23:41 INFO - 'MOZ_NO_REMOTE': '1', 03:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:41 INFO - 'NO_EM_RESTART': '1', 03:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:41 INFO - 'PWD': '/builds/slave/test', 03:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:41 INFO - 'RUST_BACKTRACE': 'full', 03:23:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:41 INFO - 'SHELL': '/bin/bash', 03:23:41 INFO - 'SHLVL': '1', 03:23:41 INFO - 'STYLO_FORCE_DISABLED': '1', 03:23:41 INFO - 'TERM': 'linux', 03:23:41 INFO - 'TMOUT': '86400', 03:23:41 INFO - 'USER': 'cltbld', 03:23:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:41 INFO - '_': '/tools/buildbot/bin/python'} 03:23:41 INFO - TEST-INFO | started process 25363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp42J402/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:42 INFO - PID 25363 | 03:23:42 INFO - PID 25363 | (/builds/slave/test/build/application/firefox/firefox:25412): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:23:42 INFO - PID 25363 | 03:23:52 INFO - PID 25363 | RSS: Main: 155160576 03:23:52 INFO - PID 25363 | 03:26:49 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50547/tests/dromaeo/cssquery-ext.html) 03:26:50 INFO - PID 25363 | RSS: Main: 156278784 03:26:50 INFO - PID 25363 | 03:29:52 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-ext.html (next: http://localhost:50547/tests/dromaeo/cssquery-jquery.html) 03:29:53 INFO - PID 25363 | RSS: Main: 152899584 03:29:53 INFO - PID 25363 | 03:32:54 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50547/tests/dromaeo/cssquery-mootools.html) 03:32:55 INFO - PID 25363 | RSS: Main: 154931200 03:32:55 INFO - PID 25363 | 03:35:57 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50547/tests/dromaeo/cssquery-prototype.html) 03:35:57 INFO - PID 25363 | RSS: Main: 155508736 03:35:57 INFO - PID 25363 | 03:39:01 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50547/tests/dromaeo/cssquery-yui.html) 03:39:01 INFO - PID 25363 | RSS: Main: 156884992 03:39:01 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | Cycle 1(1): loaded http://localhost:50547/tests/dromaeo/cssquery-yui.html (next: http://localhost:50547/tests/dromaeo/cssquery-dojo.html) 03:42:03 INFO - PID 25363 | RSS: Main: 159645696 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | __start_tp_report 03:42:03 INFO - PID 25363 | _x_x_mozilla_page_load 03:42:03 INFO - PID 25363 | _x_x_mozilla_page_load_details 03:42:03 INFO - PID 25363 | |i|pagename|runs| 03:42:03 INFO - PID 25363 | |0;dojo.html;3101.1316831287236;3128.014675377256;3129.2333378322314;3150.984245078774;3157.7000184982435;6184.443400093991;6263.279722831876;6295.622262664243;6335.144755458012;6388.744450221991;6244.406781355775;6274.341194174614;6325.051242313655;6400.295967443589;6422.9357706422925;5806.506446952004;5826.592138550303;5879.147523609074;5888.470037696607;5910.645361278315;30.39714152163504;5401.972990135064;5626.099824028156;5702.800401985931;5856.970715146418;5690.3456102548325;5693.231413759152;5730.79942202023;5733.369329373765;5762.567807414419;5725.856853578653;5726.284214473191;5745;5785.739641716133;5823.039198532237;5790.305163380422;5799.594028418012;5818.359980402152;5824.388439213906;5848.5321174305955;6197.318294987548;6289.182406287199;6337.904931425986;6373.7450501979865;6404.231492220963;6547.5089368297095;6640.468762498988;6667.6666166691475;6721.126253587003;6816.216135144472;6751.898721519132;6756.864862702768;6759.526833121683;6766.052752614638;6830.521863469559;6259.061140828867;6294.339094395114;6357.07822365759;6380.585261957958;6383.138276332682;6917.446604271747;6953.860922781516;7014.964925175444;7032.613206273653;7042.7887163385185;6490.188726409199;6585.287825165396;6597.406233439014;6599.60402375859;6612.504062195355;6762.729490820312;6766.458683305324;6766.966165169143;6767.018782276542;6769.695363708645;6651.66741662915;6676.599404035774;6723.966380168165;6757.898631520531;6758.357955994173;6709.664516774239;6719.462443004548;6798.5241033128195;6801.523893327519;6804.795856124324;5083.949160508348;5149.150390185578;5149.665271757323;5205.531502164823;5281.498257665516;4589.862304130881;4594.196015697306;4621.376114224604;4647.465541462775;4687.367205427224;5742.7415766290615;5746.913796293059;5814.098814683731;5814.563907706939;5814.680192589363;6436.613803171731;6694.297098804555;6702.497312701566;6778.084958530535;6786.762463313859;5718.656880587178;5767.8558036049435;5779.422057794187;5817.680027598522;5817.76728930838;5606.6916319602;5811.622244554091;5814.709264536757;5822.0684690449325;5831.2127862738835;6469.482441404676;6486.610803351814;6493.805185844432;6537.8692426152165;6627.734890604322;6705.865882682417;6731.899021514779;6773.593584384953;6806.421454176351;6827.965860170667;6339.4928405726505;6480.287168411565;6495.382938620824;6551.836204094936;6642.6014439133805;6647.235567909753;6654.800355989328;6655.2346480153465;6677.866442671022;6689.565178263398;6787.321267873173;6826.795196144124;6829.795106146824;6833.41915937131;6837.453003759588;6440.871182576228;6449.645269510034;6456.418922297016;6478.1578394808375;6558.278589355072;6334.429901308904;6435.099086127852;6435.646039467687;6440;6542.051402546699;6378.712957916998;6414.518911081781;6446.580972236789;6447.387498187664;6549.181352330958;6540.411362977355;6559.212894452697;6600.966995165186;6615.900761488678;6645.833854153685;6294.622322660655;6296.433321001132;6385.96807015962;6401.967990160019;6407.455366293917 03:42:03 INFO - PID 25363 | |1;ext.html;859.7506723050316;878.0429332028089;880.8326417980584;883.6730409748394;883.907189745077;38917.61082389175;42203.57796422035;42670.78664606673;42682.359764603556;42701.7864910675;39795.20409591814;39843;40049.39925901114;40144.598554014454;40239.59760402395;6899.172099348085;7050.682719277619;7054.717811287543;7070.646467676621;7088.57468551886;6915.066466027098;7007.649617519129;7021.508494405393;7033.964830175842;7060.611666358348;7001.754938577151;7038.085048943656;7688.961555192216;7867.7246296379635;7880.80297992549;7762.805929851743;7822.804429889241;7827.412944029221;7829.3736501079775;7834.2949134577875;7565.735199268;7669.578173200472;7754.302112809874;7756.0304961879765;7772.300492955605;38920.22159556821;39043.21913561713;39321.213575728325;39366.409503857176;39406;3396.320735852815;3448.2930999145115;3457.896263112111;3460.048486666162;3469.3755124077657;31482;31789.04632861018;31886;31918.840405798055;31928.361432771446;5183.611229157828;5197.168453047532;5253.52718255355;5254.474552544753;5273.34083239595;193165;194370.99999999857;194556;194630;195350;41870.1625967479;42702;48744;48813.26780098301;50106;53379;53904.73047634815;53910.730446347516;53968.73015634897;54119.188212176065;16599.91700041492;16719.83280167207;16738.74891876623;16741.581460463585;16767;13639.386227619781;13688.863111368959;13778.586642400744;13781.448742050407;13881.583552493239;14561.344739486749;14605;14744.18906960106;14842.925785371004;14866.554003379915;5861.413858614104;5913.408659134138;5923.200367950358;5957.672328021914;6016.639001659914;968.1093394077466;989.7822479054596;1000.0999100809184;1000.1044885286627;1022.1618273016204;22702.8052689922;22897.427564310692;22916.312510624706;22936.197233096762;23044.539109217723;1100.8458815765798;1108.41808050774;1110.9388983605818;1111.344306858957;1119.0767616716241;12126.878731212752;12145.574904878287;12237.388130593436;12274.570390036306;12385.009199264037;214493;215849;216155;216428;216455;52872.47127528753;52894.47105528972;53211.73394133082;53327.73336133372;53348.46651533435;1401.6776141487312;1440.063958427031;1443.1918125849347;1450.9201993890226;1455.9490417835113;22719.659205112268;23023.769762302163;23146.305610831703;23187.536249274584;23246.41883952847;37822.243555129295;38081.4287785689;38185;38226;38302.808485957394;187596;189351;189362;190032;190241.04879475513;35650.643493564734;38027.61972380241;38427.61572384352;38645.61354386533;38761.22477550377;46124;47229;47452.525474746195;47484.28773568468;48165.27752083651;33965;34105.65894341025;34184.658153418146;34687;34847.9545613632;34227.14432139217;34398.14004649904;34555.827220863735;34598;34866.302673946884;39078.413823793235;39509;39515.2096958065;39624.80187599044;39652.20695586014;33441;33636.327273453906;33785.493217601266;33896.66103339034;34248.315033699684;24084.39789005289;24308.87845560761;24436;24602.630960535964;25299.367515812253 03:42:03 INFO - PID 25363 | |2;jquery.html;560.1849309255034;561.8230257468897;571.9399463056379;574.4657468554243;590.6869359239603;22110.336689899308;22903.541929161405;22942.311730648107;22958.540829183406;22992.19527316542;23847.28458146254;24712.629310560354;25043.24870253891;25118;25187.37031574207;6500.5124615653895;6670.266270710218;6670.699818508155;6708.161479815023;6708.631025293607;6346.968265158668;6562.146920900276;6645.435138013275;6667.599944003351;6676.499262555303;6591.670416479181;6615.503837212204;6617.470602351825;6618.007298905155;6618.7021584028835;6110.938890611126;6582.473402127842;6614.140161778986;6618.073469714244;6622.6357550334715;5836.182934389189;5960.403959604048;5963.970180149072;5964.821055368346;5969.224000879901;27991.860040699667;28275;28375.432491350057;28430.57354139669;28455.71544284572;1963.7741659709172;1997.3608445297511;1997.530580313625;1998.6502362086576;1998.740163778714;17954.281828726835;18109.36617218391;18321.450356489328;18801.247950082117;19012.049397530205;2411.5056413435377;2428.0651948999584;2440.804735621146;2457.0294733580135;2459.9754002459927;121743;127383;127508;137224;144746.27626861903;14367.78448323276;14404.814266863921;14541.78187327191;14612.634684132981;15089.773653395208;23130.421739456313;23138.652920206212;23165.7683423167;23226.07095716186;23285.41786455352;10066.396016239049;10170.389511723379;10371.170306375472;10494.42280674555;10599.682009539727;9614.51927403627;9689.32174747775;9698;9699.951500242454;9769.85063286076;8739.12608739121;9092.954535227282;9243.491607961627;9267.536623168815;9298.72103836886;2511.91208307712;2541.69499660042;2613.8693065346656;2625.4355313607666;2758.4483103379403;936.2182577547687;943.2171297822928;946.9621215151317;952.9332946693803;956.2827879090682;18361.81638183601;18747.875127492392;18823;18946.336878209473;19076.904615476833;1004.1765752083221;1008.9949550252202;1009.5103874620803;1019.5615885169449;1021.3667526133845;10532.420716860646;10593.311434756715;10712.678619641423;10717.9464102679;10731.08785753204;451084;465769;469565;483657;488868;116729.41635291769;116791.41604291924;117491.41254293844;119427.40286298512;120451;1157.3808012713157;1160.4487868262509;1172.4489489939715;1182.6924999500193;1185.9703507412385;16839.831601683825;16938.40715574949;17062.573435664206;17120.40078597243;17152.48542543726;55210.447895520534;55373.446265536826;55772.442275578345;56591.71704141453;56819.431805681415;68703.31296687169;69968.30031699617;70197.29802702111;70856.64571677109;70899;13922.303884805922;14088;14303.713925721218;14325.355359009078;14412.351444185246;22281.44296392603;22380.664290035988;22662.206822761123;22666.546669066855;22698.205562805222;16566.83433165653;16689.16554172262;16733.497995060166;17312.134393280536;17659;15452.227388630748;15553.533393997746;16090.275937582603;16535.586610334838;16630.833691662927;17250.309987600856;18381.540461488035;18390.816091839446;18395.63208735791;18627.534311642317;13991.58025259244;14000.43998240059;14040.78938815939;14056.929715351767;14066.296685165906;17721.202545885208;17885;18037.458876233733;18043.63912721712;18071.277148913898 03:42:03 INFO - PID 25363 | |3;mootools.html;1278.4374875054975;1365.2491129878565;1382.0740104130232;1388.645895296699;1395.2395944210405;14661.413543458262;15271.541853744391;15289;15299.158546279965;15315;14973.401063957455;15036.774448383283;15060.472883449082;15109.244537773095;15115.470958516455;2739.52058389782;2757.0625987164412;2808.354078561932;2822.830630162197;2823.68939416664;2773.1819113361507;2824.548072308431;2827.349709566801;2833.2350265428427;2846.729560691731;2760.0753747494614;2772;2889.754370878478;2890.667573229074;2892.3203047283873;2783.6520434945633;2796.133198708397;2818.9147178336284;2824.74577288044;2827.476916770404;2569.5503286924713;2711.8779654915575;2766.101017169408;2771.071690983523;2788.8326700398043;15132.167730774803;15214.543563692996;15259;15272.847271527253;15284.847151528453;8039.839203215903;8372.53951032693;8383.580820958989;8384.371172162113;8386.790330241733;5455.509004189642;5585.106382978704;5753.395893431213;5754.482096611325;5763.193152958547;1916.1473144450724;1929.2958070304237;1929.7201905723732;1932.9806701932941;1974.1609815828215;26455.941762329483;26690.5996410054;26716;26764.197074088002;26768;7338.156112047076;7410.406762546078;7652.80867978305;7655.425843061793;7679.116901556393;19971;20070.59858802816;20115.29596464117;20127.0942807574;20153.79846201519;8222.38332125093;8526.531040792692;8557.614907329185;8558.144185581392;8565.486070835645;6989.790306290819;7124.216336203013;7133.821654458577;7619.08570971487;7629.580373079534;5496.862578435571;5779.537636989031;5798.797042103591;5842.795502157404;5861.443162899518;1769.7433872088475;1828.7714035745532;1847.5842935339442;1860.7208918662309;1862.0317434933759;863.2532859076979;882.0870399136862;892.3619611977467;898.26342399232;902.2466240688967;7318.131273592223;7319.890201646979;7332.96333518329;7366.815829604196;7383.467496583614;712.9322714342129;713.1335427455666;724.9963750181321;728.3153835394712;734.3170851108521;4909.926351104665;4935.851924442272;4977.8302099006705;5223.5559977402345;5312.62811603184;20705.171793128407;21424.57150856974;21636;21639.891800540896;21667;20990.265340713002;21222.151113955268;21639.13443462244;21779;21844.672329915065;10971.835422468828;11214.551417943354;11380.203385762918;11388.601398950997;11418.885811141949;8065.435419520577;8103.189681031849;8235.670573177005;8324.375671824517;8461.746147615582;18239;18747.34384296543;18775.530611734815;19126.33057842969;19181.520461988563;18622.813771862107;19109.23563057462;19207.32774352891;19532.707009394588;19735;12145.332006739714;12281;12293.139480236297;12307.815382769444;12312.507499699912;13672.658183545092;13839;13857.861421385656;13927.58217253484;13942;9947.204223662235;10102.191824653863;10396.428196449267;10626.362418254621;10779.568817247222;10969.945150274198;10979.780404392028;11081.113510918945;11156.44217789091;11240.662780116609;9336.486493242937;9519.619215231312;9521.095495927875;9532.428054316762;9535.809283814424;7153.606551639502;7172.103487064117;7238.203797582367;7246.275372462712;7264.091988501437;7121.181064177686;7281.1395352314175;7382.298681625237;7440.813979650552;7446.180920098893 03:42:03 INFO - PID 25363 | |4;prototype.html;494.63976036575747;496.5083150482092;521.4472658981477;522.9111051121309;529.0239508107543;6106.694665266736;6118.908216376758;6159.8768024639485;6169.475594574461;6224.751009959597;6002.519798416127;6060.787872424466;6090.269167699871;6106.969465152668;6107.267127944642;5082.390113186423;5095.4649761774945;5104.183330667094;5159.458256883011;5178.197379406198;4717.150912835688;4890.21756518957;5083.923741143867;5129.871753206163;5173;4862.34358361622;4897.902041959159;4920.901581968376;4930.605551555885;4944.651290636936;4828.493008234155;4854;4889.437714662824;4892.798240791658;4954.232094025432;4275.957240427587;4396.846110386153;4401.779911004469;4404.7357158570585;4433.135538569948;5979.431953964367;5988.31134419543;6003.699815009276;6009.1587177795145;6009.369016253274;5583.469570390806;5617.691026993513;5618.387449835846;5625.54995600351;5638.915416268759;6445.129907462479;6465.028166409244;6469.902951455685;6480;6483.967580162116;4595.425571803525;4763.666543341968;4799.808127595145;4814.277858321245;4839.104765618336;6480.384363485461;6483;6621.238557565894;6647.302033286435;6748.29142939994;4911.705297682151;4931.876703082452;4933.753312334369;4934.432540257844;4952.826651067196;4969.776360063805;4970.676906001098;5000.999800039934;5033.874153146127;5061.139606266944;5584.46947539983;5646.71766411686;5652.378238393856;5654.434556544395;5657.377688454267;6283.748650054038;6352.205974253218;6452;6492.577982431127;6533.738650454024;1707.1890851845521;1724.7326664367042;1727.3177095047386;1734.6097128146066;1738.9130543472775;1148.609472779259;1199.244475980127;1203.946546771575;1217.3852204636603;1222.6454328244888;5501.257330260363;5640.576956728261;5648.774049037993;5652.63257888236;5657.868426314753;6616.3714447128405;6637.734490620418;6643.734250630017;6684.665766711645;6686.899696504459;5676.375598684142;5693.715314234355;5703.344115426696;5706.115552089433;5728.427157284238;3441.913952151216;3447.9482807757904;3463.913402164966;3487.2502411981545;3505.702015328726;6413.37644231008;6423.004434312689;6436.774712885027;6449.548531602836;6481.995290729945;6836.658167091626;6839.555428897106;6851.3491218334175;6874.484413668994;6885.724571017204;6410.743570257231;6423.132877061536;6443.903341449882;6449.193850768747;6466.935330646727;6525.64108974011;6530.67346632657;6582.473402127914;6595.967020164869;6616.4045235929;6528.314526974599;6595.4500692336305;6636.834079147867;6646.767363142267;6653.933460665331;6353.39642733958;6412.100867202092;6412.35876412355;6476.158099447231;6481.189851268591;4869.780859861386;4941.308216849572;4942.382202224722;4948.975255123702;4954.677945933503;6345.682715864281;6392.360763923571;6512.869742605216;6705.698243579148;6710.892702703999;6342.429181373698;6349.206349206349;6375.553711240169;6388.87222255543;6410.967945160244;6284.308726040041;6299.433051025429;6299.685015749103;6340.175777148941;6347.666989931981;6129.8851896095775;6307.432331090224;6310.1796766420075;6341.302456729663;6373.075903993988;6288.496920246278;6431.517636177212;6451.322656109352;6480.513961452815;6502.219733631994;6067.453929146398;6193.318734939063;6228.408301211378;6290.2766181889665;6297.52768542352 03:42:03 INFO - PID 25363 | |5;yui.html;873.0309356614162;892.4333048514194;899.5727029660908;900.6712549919281;926.7497775600586;17782.644347113066;18266.90866545667;18287.81712182878;18295.451136465927;18444.170012349445;16995.23521441535;17391.565210869736;17601.7359739604;17626.64746705065;17664.823351766478;956.3592393096642;967.1199208720066;967.5307475874196;971.0920289529313;971.2133172130561;939.8684184214216;977.0522593084696;977.384247923807;977.5600979559191;978.0659470205972;1054.609794376082;1058.7829494953517;1064.5156453813536;1064.8935106489328;1065.0840277361463;991.0634450444333;1054.5834395413806;1058.2169194795872;1058.481344141369;1060.4220699718633;749.9062617172854;751.2787723785173;754.4115589839934;754.5359603843597;754.6679461037127;16285.755713664304;16372.099534525596;16402;16425.26086326118;16452.917735411367;21145.894270528705;21212.575748484946;21796;21825.345239642837;22028.88985555062;15971.121588312639;16135.919320403324;16297.83702162987;16313.755293670485;16437.58906027347;3716.572594151653;3766.623337666239;3779.8866034019024;3782.659560639528;3784.375578029622;131275;135667.32166339204;139915.30042349824;140208;140284.29857850645;15693.529194124194;15731.4493992712;15826.60433489172;15886.126263055412;15889.761653575206;27832.304192394946;28043.71956280452;28713.85643071771;28731.425371492453;28744.568831467546;7938.404619653434;7976.481528700616;8005.159458256916;8093.19068093186;8101.6354264058255;3984.86052988144;4030.7380020298588;4057.878263652095;4061.3704875744306;4062.4921884764403;4918.409790825052;4946.975265123651;4997.875053123628;5030.446650868402;5067.290579318898;1028.8559601655775;1032.9586816527406;1050.9421981791074;1053.8524606555088;1061.0609610494769;663.731188868509;674.3728332650682;684.6337209592843;692.8926016467456;693.784926672723;11488.977466039427;11722.765544689059;11748;11925.701857453632;11966.940165299291;648.3613640564041;650.3593959949446;652.54974067893;663.6449499517735;668.1514476614672;5102.821401250939;5160.587153027749;5163.0190263849745;5179.430262671103;5226.660267082628;118566;122894;123487.3825630866;124066;124142;103284;104463;106090;106548;106698.46650766852;90626;93403.73086941925;94529;95411;97490.51254743681;9620.508821132735;9780.217582593234;9896.554655040685;9918.256130790363;9919.20646348276;43099.56900430955;43476.565234347254;44725;46239.306410403195;47348;57208.71395642995;57294;57431.42568574261;58395.70802145962;59204.70397647984;15060.246987650793;15388;15494.985651865185;15633.374665013727;15672.451464199154;16487.505374838773;16606.584835379213;16613.41853035138;16696.081715505763;16731.581710457336;15189.924050379677;15297.923510382821;15313.923430382776;15428.84571154319;15442.30509627047;14623.19572423527;14638.41446342177;14776.187309698069;14780.260986950394;14787.11277323364;15143.242837858283;15260.542183734506;15298.694026119638;15391.3073911672;15398.384064637288;10484.895151048391;10706.73233169177;10766.515506802056;10879.673609791718;10956.671299861016;11540.24988375753;11572.942135289606;11660.941695291809;11804.527818887149;11873.82189267179 03:42:03 INFO - PID 25363 | __end_tp_report 03:42:03 INFO - PID 25363 | __start_cc_report 03:42:03 INFO - PID 25363 | _x_x_mozilla_cycle_collect,266 03:42:03 INFO - PID 25363 | __end_cc_report 03:42:03 INFO - PID 25363 | __startTimestamp1505558523424__endTimestamp 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | ------- Summary: start ------- 03:42:03 INFO - PID 25363 | Number of tests: 6 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#0] dojo.html Cycles:165 Average:6145.09 Median:6414.52 stddev:890.91 (13.9%) stddev-sans-first:861.04 03:42:03 INFO - PID 25363 | Values: 3101.1 3128.0 3129.2 3151.0 3157.7 6184.4 6263.3 6295.6 6335.1 6388.7 6244.4 6274.3 6325.1 6400.3 6422.9 5806.5 5826.6 5879.1 5888.5 5910.6 30.4 5402.0 5626.1 5702.8 5857.0 5690.3 5693.2 5730.8 5733.4 5762.6 5725.9 5726.3 5745.0 5785.7 5823.0 5790.3 5799.6 5818.4 5824.4 5848.5 6197.3 6289.2 6337.9 6373.7 6404.2 6547.5 6640.5 6667.7 6721.1 6816.2 6751.9 6756.9 6759.5 6766.1 6830.5 6259.1 6294.3 6357.1 6380.6 6383.1 6917.4 6953.9 7015.0 7032.6 7042.8 6490.2 6585.3 6597.4 6599.6 6612.5 6762.7 6766.5 6767.0 6767.0 6769.7 6651.7 6676.6 6724.0 6757.9 6758.4 6709.7 6719.5 6798.5 6801.5 6804.8 5083.9 5149.2 5149.7 5205.5 5281.5 4589.9 4594.2 4621.4 4647.5 4687.4 5742.7 5746.9 5814.1 5814.6 5814.7 6436.6 6694.3 6702.5 6778.1 6786.8 5718.7 5767.9 5779.4 5817.7 5817.8 5606.7 5811.6 5814.7 5822.1 5831.2 6469.5 6486.6 6493.8 6537.9 6627.7 6705.9 6731.9 6773.6 6806.4 6828.0 6339.5 6480.3 6495.4 6551.8 6642.6 6647.2 6654.8 6655.2 6677.9 6689.6 6787.3 6826.8 6829.8 6833.4 6837.5 6440.9 6449.6 6456.4 6478.2 6558.3 6334.4 6435.1 6435.6 6440.0 6542.1 6378.7 6414.5 6446.6 6447.4 6549.2 6540.4 6559.2 6601.0 6615.9 6645.8 6294.6 6296.4 6386.0 6402.0 6407.5 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#1] ext.html Cycles:180 Average:37650.29 Median:38054.52 stddev:51799.10 (136.1%) stddev-sans-first:51870.75 03:42:03 INFO - PID 25363 | Values: 859.8 878.0 880.8 883.7 883.9 38917.6 42203.6 42670.8 42682.4 42701.8 39795.2 39843.0 40049.4 40144.6 40239.6 6899.2 7050.7 7054.7 7070.6 7088.6 6915.1 7007.6 7021.5 7034.0 7060.6 7001.8 7038.1 7689.0 7867.7 7880.8 7762.8 7822.8 7827.4 7829.4 7834.3 7565.7 7669.6 7754.3 7756.0 7772.3 38920.2 39043.2 39321.2 39366.4 39406.0 3396.3 3448.3 3457.9 3460.0 3469.4 31482.0 31789.0 31886.0 31918.8 31928.4 5183.6 5197.2 5253.5 5254.5 5273.3 193165.0 194371.0 194556.0 194630.0 195350.0 41870.2 42702.0 48744.0 48813.3 50106.0 53379.0 53904.7 53910.7 53968.7 54119.2 16599.9 16719.8 16738.7 16741.6 16767.0 13639.4 13688.9 13778.6 13781.4 13881.6 14561.3 14605.0 14744.2 14842.9 14866.6 5861.4 5913.4 5923.2 5957.7 6016.6 968.1 989.8 1000.1 1000.1 1022.2 22702.8 22897.4 22916.3 22936.2 23044.5 1100.8 1108.4 1110.9 1111.3 1119.1 12126.9 12145.6 12237.4 12274.6 12385.0 214493.0 215849.0 216155.0 216428.0 216455.0 52872.5 52894.5 53211.7 53327.7 53348.5 1401.7 1440.1 1443.2 1450.9 1455.9 22719.7 23023.8 23146.3 23187.5 23246.4 37822.2 38081.4 38185.0 38226.0 38302.8 187596.0 189351.0 189362.0 190032.0 190241.0 35650.6 38027.6 38427.6 38645.6 38761.2 46124.0 47229.0 47452.5 47484.3 48165.3 33965.0 34105.7 34184.7 34687.0 34848.0 34227.1 34398.1 34555.8 34598.0 34866.3 39078.4 39509.0 39515.2 39624.8 39652.2 33441.0 33636.3 33785.5 33896.7 34248.3 24084.4 24308.9 24436.0 24602.6 25299.4 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#2] jquery.html Cycles:180 Average:33847.86 Median:22800.87 stddev:79692.10 (349.5%) stddev-sans-first:79876.46 03:42:03 INFO - PID 25363 | Values: 560.2 561.8 571.9 574.5 590.7 22110.3 22903.5 22942.3 22958.5 22992.2 23847.3 24712.6 25043.2 25118.0 25187.4 6500.5 6670.3 6670.7 6708.2 6708.6 6347.0 6562.1 6645.4 6667.6 6676.5 6591.7 6615.5 6617.5 6618.0 6618.7 6110.9 6582.5 6614.1 6618.1 6622.6 5836.2 5960.4 5964.0 5964.8 5969.2 27991.9 28275.0 28375.4 28430.6 28455.7 1963.8 1997.4 1997.5 1998.7 1998.7 17954.3 18109.4 18321.5 18801.2 19012.0 2411.5 2428.1 2440.8 2457.0 2460.0 121743.0 127383.0 127508.0 137224.0 144746.3 14367.8 14404.8 14541.8 14612.6 15089.8 23130.4 23138.7 23165.8 23226.1 23285.4 10066.4 10170.4 10371.2 10494.4 10599.7 9614.5 9689.3 9698.0 9700.0 9769.9 8739.1 9093.0 9243.5 9267.5 9298.7 2511.9 2541.7 2613.9 2625.4 2758.4 936.2 943.2 947.0 952.9 956.3 18361.8 18747.9 18823.0 18946.3 19076.9 1004.2 1009.0 1009.5 1019.6 1021.4 10532.4 10593.3 10712.7 10717.9 10731.1 451084.0 465769.0 469565.0 483657.0 488868.0 116729.4 116791.4 117491.4 119427.4 120451.0 1157.4 1160.4 1172.4 1182.7 1186.0 16839.8 16938.4 17062.6 17120.4 17152.5 55210.4 55373.4 55772.4 56591.7 56819.4 68703.3 69968.3 70197.3 70856.6 70899.0 13922.3 14088.0 14303.7 14325.4 14412.4 22281.4 22380.7 22662.2 22666.5 22698.2 16566.8 16689.2 16733.5 17312.1 17659.0 15452.2 15553.5 16090.3 16535.6 16630.8 17250.3 18381.5 18390.8 18395.6 18627.5 13991.6 14000.4 14040.8 14056.9 14066.3 17721.2 17885.0 18037.5 18043.6 18071.3 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#3] mootools.html Cycles:180 Average:9458.89 Median:2771.54 stddev:6764.57 (244.1%) stddev-sans-first:6755.62 03:42:03 INFO - PID 25363 | Values: 1278.4 1365.2 1382.1 1388.6 1395.2 14661.4 15271.5 15289.0 15299.2 15315.0 14973.4 15036.8 15060.5 15109.2 15115.5 2739.5 2757.1 2808.4 2822.8 2823.7 2773.2 2824.5 2827.3 2833.2 2846.7 2760.1 2772.0 2889.8 2890.7 2892.3 2783.7 2796.1 2818.9 2824.7 2827.5 2569.6 2711.9 2766.1 2771.1 2788.8 15132.2 15214.5 15259.0 15272.8 15284.8 8039.8 8372.5 8383.6 8384.4 8386.8 5455.5 5585.1 5753.4 5754.5 5763.2 1916.1 1929.3 1929.7 1933.0 1974.2 26455.9 26690.6 26716.0 26764.2 26768.0 7338.2 7410.4 7652.8 7655.4 7679.1 19971.0 20070.6 20115.3 20127.1 20153.8 8222.4 8526.5 8557.6 8558.1 8565.5 6989.8 7124.2 7133.8 7619.1 7629.6 5496.9 5779.5 5798.8 5842.8 5861.4 1769.7 1828.8 1847.6 1860.7 1862.0 863.3 882.1 892.4 898.3 902.2 7318.1 7319.9 7333.0 7366.8 7383.5 712.9 713.1 725.0 728.3 734.3 4909.9 4935.9 4977.8 5223.6 5312.6 20705.2 21424.6 21636.0 21639.9 21667.0 20990.3 21222.2 21639.1 21779.0 21844.7 10971.8 11214.6 11380.2 11388.6 11418.9 8065.4 8103.2 8235.7 8324.4 8461.7 18239.0 18747.3 18775.5 19126.3 19181.5 18622.8 19109.2 19207.3 19532.7 19735.0 12145.3 12281.0 12293.1 12307.8 12312.5 13672.7 13839.0 13857.9 13927.6 13942.0 9947.2 10102.2 10396.4 10626.4 10779.6 10969.9 10979.8 11081.1 11156.4 11240.7 9336.5 9519.6 9521.1 9532.4 9535.8 7153.6 7172.1 7238.2 7246.3 7264.1 7121.2 7281.1 7382.3 7440.8 7446.2 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#4] prototype.html Cycles:180 Average:5424.86 Median:6035.08 stddev:1515.57 (25.1%) stddev-sans-first:1473.96 03:42:03 INFO - PID 25363 | Values: 494.6 496.5 521.4 522.9 529.0 6106.7 6118.9 6159.9 6169.5 6224.8 6002.5 6060.8 6090.3 6107.0 6107.3 5082.4 5095.5 5104.2 5159.5 5178.2 4717.2 4890.2 5083.9 5129.9 5173.0 4862.3 4897.9 4920.9 4930.6 4944.7 4828.5 4854.0 4889.4 4892.8 4954.2 4276.0 4396.8 4401.8 4404.7 4433.1 5979.4 5988.3 6003.7 6009.2 6009.4 5583.5 5617.7 5618.4 5625.5 5638.9 6445.1 6465.0 6469.9 6480.0 6484.0 4595.4 4763.7 4799.8 4814.3 4839.1 6480.4 6483.0 6621.2 6647.3 6748.3 4911.7 4931.9 4933.8 4934.4 4952.8 4969.8 4970.7 5001.0 5033.9 5061.1 5584.5 5646.7 5652.4 5654.4 5657.4 6283.7 6352.2 6452.0 6492.6 6533.7 1707.2 1724.7 1727.3 1734.6 1738.9 1148.6 1199.2 1203.9 1217.4 1222.6 5501.3 5640.6 5648.8 5652.6 5657.9 6616.4 6637.7 6643.7 6684.7 6686.9 5676.4 5693.7 5703.3 5706.1 5728.4 3441.9 3447.9 3463.9 3487.3 3505.7 6413.4 6423.0 6436.8 6449.5 6482.0 6836.7 6839.6 6851.3 6874.5 6885.7 6410.7 6423.1 6443.9 6449.2 6466.9 6525.6 6530.7 6582.5 6596.0 6616.4 6528.3 6595.5 6636.8 6646.8 6653.9 6353.4 6412.1 6412.4 6476.2 6481.2 4869.8 4941.3 4942.4 4949.0 4954.7 6345.7 6392.4 6512.9 6705.7 6710.9 6342.4 6349.2 6375.6 6388.9 6411.0 6284.3 6299.4 6299.7 6340.2 6347.7 6129.9 6307.4 6310.2 6341.3 6373.1 6288.5 6431.5 6451.3 6480.5 6502.2 6067.5 6193.3 6228.4 6290.3 6297.5 03:42:03 INFO - PID 25363 | 03:42:03 INFO - PID 25363 | [#5] yui.html Cycles:180 Average:23676.34 Median:18277.36 stddev:34937.39 (191.2%) stddev-sans-first:34993.45 03:42:03 INFO - PID 25363 | Values: 873.0 892.4 899.6 900.7 926.7 17782.6 18266.9 18287.8 18295.5 18444.2 16995.2 17391.6 17601.7 17626.6 17664.8 956.4 967.1 967.5 971.1 971.2 939.9 977.1 977.4 977.6 978.1 1054.6 1058.8 1064.5 1064.9 1065.1 991.1 1054.6 1058.2 1058.5 1060.4 749.9 751.3 754.4 754.5 754.7 16285.8 16372.1 16402.0 16425.3 16452.9 21145.9 21212.6 21796.0 21825.3 22028.9 15971.1 16135.9 16297.8 16313.8 16437.6 3716.6 3766.6 3779.9 3782.7 3784.4 131275.0 135667.3 139915.3 140208.0 140284.3 15693.5 15731.4 15826.6 15886.1 15889.8 27832.3 28043.7 28713.9 28731.4 28744.6 7938.4 7976.5 8005.2 8093.2 8101.6 3984.9 4030.7 4057.9 4061.4 4062.5 4918.4 4947.0 4997.9 5030.4 5067.3 1028.9 1033.0 1050.9 1053.9 1061.1 663.7 674.4 684.6 692.9 693.8 11489.0 11722.8 11748.0 11925.7 11966.9 648.4 650.4 652.5 663.6 668.2 5102.8 5160.6 5163.0 5179.4 5226.7 118566.0 122894.0 123487.4 124066.0 124142.0 103284.0 104463.0 106090.0 106548.0 106698.5 90626.0 93403.7 94529.0 95411.0 97490.5 9620.5 9780.2 9896.6 9918.3 9919.2 43099.6 43476.6 44725.0 46239.3 47348.0 57208.7 57294.0 57431.4 58395.7 59204.7 15060.2 15388.0 15495.0 15633.4 15672.5 16487.5 16606.6 16613.4 16696.1 16731.6 15189.9 15297.9 15313.9 15428.8 15442.3 14623.2 14638.4 14776.2 14780.3 14787.1 15143.2 15260.5 15298.7 15391.3 15398.4 10484.9 10706.7 10766.5 10879.7 10956.7 11540.2 11572.9 11660.9 11804.5 11873.8 03:42:03 INFO - PID 25363 | -------- Summary: end -------- 03:42:03 INFO - PID 25363 | 03:42:04 INFO - TEST-INFO | 25363: exit 0 03:42:04 INFO - TEST-OK | dromaeo_css | took 1109023ms 03:42:04 INFO - TEST-START | kraken 03:42:04 INFO - Initialising browser for kraken test... 03:42:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50547/getInfo.html -profile /tmp/tmpFta2_4/profile 03:42:04 INFO - TEST-INFO | started process 25728 (/builds/slave/test/build/application/firefox/firefox http://localhost:50547/getInfo.html) 03:42:09 INFO - TEST-INFO | 25728: exit 0 03:42:09 INFO - Browser initialized. 03:42:09 INFO - Running cycle 1/1 for kraken test... 03:42:09 INFO - Using env: {'DISPLAY': ':0', 03:42:09 INFO - 'HOME': '/home/cltbld', 03:42:09 INFO - 'JSGC_DISABLE_POISONING': '1', 03:42:09 INFO - 'LANG': 'en_US.UTF-8', 03:42:09 INFO - 'LANGUAGE': 'en_US:en', 03:42:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:42:09 INFO - 'LOGNAME': 'cltbld', 03:42:09 INFO - 'MAIL': '/var/mail/cltbld', 03:42:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:09 INFO - 'MOZ_CRASHREPORTER': '1', 03:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:42:09 INFO - 'MOZ_NO_REMOTE': '1', 03:42:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:09 INFO - 'NO_EM_RESTART': '1', 03:42:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:09 INFO - 'PWD': '/builds/slave/test', 03:42:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:09 INFO - 'RUST_BACKTRACE': 'full', 03:42:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:42:09 INFO - 'SHELL': '/bin/bash', 03:42:09 INFO - 'SHLVL': '1', 03:42:09 INFO - 'STYLO_FORCE_DISABLED': '1', 03:42:09 INFO - 'TERM': 'linux', 03:42:09 INFO - 'TMOUT': '86400', 03:42:09 INFO - 'USER': 'cltbld', 03:42:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858', 03:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:09 INFO - '_': '/tools/buildbot/bin/python'} 03:42:09 INFO - TEST-INFO | started process 25958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFta2_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:10 INFO - PID 25958 | 03:42:10 INFO - PID 25958 | (/builds/slave/test/build/application/firefox/firefox:26007): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:42:10 INFO - PID 25958 | 03:42:21 INFO - PID 25958 | RSS: Main: 154296320 03:42:21 INFO - PID 25958 | 03:42:23 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:24 INFO - PID 25958 | RSS: Main: 160636928 03:42:24 INFO - PID 25958 | 03:42:27 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-dft) 03:42:27 INFO - PID 25958 | RSS: Main: 160755712 03:42:27 INFO - PID 25958 | 03:42:30 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-fft) 03:42:31 INFO - PID 25958 | RSS: Main: 156844032 03:42:31 INFO - PID 25958 | 03:42:33 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50547/tests/kraken/driver.html?testName=audio-oscillator) 03:42:34 INFO - PID 25958 | RSS: Main: 157331456 03:42:34 INFO - PID 25958 | 03:42:36 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:36 INFO - PID 25958 | RSS: Main: 157634560 03:42:36 INFO - PID 25958 | 03:42:40 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:40 INFO - PID 25958 | RSS: Main: 159477760 03:42:40 INFO - PID 25958 | 03:42:44 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50547/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:44 INFO - PID 25958 | RSS: Main: 160079872 03:42:45 INFO - PID 25958 | 03:42:48 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50547/tests/kraken/driver.html?testName=json-parse-financial) 03:42:48 INFO - PID 25958 | RSS: Main: 160145408 03:42:48 INFO - PID 25958 | 03:42:50 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50547/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:50 INFO - PID 25958 | RSS: Main: 160194560 03:42:50 INFO - PID 25958 | 03:42:52 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:53 INFO - PID 25958 | RSS: Main: 157249536 03:42:53 INFO - PID 25958 | 03:42:55 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:55 INFO - PID 25958 | RSS: Main: 157200384 03:42:55 INFO - PID 25958 | 03:42:58 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:59 INFO - PID 25958 | RSS: Main: 157413376 03:42:59 INFO - PID 25958 | 03:43:02 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:02 INFO - PID 25958 | RSS: Main: 157704192 03:43:02 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | Cycle 1(1): loaded http://localhost:50547/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50547/tests/kraken/driver.html?testName=ai-astar) 03:43:04 INFO - PID 25958 | RSS: Main: 158736384 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | __start_tp_report 03:43:04 INFO - PID 25958 | _x_x_mozilla_page_load 03:43:04 INFO - PID 25958 | _x_x_mozilla_page_load_details 03:43:04 INFO - PID 25958 | |i|pagename|runs| 03:43:04 INFO - PID 25958 | |0;ai-astar;109;109;106;107;108;108;107;108;108;108 03:43:04 INFO - PID 25958 | |1;audio-beat-detection;118;120;119;117;118;115;118;118;118;114 03:43:04 INFO - PID 25958 | |2;audio-dft;162;162;163;163;164;162;163;165;169;166 03:43:04 INFO - PID 25958 | |3;audio-fft;74;76;75;74;74;73;100;78;75;74 03:43:04 INFO - PID 25958 | |4;audio-oscillator;79;79;79;78;79;79;78;78;78;79 03:43:04 INFO - PID 25958 | |5;imaging-gaussian-blur;113;114;114;110;113;114;114;114;114;114 03:43:04 INFO - PID 25958 | |6;imaging-darkroom;151;149;148;148;148;149;148;148;151;150 03:43:04 INFO - PID 25958 | |7;imaging-desaturate;99;93;94;95;95;95;94;94;94;94 03:43:04 INFO - PID 25958 | |8;json-parse-financial;54;52;55;53;55;53;53;54;54;59 03:43:04 INFO - PID 25958 | |9;json-stringify-tinderbox;40;38;39;38;38;38;38;39;42;39 03:43:04 INFO - PID 25958 | |10;stanford-crypto-aes;80;78;75;76;75;79;74;74;77;74 03:43:04 INFO - PID 25958 | |11;stanford-crypto-ccm;112;108;113;121;113;116;117;114;110;112 03:43:04 INFO - PID 25958 | |12;stanford-crypto-pbkdf2;172;174;170;169;167;172;175;171;172;168 03:43:04 INFO - PID 25958 | |13;stanford-crypto-sha256-iterative;62;64;69;66;69;65;63;65;67;68 03:43:04 INFO - PID 25958 | __end_tp_report 03:43:04 INFO - PID 25958 | __start_cc_report 03:43:04 INFO - PID 25958 | _x_x_mozilla_cycle_collect,759 03:43:04 INFO - PID 25958 | __end_cc_report 03:43:04 INFO - PID 25958 | __startTimestamp1505558584624__endTimestamp 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | ------- Summary: start ------- 03:43:04 INFO - PID 25958 | Number of tests: 14 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.00 stddev:0.92 (0.9%) stddev-sans-first:0.87 03:43:04 INFO - PID 25958 | Values: 109.0 109.0 106.0 107.0 108.0 108.0 107.0 108.0 108.0 108.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:118.00 stddev:1.78 (1.5%) stddev-sans-first:1.88 03:43:04 INFO - PID 25958 | Values: 118.0 120.0 119.0 117.0 118.0 115.0 118.0 118.0 118.0 114.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.23 (1.4%) stddev-sans-first:2.26 03:43:04 INFO - PID 25958 | Values: 162.0 162.0 163.0 163.0 164.0 162.0 163.0 165.0 169.0 166.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#3] audio-fft Cycles:10 Average:77.30 Median:74.50 stddev:8.10 (10.9%) stddev-sans-first:8.50 03:43:04 INFO - PID 25958 | Values: 74.0 76.0 75.0 74.0 74.0 73.0 100.0 78.0 75.0 74.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 03:43:04 INFO - PID 25958 | Values: 79.0 79.0 79.0 78.0 79.0 79.0 78.0 78.0 78.0 79.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 03:43:04 INFO - PID 25958 | Values: 113.0 114.0 114.0 110.0 113.0 114.0 114.0 114.0 114.0 114.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.25 (0.8%) stddev-sans-first:1.09 03:43:04 INFO - PID 25958 | Values: 151.0 149.0 148.0 148.0 148.0 149.0 148.0 148.0 151.0 150.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.64 (1.7%) stddev-sans-first:0.67 03:43:04 INFO - PID 25958 | Values: 99.0 93.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.93 (3.6%) stddev-sans-first:2.05 03:43:04 INFO - PID 25958 | Values: 54.0 52.0 55.0 53.0 55.0 53.0 53.0 54.0 54.0 59.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.29 (3.3%) stddev-sans-first:1.30 03:43:04 INFO - PID 25958 | Values: 40.0 38.0 39.0 38.0 38.0 38.0 38.0 39.0 42.0 39.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.50 stddev:2.20 (2.9%) stddev-sans-first:1.86 03:43:04 INFO - PID 25958 | Values: 80.0 78.0 75.0 76.0 75.0 79.0 74.0 74.0 77.0 74.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#11] stanford-crypto-ccm Cycles:10 Average:113.60 Median:113.50 stddev:3.69 (3.2%) stddev-sans-first:3.87 03:43:04 INFO - PID 25958 | Values: 112.0 108.0 113.0 121.0 113.0 116.0 117.0 114.0 110.0 112.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:172.00 stddev:2.54 (1.5%) stddev-sans-first:2.67 03:43:04 INFO - PID 25958 | Values: 172.0 174.0 170.0 169.0 167.0 172.0 175.0 171.0 172.0 168.0 03:43:04 INFO - PID 25958 | 03:43:04 INFO - PID 25958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:2.44 (3.7%) stddev-sans-first:2.17 03:43:04 INFO - PID 25958 | Values: 62.0 64.0 69.0 66.0 69.0 65.0 63.0 65.0 67.0 68.0 03:43:04 INFO - PID 25958 | -------- Summary: end -------- 03:43:04 INFO - PID 25958 | 03:43:05 INFO - PID 25958 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:05 INFO - TEST-INFO | 25958: exit 0 03:43:05 INFO - TEST-OK | kraken | took 61252ms 03:43:05 INFO - SUITE-END | took 1170s 03:43:05 INFO - Completed test suite (00:19:30) 03:43:05 INFO - javascript benchmark 03:43:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8432.259234830399, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.1316831287236, 3128.014675377256, 3129.2333378322314, 3150.984245078774, 3157.7000184982435, 6184.443400093991, 6263.279722831876, 6295.622262664243, 6335.144755458012, 6388.744450221991, 6244.406781355775, 6274.341194174614, 6325.051242313655, 6400.295967443589, 6422.9357706422925, 5806.506446952004, 5826.592138550303, 5879.147523609074, 5888.470037696607, 5910.645361278315, 30.39714152163504, 5401.972990135064, 5626.099824028156, 5702.800401985931, 5856.970715146418, 5690.3456102548325, 5693.231413759152, 5730.79942202023, 5733.369329373765, 5762.567807414419, 5725.856853578653, 5726.284214473191, 5745.0, 5785.739641716133, 5823.039198532237, 5790.305163380422, 5799.594028418012, 5818.359980402152, 5824.388439213906, 5848.5321174305955, 6197.318294987548, 6289.182406287199, 6337.904931425986, 6373.7450501979865, 6404.231492220963, 6547.5089368297095, 6640.468762498988, 6667.6666166691475, 6721.126253587003, 6816.216135144472, 6751.898721519132, 6756.864862702768, 6759.526833121683, 6766.052752614638, 6830.521863469559, 6259.061140828867, 6294.339094395114, 6357.07822365759, 6380.585261957958, 6383.138276332682, 6917.446604271747, 6953.860922781516, 7014.964925175444, 7032.613206273653, 7042.7887163385185, 6490.188726409199, 6585.287825165396, 6597.406233439014, 6599.60402375859, 6612.504062195355, 6762.729490820312, 6766.458683305324, 6766.966165169143, 6767.018782276542, 6769.695363708645, 6651.66741662915, 6676.599404035774, 6723.966380168165, 6757.898631520531, 6758.357955994173, 6709.664516774239, 6719.462443004548, 6798.5241033128195, 6801.523893327519, 6804.795856124324, 5083.949160508348, 5149.150390185578, 5149.665271757323, 5205.531502164823, 5281.498257665516, 4589.862304130881, 4594.196015697306, 4621.376114224604, 4647.465541462775, 4687.367205427224, 5742.7415766290615, 5746.913796293059, 5814.098814683731, 5814.563907706939, 5814.680192589363, 6436.613803171731, 6694.297098804555, 6702.497312701566, 6778.084958530535, 6786.762463313859, 5718.656880587178, 5767.8558036049435, 5779.422057794187, 5817.680027598522, 5817.76728930838, 5606.6916319602, 5811.622244554091, 5814.709264536757, 5822.0684690449325, 5831.2127862738835, 6469.482441404676, 6486.610803351814, 6493.805185844432, 6537.8692426152165, 6627.734890604322, 6705.865882682417, 6731.899021514779, 6773.593584384953, 6806.421454176351, 6827.965860170667, 6339.4928405726505, 6480.287168411565, 6495.382938620824, 6551.836204094936, 6642.6014439133805, 6647.235567909753, 6654.800355989328, 6655.2346480153465, 6677.866442671022, 6689.565178263398, 6787.321267873173, 6826.795196144124, 6829.795106146824, 6833.41915937131, 6837.453003759588, 6440.871182576228, 6449.645269510034, 6456.418922297016, 6478.1578394808375, 6558.278589355072, 6334.429901308904, 6435.099086127852, 6435.646039467687, 6440.0, 6542.051402546699, 6378.712957916998, 6414.518911081781, 6446.580972236789, 6447.387498187664, 6549.181352330958, 6540.411362977355, 6559.212894452697, 6600.966995165186, 6615.900761488678, 6645.833854153685, 6294.622322660655, 6296.433321001132, 6385.96807015962, 6401.967990160019, 6407.455366293917], "value": 6079.984283261787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.7506723050316, 878.0429332028089, 880.8326417980584, 883.6730409748394, 883.907189745077, 38917.61082389175, 42203.57796422035, 42670.78664606673, 42682.359764603556, 42701.7864910675, 39795.20409591814, 39843.0, 40049.39925901114, 40144.598554014454, 40239.59760402395, 6899.172099348085, 7050.682719277619, 7054.717811287543, 7070.646467676621, 7088.57468551886, 6915.066466027098, 7007.649617519129, 7021.508494405393, 7033.964830175842, 7060.611666358348, 7001.754938577151, 7038.085048943656, 7688.961555192216, 7867.7246296379635, 7880.80297992549, 7762.805929851743, 7822.804429889241, 7827.412944029221, 7829.3736501079775, 7834.2949134577875, 7565.735199268, 7669.578173200472, 7754.302112809874, 7756.0304961879765, 7772.300492955605, 38920.22159556821, 39043.21913561713, 39321.213575728325, 39366.409503857176, 39406.0, 3396.320735852815, 3448.2930999145115, 3457.896263112111, 3460.048486666162, 3469.3755124077657, 31482.0, 31789.04632861018, 31886.0, 31918.840405798055, 31928.361432771446, 5183.611229157828, 5197.168453047532, 5253.52718255355, 5254.474552544753, 5273.34083239595, 193165.0, 194370.99999999857, 194556.0, 194630.0, 195350.0, 41870.1625967479, 42702.0, 48744.0, 48813.26780098301, 50106.0, 53379.0, 53904.73047634815, 53910.730446347516, 53968.73015634897, 54119.188212176065, 16599.91700041492, 16719.83280167207, 16738.74891876623, 16741.581460463585, 16767.0, 13639.386227619781, 13688.863111368959, 13778.586642400744, 13781.448742050407, 13881.583552493239, 14561.344739486749, 14605.0, 14744.18906960106, 14842.925785371004, 14866.554003379915, 5861.413858614104, 5913.408659134138, 5923.200367950358, 5957.672328021914, 6016.639001659914, 968.1093394077466, 989.7822479054596, 1000.0999100809184, 1000.1044885286627, 1022.1618273016204, 22702.8052689922, 22897.427564310692, 22916.312510624706, 22936.197233096762, 23044.539109217723, 1100.8458815765798, 1108.41808050774, 1110.9388983605818, 1111.344306858957, 1119.0767616716241, 12126.878731212752, 12145.574904878287, 12237.388130593436, 12274.570390036306, 12385.009199264037, 214493.0, 215849.0, 216155.0, 216428.0, 216455.0, 52872.47127528753, 52894.47105528972, 53211.73394133082, 53327.73336133372, 53348.46651533435, 1401.6776141487312, 1440.063958427031, 1443.1918125849347, 1450.9201993890226, 1455.9490417835113, 22719.659205112268, 23023.769762302163, 23146.305610831703, 23187.536249274584, 23246.41883952847, 37822.243555129295, 38081.4287785689, 38185.0, 38226.0, 38302.808485957394, 187596.0, 189351.0, 189362.0, 190032.0, 190241.04879475513, 35650.643493564734, 38027.61972380241, 38427.61572384352, 38645.61354386533, 38761.22477550377, 46124.0, 47229.0, 47452.525474746195, 47484.28773568468, 48165.27752083651, 33965.0, 34105.65894341025, 34184.658153418146, 34687.0, 34847.9545613632, 34227.14432139217, 34398.14004649904, 34555.827220863735, 34598.0, 34866.302673946884, 39078.413823793235, 39509.0, 39515.2096958065, 39624.80187599044, 39652.20695586014, 33441.0, 33636.327273453906, 33785.493217601266, 33896.66103339034, 34248.315033699684, 24084.39789005289, 24308.87845560761, 24436.0, 24602.630960535964, 25299.367515812253], "value": 17367.018155334055, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1849309255034, 561.8230257468897, 571.9399463056379, 574.4657468554243, 590.6869359239603, 22110.336689899308, 22903.541929161405, 22942.311730648107, 22958.540829183406, 22992.19527316542, 23847.28458146254, 24712.629310560354, 25043.24870253891, 25118.0, 25187.37031574207, 6500.5124615653895, 6670.266270710218, 6670.699818508155, 6708.161479815023, 6708.631025293607, 6346.968265158668, 6562.146920900276, 6645.435138013275, 6667.599944003351, 6676.499262555303, 6591.670416479181, 6615.503837212204, 6617.470602351825, 6618.007298905155, 6618.7021584028835, 6110.938890611126, 6582.473402127842, 6614.140161778986, 6618.073469714244, 6622.6357550334715, 5836.182934389189, 5960.403959604048, 5963.970180149072, 5964.821055368346, 5969.224000879901, 27991.860040699667, 28275.0, 28375.432491350057, 28430.57354139669, 28455.71544284572, 1963.7741659709172, 1997.3608445297511, 1997.530580313625, 1998.6502362086576, 1998.740163778714, 17954.281828726835, 18109.36617218391, 18321.450356489328, 18801.247950082117, 19012.049397530205, 2411.5056413435377, 2428.0651948999584, 2440.804735621146, 2457.0294733580135, 2459.9754002459927, 121743.0, 127383.0, 127508.0, 137224.0, 144746.27626861903, 14367.78448323276, 14404.814266863921, 14541.78187327191, 14612.634684132981, 15089.773653395208, 23130.421739456313, 23138.652920206212, 23165.7683423167, 23226.07095716186, 23285.41786455352, 10066.396016239049, 10170.389511723379, 10371.170306375472, 10494.42280674555, 10599.682009539727, 9614.51927403627, 9689.32174747775, 9698.0, 9699.951500242454, 9769.85063286076, 8739.12608739121, 9092.954535227282, 9243.491607961627, 9267.536623168815, 9298.72103836886, 2511.91208307712, 2541.69499660042, 2613.8693065346656, 2625.4355313607666, 2758.4483103379403, 936.2182577547687, 943.2171297822928, 946.9621215151317, 952.9332946693803, 956.2827879090682, 18361.81638183601, 18747.875127492392, 18823.0, 18946.336878209473, 19076.904615476833, 1004.1765752083221, 1008.9949550252202, 1009.5103874620803, 1019.5615885169449, 1021.3667526133845, 10532.420716860646, 10593.311434756715, 10712.678619641423, 10717.9464102679, 10731.08785753204, 451084.0, 465769.0, 469565.0, 483657.0, 488868.0, 116729.41635291769, 116791.41604291924, 117491.41254293844, 119427.40286298512, 120451.0, 1157.3808012713157, 1160.4487868262509, 1172.4489489939715, 1182.6924999500193, 1185.9703507412385, 16839.831601683825, 16938.40715574949, 17062.573435664206, 17120.40078597243, 17152.48542543726, 55210.447895520534, 55373.446265536826, 55772.442275578345, 56591.71704141453, 56819.431805681415, 68703.31296687169, 69968.30031699617, 70197.29802702111, 70856.64571677109, 70899.0, 13922.303884805922, 14088.0, 14303.713925721218, 14325.355359009078, 14412.351444185246, 22281.44296392603, 22380.664290035988, 22662.206822761123, 22666.546669066855, 22698.205562805222, 16566.83433165653, 16689.16554172262, 16733.497995060166, 17312.134393280536, 17659.0, 15452.227388630748, 15553.533393997746, 16090.275937582603, 16535.586610334838, 16630.833691662927, 17250.309987600856, 18381.540461488035, 18390.816091839446, 18395.63208735791, 18627.534311642317, 13991.58025259244, 14000.43998240059, 14040.78938815939, 14056.929715351767, 14066.296685165906, 17721.202545885208, 17885.0, 18037.458876233733, 18043.63912721712, 18071.277148913898], "value": 11747.16915060001, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.4374875054975, 1365.2491129878565, 1382.0740104130232, 1388.645895296699, 1395.2395944210405, 14661.413543458262, 15271.541853744391, 15289.0, 15299.158546279965, 15315.0, 14973.401063957455, 15036.774448383283, 15060.472883449082, 15109.244537773095, 15115.470958516455, 2739.52058389782, 2757.0625987164412, 2808.354078561932, 2822.830630162197, 2823.68939416664, 2773.1819113361507, 2824.548072308431, 2827.349709566801, 2833.2350265428427, 2846.729560691731, 2760.0753747494614, 2772.0, 2889.754370878478, 2890.667573229074, 2892.3203047283873, 2783.6520434945633, 2796.133198708397, 2818.9147178336284, 2824.74577288044, 2827.476916770404, 2569.5503286924713, 2711.8779654915575, 2766.101017169408, 2771.071690983523, 2788.8326700398043, 15132.167730774803, 15214.543563692996, 15259.0, 15272.847271527253, 15284.847151528453, 8039.839203215903, 8372.53951032693, 8383.580820958989, 8384.371172162113, 8386.790330241733, 5455.509004189642, 5585.106382978704, 5753.395893431213, 5754.482096611325, 5763.193152958547, 1916.1473144450724, 1929.2958070304237, 1929.7201905723732, 1932.9806701932941, 1974.1609815828215, 26455.941762329483, 26690.5996410054, 26716.0, 26764.197074088002, 26768.0, 7338.156112047076, 7410.406762546078, 7652.80867978305, 7655.425843061793, 7679.116901556393, 19971.0, 20070.59858802816, 20115.29596464117, 20127.0942807574, 20153.79846201519, 8222.38332125093, 8526.531040792692, 8557.614907329185, 8558.144185581392, 8565.486070835645, 6989.790306290819, 7124.216336203013, 7133.821654458577, 7619.08570971487, 7629.580373079534, 5496.862578435571, 5779.537636989031, 5798.797042103591, 5842.795502157404, 5861.443162899518, 1769.7433872088475, 1828.7714035745532, 1847.5842935339442, 1860.7208918662309, 1862.0317434933759, 863.2532859076979, 882.0870399136862, 892.3619611977467, 898.26342399232, 902.2466240688967, 7318.131273592223, 7319.890201646979, 7332.96333518329, 7366.815829604196, 7383.467496583614, 712.9322714342129, 713.1335427455666, 724.9963750181321, 728.3153835394712, 734.3170851108521, 4909.926351104665, 4935.851924442272, 4977.8302099006705, 5223.5559977402345, 5312.62811603184, 20705.171793128407, 21424.57150856974, 21636.0, 21639.891800540896, 21667.0, 20990.265340713002, 21222.151113955268, 21639.13443462244, 21779.0, 21844.672329915065, 10971.835422468828, 11214.551417943354, 11380.203385762918, 11388.601398950997, 11418.885811141949, 8065.435419520577, 8103.189681031849, 8235.670573177005, 8324.375671824517, 8461.746147615582, 18239.0, 18747.34384296543, 18775.530611734815, 19126.33057842969, 19181.520461988563, 18622.813771862107, 19109.23563057462, 19207.32774352891, 19532.707009394588, 19735.0, 12145.332006739714, 12281.0, 12293.139480236297, 12307.815382769444, 12312.507499699912, 13672.658183545092, 13839.0, 13857.861421385656, 13927.58217253484, 13942.0, 9947.204223662235, 10102.191824653863, 10396.428196449267, 10626.362418254621, 10779.568817247222, 10969.945150274198, 10979.780404392028, 11081.113510918945, 11156.44217789091, 11240.662780116609, 9336.486493242937, 9519.619215231312, 9521.095495927875, 9532.428054316762, 9535.809283814424, 7153.606551639502, 7172.103487064117, 7238.203797582367, 7246.275372462712, 7264.091988501437, 7121.181064177686, 7281.1395352314175, 7382.298681625237, 7440.813979650552, 7446.180920098893], "value": 6748.657160358123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.63976036575747, 496.5083150482092, 521.4472658981477, 522.9111051121309, 529.0239508107543, 6106.694665266736, 6118.908216376758, 6159.8768024639485, 6169.475594574461, 6224.751009959597, 6002.519798416127, 6060.787872424466, 6090.269167699871, 6106.969465152668, 6107.267127944642, 5082.390113186423, 5095.4649761774945, 5104.183330667094, 5159.458256883011, 5178.197379406198, 4717.150912835688, 4890.21756518957, 5083.923741143867, 5129.871753206163, 5173.0, 4862.34358361622, 4897.902041959159, 4920.901581968376, 4930.605551555885, 4944.651290636936, 4828.493008234155, 4854.0, 4889.437714662824, 4892.798240791658, 4954.232094025432, 4275.957240427587, 4396.846110386153, 4401.779911004469, 4404.7357158570585, 4433.135538569948, 5979.431953964367, 5988.31134419543, 6003.699815009276, 6009.1587177795145, 6009.369016253274, 5583.469570390806, 5617.691026993513, 5618.387449835846, 5625.54995600351, 5638.915416268759, 6445.129907462479, 6465.028166409244, 6469.902951455685, 6480.0, 6483.967580162116, 4595.425571803525, 4763.666543341968, 4799.808127595145, 4814.277858321245, 4839.104765618336, 6480.384363485461, 6483.0, 6621.238557565894, 6647.302033286435, 6748.29142939994, 4911.705297682151, 4931.876703082452, 4933.753312334369, 4934.432540257844, 4952.826651067196, 4969.776360063805, 4970.676906001098, 5000.999800039934, 5033.874153146127, 5061.139606266944, 5584.46947539983, 5646.71766411686, 5652.378238393856, 5654.434556544395, 5657.377688454267, 6283.748650054038, 6352.205974253218, 6452.0, 6492.577982431127, 6533.738650454024, 1707.1890851845521, 1724.7326664367042, 1727.3177095047386, 1734.6097128146066, 1738.9130543472775, 1148.609472779259, 1199.244475980127, 1203.946546771575, 1217.3852204636603, 1222.6454328244888, 5501.257330260363, 5640.576956728261, 5648.774049037993, 5652.63257888236, 5657.868426314753, 6616.3714447128405, 6637.734490620418, 6643.734250630017, 6684.665766711645, 6686.899696504459, 5676.375598684142, 5693.715314234355, 5703.344115426696, 5706.115552089433, 5728.427157284238, 3441.913952151216, 3447.9482807757904, 3463.913402164966, 3487.2502411981545, 3505.702015328726, 6413.37644231008, 6423.004434312689, 6436.774712885027, 6449.548531602836, 6481.995290729945, 6836.658167091626, 6839.555428897106, 6851.3491218334175, 6874.484413668994, 6885.724571017204, 6410.743570257231, 6423.132877061536, 6443.903341449882, 6449.193850768747, 6466.935330646727, 6525.64108974011, 6530.67346632657, 6582.473402127914, 6595.967020164869, 6616.4045235929, 6528.314526974599, 6595.4500692336305, 6636.834079147867, 6646.767363142267, 6653.933460665331, 6353.39642733958, 6412.100867202092, 6412.35876412355, 6476.158099447231, 6481.189851268591, 4869.780859861386, 4941.308216849572, 4942.382202224722, 4948.975255123702, 4954.677945933503, 6345.682715864281, 6392.360763923571, 6512.869742605216, 6705.698243579148, 6710.892702703999, 6342.429181373698, 6349.206349206349, 6375.553711240169, 6388.87222255543, 6410.967945160244, 6284.308726040041, 6299.433051025429, 6299.685015749103, 6340.175777148941, 6347.666989931981, 6129.8851896095775, 6307.432331090224, 6310.1796766420075, 6341.302456729663, 6373.075903993988, 6288.496920246278, 6431.517636177212, 6451.322656109352, 6480.513961452815, 6502.219733631994, 6067.453929146398, 6193.318734939063, 6228.408301211378, 6290.2766181889665, 6297.52768542352], "value": 4979.570555554881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.0309356614162, 892.4333048514194, 899.5727029660908, 900.6712549919281, 926.7497775600586, 17782.644347113066, 18266.90866545667, 18287.81712182878, 18295.451136465927, 18444.170012349445, 16995.23521441535, 17391.565210869736, 17601.7359739604, 17626.64746705065, 17664.823351766478, 956.3592393096642, 967.1199208720066, 967.5307475874196, 971.0920289529313, 971.2133172130561, 939.8684184214216, 977.0522593084696, 977.384247923807, 977.5600979559191, 978.0659470205972, 1054.609794376082, 1058.7829494953517, 1064.5156453813536, 1064.8935106489328, 1065.0840277361463, 991.0634450444333, 1054.5834395413806, 1058.2169194795872, 1058.481344141369, 1060.4220699718633, 749.9062617172854, 751.2787723785173, 754.4115589839934, 754.5359603843597, 754.6679461037127, 16285.755713664304, 16372.099534525596, 16402.0, 16425.26086326118, 16452.917735411367, 21145.894270528705, 21212.575748484946, 21796.0, 21825.345239642837, 22028.88985555062, 15971.121588312639, 16135.919320403324, 16297.83702162987, 16313.755293670485, 16437.58906027347, 3716.572594151653, 3766.623337666239, 3779.8866034019024, 3782.659560639528, 3784.375578029622, 131275.0, 135667.32166339204, 139915.30042349824, 140208.0, 140284.29857850645, 15693.529194124194, 15731.4493992712, 15826.60433489172, 15886.126263055412, 15889.761653575206, 27832.304192394946, 28043.71956280452, 28713.85643071771, 28731.425371492453, 28744.568831467546, 7938.404619653434, 7976.481528700616, 8005.159458256916, 8093.19068093186, 8101.6354264058255, 3984.86052988144, 4030.7380020298588, 4057.878263652095, 4061.3704875744306, 4062.4921884764403, 4918.409790825052, 4946.975265123651, 4997.875053123628, 5030.446650868402, 5067.290579318898, 1028.8559601655775, 1032.9586816527406, 1050.9421981791074, 1053.8524606555088, 1061.0609610494769, 663.731188868509, 674.3728332650682, 684.6337209592843, 692.8926016467456, 693.784926672723, 11488.977466039427, 11722.765544689059, 11748.0, 11925.701857453632, 11966.940165299291, 648.3613640564041, 650.3593959949446, 652.54974067893, 663.6449499517735, 668.1514476614672, 5102.821401250939, 5160.587153027749, 5163.0190263849745, 5179.430262671103, 5226.660267082628, 118566.0, 122894.0, 123487.3825630866, 124066.0, 124142.0, 103284.0, 104463.0, 106090.0, 106548.0, 106698.46650766852, 90626.0, 93403.73086941925, 94529.0, 95411.0, 97490.51254743681, 9620.508821132735, 9780.217582593234, 9896.554655040685, 9918.256130790363, 9919.20646348276, 43099.56900430955, 43476.565234347254, 44725.0, 46239.306410403195, 47348.0, 57208.71395642995, 57294.0, 57431.42568574261, 58395.70802145962, 59204.70397647984, 15060.246987650793, 15388.0, 15494.985651865185, 15633.374665013727, 15672.451464199154, 16487.505374838773, 16606.584835379213, 16613.41853035138, 16696.081715505763, 16731.581710457336, 15189.924050379677, 15297.923510382821, 15313.923430382776, 15428.84571154319, 15442.30509627047, 14623.19572423527, 14638.41446342177, 14776.187309698069, 14780.260986950394, 14787.11277323364, 15143.242837858283, 15260.542183734506, 15298.694026119638, 15391.3073911672, 15398.384064637288, 10484.895151048391, 10706.73233169177, 10766.515506802056, 10879.673609791718, 10956.671299861016, 11540.24988375753, 11572.942135289606, 11660.941695291809, 11804.527818887149, 11873.82189267179], "value": 8623.174916634782, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 106.0, 107.0, 108.0, 108.0, 107.0, 108.0, 108.0, 108.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 119.0, 117.0, 118.0, 115.0, 118.0, 118.0, 118.0, 114.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 164.0, 162.0, 163.0, 165.0, 169.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 74.0, 74.0, 73.0, 100.0, 78.0, 75.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 110.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 151.0, 150.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 93.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 55.0, 53.0, 55.0, 53.0, 53.0, 54.0, 54.0, 59.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 39.0, 42.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 75.0, 76.0, 75.0, 79.0, 74.0, 74.0, 77.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 121.0, 113.0, 116.0, 117.0, 114.0, 110.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 170.0, 169.0, 167.0, 172.0, 175.0, 171.0, 172.0, 168.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 69.0, 66.0, 69.0, 65.0, 63.0, 65.0, 67.0, 68.0], "value": 65.8, "unit": "score"}]}]} 03:43:05 INFO - Return code: 0 03:43:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:05 INFO - # TBPL SUCCESS # 03:43:05 INFO - Running post-action listener: _package_coverage_data 03:43:05 INFO - Running post-action listener: _resource_record_post_action 03:43:05 INFO - [mozharness: 2017-09-16 10:43:05.924822Z] Finished run-tests step (success) 03:43:05 INFO - Running post-run listener: _resource_record_post_run 03:43:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 334233600; Read time: 356; Write time: 440460 03:43:05 INFO - TinderboxPrint: CPU usage
13.1% 03:43:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 356 03:43:05 INFO - TinderboxPrint: I/O write bytes / time
334,233,600 / 440,460 03:43:05 INFO - TinderboxPrint: CPU idle
8,234.3 (86.9%) 03:43:05 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 03:43:05 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13312000; Read time: 0; Write time: 2656 03:43:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320430080; Read time: 356; Write time: 437804 03:43:06 INFO - Running post-run listener: _upload_blobber_files 03:43:06 INFO - Blob upload gear active. 03:43:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:06 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:43:06 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:43:06 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:43:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:43:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:08 INFO - (blobuploader) - INFO - Done attempting. 03:43:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:14 INFO - (blobuploader) - INFO - Done attempting. 03:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:43:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:15 INFO - (blobuploader) - INFO - Done attempting. 03:43:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:43:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:16 INFO - (blobuploader) - INFO - Done attempting. 03:43:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:16 INFO - Return code: 0 03:43:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fe851e42a39c06844a39211f2a9b8fb150b6900ea14cdaf6bb9951b0d44892791395700b586129082727c1880852bcce4733576d5d2a4e8398b5b58b83058b8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a24f43e8f7170ad3a3c4b802fd21cccaf8e55abfaa7b482cc5eb541763ea93e8e4d9a78f21f896c596af3b62222d8f40ea071cca241b395b54aafc178c599f40", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d529e31d9fdd15282ca1b226fab880b902b9aedd90cde663f9c5085389eb4169706dd467723610e794fa805980481d1521cfd06f383675c5e5a93eb46f68b5a7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9df1ab6b53029b02786e34cf66d79972ee5aa05f1d640a5a5f3c77b63a8e7440abd6e28d51807cb1fbc9e29594e058d4ffca61a98c55bf2fd0fc49c2034dc40"} 03:43:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:16 INFO - Contents: 03:43:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fe851e42a39c06844a39211f2a9b8fb150b6900ea14cdaf6bb9951b0d44892791395700b586129082727c1880852bcce4733576d5d2a4e8398b5b58b83058b8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a24f43e8f7170ad3a3c4b802fd21cccaf8e55abfaa7b482cc5eb541763ea93e8e4d9a78f21f896c596af3b62222d8f40ea071cca241b395b54aafc178c599f40", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d529e31d9fdd15282ca1b226fab880b902b9aedd90cde663f9c5085389eb4169706dd467723610e794fa805980481d1521cfd06f383675c5e5a93eb46f68b5a7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9df1ab6b53029b02786e34cf66d79972ee5aa05f1d640a5a5f3c77b63a8e7440abd6e28d51807cb1fbc9e29594e058d4ffca61a98c55bf2fd0fc49c2034dc40"} 03:43:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:16 INFO - Copying logs to upload dir... 03:43:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.189874 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 03:43:17.016155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:17.025398) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fe851e42a39c06844a39211f2a9b8fb150b6900ea14cdaf6bb9951b0d44892791395700b586129082727c1880852bcce4733576d5d2a4e8398b5b58b83058b8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a24f43e8f7170ad3a3c4b802fd21cccaf8e55abfaa7b482cc5eb541763ea93e8e4d9a78f21f896c596af3b62222d8f40ea071cca241b395b54aafc178c599f40", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d529e31d9fdd15282ca1b226fab880b902b9aedd90cde663f9c5085389eb4169706dd467723610e794fa805980481d1521cfd06f383675c5e5a93eb46f68b5a7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9df1ab6b53029b02786e34cf66d79972ee5aa05f1d640a5a5f3c77b63a8e7440abd6e28d51807cb1fbc9e29594e058d4ffca61a98c55bf2fd0fc49c2034dc40"} build_url:https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/HjCsUs2wRpaX7mNuomNYtQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fe851e42a39c06844a39211f2a9b8fb150b6900ea14cdaf6bb9951b0d44892791395700b586129082727c1880852bcce4733576d5d2a4e8398b5b58b83058b8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a24f43e8f7170ad3a3c4b802fd21cccaf8e55abfaa7b482cc5eb541763ea93e8e4d9a78f21f896c596af3b62222d8f40ea071cca241b395b54aafc178c599f40", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d529e31d9fdd15282ca1b226fab880b902b9aedd90cde663f9c5085389eb4169706dd467723610e794fa805980481d1521cfd06f383675c5e5a93eb46f68b5a7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9df1ab6b53029b02786e34cf66d79972ee5aa05f1d640a5a5f3c77b63a8e7440abd6e28d51807cb1fbc9e29594e058d4ffca61a98c55bf2fd0fc49c2034dc40"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:17.062486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:17.062977) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505557136.342300-434831858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:43:17.117575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:17.117972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:43:17.118358) ========= ========= Total master_lag: 0.43 =========